| Name | EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm_0 |
| Workunit | 239937381 |
| Created | 15 Mar 2026, 14:49:41 UTC |
| Sent | 15 Mar 2026, 14:49:43 UTC |
| Report deadline | 23 Mar 2026, 14:49:43 UTC |
| Received | 20 Mar 2026, 13:48:34 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10878259 |
| Run time | 3 days 19 hours 33 min 44 sec |
| CPU time | 11 days 10 hours 1 min 13 sec |
| Priority | 28 |
| Validate state | Valid |
| Credit | 8,940.39 |
| Device peak FLOPS | 22.90 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 1.68 GB |
| Peak swap size | 2.25 GB |
| Peak disk usage | 2.63 GB |
<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
10:50:12 (2312668): wrapper (7.7.26015): starting
10:50:12 (2312668): wrapper: running run_atlas (--nthreads 10)
[2026-03-15 10:50:12] Arguments: --nthreads 10
[2026-03-15 10:50:12] Threads: 10
[2026-03-15 10:50:12] Checking for CVMFS
[2026-03-15 10:50:13] Probing /cvmfs/atlas.cern.ch... OK
[2026-03-15 10:50:13] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-03-15 10:50:13] Running cvmfs_config stat atlas.cern.ch
[2026-03-15 10:50:13] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2026-03-15 10:50:13] 2.13.3.0 7202 115016 148288 157317 0 50 38408564 40960000 7663 16776704 0 75856231 99.626 74236019 30348 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2026-03-15 10:50:13] CVMFS is ok
[2026-03-15 10:50:13] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-03-15 10:50:13] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-03-15 10:50:13] Further information can be found at the LHC@home message board.
[2026-03-15 10:50:13] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-03-15 10:50:13] Checking for apptainer binary...
[2026-03-15 10:50:13] Using apptainer found in PATH at /usr/bin/apptainer
[2026-03-15 10:50:13] Running /usr/bin/apptainer --version
[2026-03-15 10:50:13] apptainer version 1.4.5-2.el9
[2026-03-15 10:50:13] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-03-15 10:50:13] c-211-10.aglt2.org
[2026-03-15 10:50:13] apptainer works
[2026-03-15 10:50:13] Set ATHENA_PROC_NUMBER=10
[2026-03-15 10:50:13] Set ATHENA_CORE_NUMBER=10
[2026-03-15 10:50:13] Starting ATLAS job with PandaID=7055964468
[2026-03-15 10:50:13] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
19:47:56 (2843307): wrapper (7.7.26015): starting
19:47:56 (2843307): wrapper: running run_atlas (--nthreads 8)
[2026-03-15 19:47:56] Arguments: --nthreads 8
[2026-03-15 19:47:56] Threads: 8
[2026-03-15 19:47:56] This job has been restarted, cleaning up previous attempt
[2026-03-15 19:47:56] Checking for CVMFS
[2026-03-15 19:47:56] Probing /cvmfs/atlas.cern.ch... OK
[2026-03-15 19:47:56] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-03-15 19:47:56] Running cvmfs_config stat atlas.cern.ch
[2026-03-15 19:47:57] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2026-03-15 19:47:57] 2.13.3.0 7202 115554 149648 157333 3 1 40183113 40960001 0 16776704 0 76166086 99.625 74506321 30333 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2026-03-15 19:47:57] CVMFS is ok
[2026-03-15 19:47:57] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-03-15 19:47:57] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-03-15 19:47:57] Further information can be found at the LHC@home message board.
[2026-03-15 19:47:57] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-03-15 19:47:57] Checking for apptainer binary...
[2026-03-15 19:47:57] Using apptainer found in PATH at /usr/bin/apptainer
[2026-03-15 19:47:57] Running /usr/bin/apptainer --version
[2026-03-15 19:47:57] apptainer version 1.4.5-2.el9
[2026-03-15 19:47:57] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-03-15 19:47:58] c-211-10.aglt2.org
[2026-03-15 19:47:58] apptainer works
[2026-03-15 19:47:58] Set ATHENA_PROC_NUMBER=8
[2026-03-15 19:47:58] Set ATHENA_CORE_NUMBER=8
[2026-03-15 19:47:58] Starting ATLAS job with PandaID=7055964468
[2026-03-15 19:47:58] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-03-15 19:51:04] Job failed
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/0/
[2026-03-15 19:51:04] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/0/
[2026-03-15 19:51:04] + mv ATLAS.root_0 EVNT.49144833._000001.pool.root.1
[2026-03-15 19:51:04] mv: ‘ATLAS.root_0’ and ‘EVNT.49144833._000001.pool.root.1’ are the same file
[2026-03-15 19:51:04] + tar --strip-components=5 -xvf input.tar.gz
[2026-03-15 19:51:04] + umask 077
[2026-03-15 19:51:04] ++ date +%s
[2026-03-15 19:51:04] + ACCOUNTING_STARTTIME=1773618478
[2026-03-15 19:51:04] + echo 'Detecting resource accounting method available for the job.'
[2026-03-15 19:51:04] Detecting resource accounting method available for the job.
[2026-03-15 19:51:04] + JOB_ACCOUNTING=
[2026-03-15 19:51:04] + command -v arc-job-cgroup
[2026-03-15 19:51:04] + '[' -z '' ']'
[2026-03-15 19:51:04] + GNU_TIME=/usr/bin/time
[2026-03-15 19:51:04] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2026-03-15 19:51:04] Looking for /usr/bin/time tool for accounting measurements
[2026-03-15 19:51:04] + '[' '!' -z /usr/bin/time ']'
[2026-03-15 19:51:04] + /usr/bin/time --version
[2026-03-15 19:51:04] + echo 'GNU time found and will be used for job accounting.'
[2026-03-15 19:51:04] GNU time found and will be used for job accounting.
[2026-03-15 19:51:04] + JOB_ACCOUNTING=gnutime
[2026-03-15 19:51:04] + '[' -z gnutime ']'
[2026-03-15 19:51:04] + export PANDA_JSID=harvester-CERN_central_ACTA
[2026-03-15 19:51:04] + PANDA_JSID=harvester-CERN_central_ACTA
[2026-03-15 19:51:04] + export GTAG=http://aipanda404.cern.ch/data/jobs/2026-03-15/BOINC_MCORE/7055964468.out
[2026-03-15 19:51:04] + GTAG=http://aipanda404.cern.ch/data/jobs/2026-03-15/BOINC_MCORE/7055964468.out
[2026-03-15 19:51:04] + export PILOT_NOKILL=YES
[2026-03-15 19:51:04] + PILOT_NOKILL=YES
[2026-03-15 19:51:04] + export GRID_GLOBAL_JOBID=EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBID=EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm
[2026-03-15 19:51:04] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm
[2026-03-15 19:51:04] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2026-03-15 19:51:04] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/0
[2026-03-15 19:51:04] + RUNTIME_JOB_STDIN=/dev/null
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/0/log.49144843._000002.job.log.1
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/0/log.49144843._000002.job.log.1
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/0.diag
[2026-03-15 19:51:04] + '[' '!' -z '' ']'
[2026-03-15 19:51:04] + RUNTIME_LOCAL_SCRATCH_DIR=
[2026-03-15 19:51:04] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2026-03-15 19:51:04] + RUNTIME_FRONTEND_SEES_NODE=
[2026-03-15 19:51:04] + RUNTIME_NODE_SEES_FRONTEND=yes
[2026-03-15 19:51:04] + '[' '!' -z '' ']'
[2026-03-15 19:51:04] + '[' -z yes ']'
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/0/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag
[2026-03-15 19:51:04] + runtimeenvironments=
[2026-03-15 19:51:04] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2026-03-15 19:51:04] + RTE_function_0 1
[2026-03-15 19:51:04] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-03-15 19:51:04] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-03-15 19:51:04] + export BOINC_APP=ATLAS
[2026-03-15 19:51:04] + BOINC_APP=ATLAS
[2026-03-15 19:51:04] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-03-15 19:51:04] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-03-15 19:51:04] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-03-15 19:51:04] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-03-15 19:51:04] + '[' -z 1 ']'
[2026-03-15 19:51:04] + '[' 1 == 1 ']'
[2026-03-15 19:51:04] + shift
[2026-03-15 19:51:04] + export SITE_NAME=BOINC
[2026-03-15 19:51:04] + SITE_NAME=BOINC
[2026-03-15 19:51:04] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/0/
[2026-03-15 19:51:04] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/0/
[2026-03-15 19:51:04] + '[' -e /tmp/boinchome/slots/0/init_data.xml ']'
[2026-03-15 19:51:04] + grep '<use_http_proxy/>' /tmp/boinchome/slots/0/init_data.xml
[2026-03-15 19:51:04] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_name>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/0/init_data.xml
[2026-03-15 19:51:04] + PROXY_HOST=sl-um-es2.slateci.io
[2026-03-15 19:51:04] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_port>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/0/init_data.xml
[2026-03-15 19:51:04] + PROXY_PORT=6081
[2026-03-15 19:51:04] + '[' -n sl-um-es2.slateci.io ']'
[2026-03-15 19:51:04] + '[' -n 6081 ']'
[2026-03-15 19:51:04] + export FRONTIER_PROXY=http://sl-um-es2.slateci.io:6081
[2026-03-15 19:51:04] + FRONTIER_PROXY=http://sl-um-es2.slateci.io:6081
[2026-03-15 19:51:04] + echo 'export FRONTIER_PROXY="http://sl-um-es2.slateci.io:6081"'
[2026-03-15 19:51:04] + '[' 0 -ne 0 ']'
[2026-03-15 19:51:04] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2026-03-15 19:51:04] + '[' -f /etc/os-release ']'
[2026-03-15 19:51:04] +++ cat /etc/os-release
[2026-03-15 19:51:04] ++ eval 'NAME="CentOS' 'Linux"' 'VERSION="7' '(Core)"' 'ID="centos"' 'ID_LIKE="rhel' 'fedora"' 'VERSION_ID="7"' 'PRETTY_NAME="CentOS' Linux 7 '(Core)"' 'ANSI_COLOR="0;31"' 'CPE_NAME="cpe:/o:centos:centos:7"' 'HOME_URL="https://www.centos.org/"' 'BUG_REPORT_URL="https://bugs.centos.org/"' 'CENTOS_MANTISBT_PROJECT="CentOS-7"' 'CENTOS_MANTISBT_PROJECT_VERSION="7"' 'REDHAT_SUPPORT_PRODUCT="centos"' 'REDHAT_SUPPORT_PRODUCT_VERSION="7"'
[2026-03-15 19:51:04] +++ NAME='CentOS Linux'
[2026-03-15 19:51:04] +++ VERSION='7 (Core)'
[2026-03-15 19:51:04] +++ ID=centos
[2026-03-15 19:51:04] +++ ID_LIKE='rhel fedora'
[2026-03-15 19:51:04] +++ VERSION_ID=7
[2026-03-15 19:51:04] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2026-03-15 19:51:04] +++ ANSI_COLOR='0;31'
[2026-03-15 19:51:04] +++ CPE_NAME=cpe:/o:centos:centos:7
[2026-03-15 19:51:04] +++ HOME_URL=https://www.centos.org/
[2026-03-15 19:51:04] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2026-03-15 19:51:04] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2026-03-15 19:51:04] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2026-03-15 19:51:04] +++ REDHAT_SUPPORT_PRODUCT=centos
[2026-03-15 19:51:04] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2026-03-15 19:51:04] ++ echo 'CentOS Linux 7 (Core)'
[2026-03-15 19:51:04] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2026-03-15 19:51:04] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2026-03-15 19:51:04] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2026-03-15 19:51:04] + HOME=/tmp/boinchome/slots/0
[2026-03-15 19:51:04] + export HOME
[2026-03-15 19:51:04] + cd /tmp/boinchome/slots/0
[2026-03-15 19:51:04] + '[' '!' -z '' ']'
[2026-03-15 19:51:04] + '[' -z '' ']'
[2026-03-15 19:51:04] ++ /bin/hostname -f
[2026-03-15 19:51:04] + nodename=c-211-10.aglt2.org
[2026-03-15 19:51:04] + echo nodename=c-211-10.aglt2.org
[2026-03-15 19:51:04] + echo Processors=2
[2026-03-15 19:51:04] + echo Nodecount=1
[2026-03-15 19:51:04] + echo Benchmark=HEPSPEC:1.0
[2026-03-15 19:51:04] + executable=./runpilot2-wrapper.sh
[2026-03-15 19:51:04] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2026-03-15 19:51:04] ++ dd if=./runpilot2-wrapper.sh count=1
[2026-03-15 19:51:04] ++ head -n 1
[2026-03-15 19:51:04] ++ tr -d '\0'
[2026-03-15 19:51:04] + line1='#!/bin/bash'
[2026-03-15 19:51:04] ++ echo '#!/bin/bash'
[2026-03-15 19:51:04] ++ sed -n 's/^#! *//p'
[2026-03-15 19:51:04] + shebang=/bin/bash
[2026-03-15 19:51:04] ++ echo /bin/bash
[2026-03-15 19:51:04] ++ awk '{print $1}'
[2026-03-15 19:51:04] + interpreter=/bin/bash
[2026-03-15 19:51:04] + '[' /bin/bash = /usr/bin/env ']'
[2026-03-15 19:51:04] + '[' x/bin/bash = x ']'
[2026-03-15 19:51:04] + type /bin/bash
[2026-03-15 19:51:04] + '[' xgnutime = xgnutime ']'
[2026-03-15 19:51:04] + /usr/bin/time -o /tmp/boinchome/slots/0/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag -a -f 'WallTime=%es\nKernelTime=%Ss\nUserTime=%Us\nCPUUsage=%P\nMaxResidentMemory=%MkB\nAverageResidentMemory=%tkB\nAverageTotalMemory=%KkB\nAverageUnsharedMemory=%DkB\nAverageUnsharedStack=%pkB\nAverageSharedMemory=%XkB\nPageSize=%ZB\nMajorPageFaults=%F\nMinorPageFaults=%R\nSwaps=%W\nForcedSwitches=%c\nWaitSwitches=%w\nInputs=%I\nOutputs=%O\nSocketReceived=%r\nSocketSent=%s\nSignals=%k\n' ./runpilot2-wrapper.sh -q BOINC_MCORE -j managed --pilot-user ATLAS --harvester-submit-mode PUSH -w generic --job-type managed --resource-type MCORE --pilotversion 3.11.5.1 -z -t --piloturl local --mute --container
[2026-03-15 19:51:04] + RESULT=2
[2026-03-15 19:51:04] + sed -i -e /nodename=/d /tmp/boinchome/slots/0/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag
[2026-03-15 19:51:04] ++ grep domain_name init_data.xml
[2026-03-15 19:51:04] ++ awk -F '>' '{print $2}'
[2026-03-15 19:51:04] ++ awk -F '<' '{print $1}'
[2026-03-15 19:51:04] ++ sed -e 's# #_#g'
[2026-03-15 19:51:04] + hostname=c-211-10.aglt2.org
[2026-03-15 19:51:04] ++ grep user_name init_data.xml
[2026-03-15 19:51:04] ++ awk -F '>' '{print $2}'
[2026-03-15 19:51:04] ++ awk -F '<' '{print $1}'
[2026-03-15 19:51:04] ++ sed -e 's# #_#g'
[2026-03-15 19:51:04] + username=AGLT2
[2026-03-15 19:51:04] + nodename=AGLT2@c-211-10.aglt2.org
[2026-03-15 19:51:04] + echo nodename=AGLT2@c-211-10.aglt2.org
[2026-03-15 19:51:04] + '[' -n 8 ']'
[2026-03-15 19:51:04] + sed -i -e s/Processors=1/Processors=8/ /tmp/boinchome/slots/0/EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag
[2026-03-15 19:51:04] + echo exitcode=2
[2026-03-15 19:51:04] + runtimeenvironments=
[2026-03-15 19:51:04] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2026-03-15 19:51:04] + RTE_function_0 2
[2026-03-15 19:51:04] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-03-15 19:51:04] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-03-15 19:51:04] + export BOINC_APP=ATLAS
[2026-03-15 19:51:04] + BOINC_APP=ATLAS
[2026-03-15 19:51:04] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-03-15 19:51:04] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-03-15 19:51:04] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-03-15 19:51:04] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-03-15 19:51:04] + '[' -z 2 ']'
[2026-03-15 19:51:04] + '[' 2 == 1 ']'
[2026-03-15 19:51:04] + '[' 0 -ne 0 ']'
[2026-03-15 19:51:04] + echo 'zip all output files'
[2026-03-15 19:51:04] + flist='*.diag '
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./heartbeat.json ']'
[2026-03-15 19:51:04] + flist='*.diag ./heartbeat.json'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./output.list ']'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./log.49144843._000002.job.log.1 ']'
[2026-03-15 19:51:04] + flist='*.diag ./heartbeat.json ./log.49144843._000002.job.log.1'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./log.49144843._000002.job.log.1 ']'
[2026-03-15 19:51:04] + flist='*.diag ./heartbeat.json ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./gmlog/ ']'
[2026-03-15 19:51:04] + '[' -f output.list ']'
[2026-03-15 19:51:04] + tar cvf result.tar.gz EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag ./heartbeat.json ./log.49144843._000002.job.log.1 ./log.49144843._000002.job.log.1
[2026-03-15 19:51:04] + '[' xgnutime = xcgroup ']'
[2026-03-15 19:51:04] + '[' -n '' ']'
[2026-03-15 19:51:04] + '[' -n '' ']'
[2026-03-15 19:51:04] ++ date +%s
[2026-03-15 19:51:04] + ACCOUNTING_ENDTIME=1773618664
[2026-03-15 19:51:04] ++ date -d '1970-01-01 UTC 1773618478 seconds' +%Y%m%d%H%M%SZ
[2026-03-15 19:51:04] + echo LRMSStartTime=20260315194758Z
[2026-03-15 19:51:04] ++ date -d '1970-01-01 UTC 1773618664 seconds' +%Y%m%d%H%M%SZ
[2026-03-15 19:51:04] + echo LRMSEndTime=20260315195104Z
[2026-03-15 19:51:04] + echo walltime=186
[2026-03-15 19:51:04] + echo exitcode=2
[2026-03-15 19:51:04] + exit 2
[2026-03-15 19:51:04] ./runtime_log.err
[2026-03-15 19:51:04] ./runtime_log
[2026-03-15 19:51:04] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2026-03-15 19:51:04] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2026-03-15 19:51:04] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2026-03-15 19:51:04] ./pilot3/pilot/util/realtimelogger.py
[2026-03-15 19:51:04] ./pilot3/pilot/util/lokirealtimelogger.py
[2026-03-15 19:51:04] ./pilot3/pilot/util/loggingsupport.py
[2026-03-15 19:51:04] ./pilotlog.txt
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/prmon.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/log.EVNTtoHITS
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/pilotlog.txt
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_1/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_1/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_1/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_7/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_7/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_7/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/evt_counter/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/evt_counter/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/evt_counter/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_4/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_4/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_4/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_6/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_6/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_6/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_2/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_2/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_2/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_0/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_0/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_0/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_5/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_5/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_5/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_3/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_3/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/athenaMP-workers-EVNTtoHITS-sim/worker_3/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964468/PoolFileCatalog.xml.AthenaMP-saved
[2026-03-15 19:51:04] ./log.49144843._000002.job.log.1
20:04:43 (2914241): wrapper (7.7.26015): starting
20:04:43 (2914241): wrapper: running run_atlas (--nthreads 8)
[2026-03-15 20:04:43] Arguments: --nthreads 8
[2026-03-15 20:04:43] Threads: 8
[2026-03-15 20:04:43] This job has been restarted, cleaning up previous attempt
[2026-03-15 20:04:43] Checking for CVMFS
[2026-03-15 20:04:43] Probing /cvmfs/atlas.cern.ch... OK
[2026-03-15 20:04:43] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-03-15 20:04:43] Running cvmfs_config stat atlas.cern.ch
[2026-03-15 20:04:43] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2026-03-15 20:04:43] 2.13.3.0 7202 115570 152372 157333 2 265 40216049 40960000 0 16776704 0 76324868 99.626 74506330 30333 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2026-03-15 20:04:43] CVMFS is ok
[2026-03-15 20:04:43] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-03-15 20:04:43] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-03-15 20:04:43] Further information can be found at the LHC@home message board.
[2026-03-15 20:04:43] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-03-15 20:04:43] Checking for apptainer binary...
[2026-03-15 20:04:43] Using apptainer found in PATH at /usr/bin/apptainer
[2026-03-15 20:04:43] Running /usr/bin/apptainer --version
[2026-03-15 20:04:43] apptainer version 1.4.5-2.el9
[2026-03-15 20:04:43] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-03-15 20:04:43] c-211-10.aglt2.org
[2026-03-15 20:04:43] apptainer works
[2026-03-15 20:04:43] Set ATHENA_PROC_NUMBER=8
[2026-03-15 20:04:43] Set ATHENA_CORE_NUMBER=8
[2026-03-15 20:04:43] Starting ATLAS job with PandaID=7055964468
[2026-03-15 20:04:43] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-03-19 20:05:48] *** The last 200 lines of the pilot log: ***
[2026-03-19 20:05:48] 2026-03-20 00:03:31,122 | INFO | CPU consumption time changed by a factor of 1.0001092299290006 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:03:31,122 | INFO | (instant) CPU consumption time for pid=2939458: 9156)
[2026-03-19 20:05:48] 2026-03-20 00:03:31,123 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:03:31,537 | INFO | time since job start (345522s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:31,811 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,244 | WARNING | memory limits not set in config, using defaults: 'NoneType' object has no attribute 'get'
[2026-03-19 20:05:48] 2026-03-20 00:03:32,245 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 3275884 kB <= 32768000 kB (subresource=MCORE)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,261 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 651284 B
[2026-03-19 20:05:48] 2026-03-20 00:03:32,261 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6664 B
[2026-03-19 20:05:48] 2026-03-20 00:03:32,285 | INFO | executing command: df -mP /tmp/boinchome/slots/0
[2026-03-19 20:05:48] 2026-03-20 00:03:32,334 | INFO | sufficient remaining disk space (55767465984 B)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,335 | INFO | work directory size check will use 5033164800 B as a max limit (20% grace limit added, divider=1)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,339 | INFO | size of work directory /tmp/boinchome/slots/0/PanDA_Pilot-7055964468: 1719645306 B (within 5033164800 B limit)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,340 | INFO | pfn file=/tmp/boinchome/slots/0/PanDA_Pilot-7055964468/HITS.49144843._000002.pool.root.1 does not exist (skip from workdir size calculation)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,340 | INFO | total size of present files: 0 B (workdir size: 1719645306 B)
[2026-03-19 20:05:48] 2026-03-20 00:03:32,340 | INFO | output file size check: skipping output file /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/HITS.49144843._000002.pool.root.1 since it does not exist
[2026-03-19 20:05:48] 2026-03-20 00:03:32,753 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:03:32,753 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:03:33,545 | INFO | time since job start (345524s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:35,258 | INFO | monitor loop #18629: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:03:35,551 | INFO | time since job start (345526s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:37,557 | INFO | time since job start (345528s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:39,578 | INFO | time since job start (345530s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:41,585 | INFO | time since job start (345532s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:43,592 | INFO | time since job start (345534s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:45,600 | INFO | time since job start (345536s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:46,222 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:03:46,222 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:03:46,223 | INFO | (instant) CPU consumption time for pid=2939458: 9156)
[2026-03-19 20:05:48] 2026-03-20 00:03:46,223 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:03:47,145 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:03:47,145 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:03:47,650 | INFO | time since job start (345538s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:49,650 | INFO | monitor loop #18630: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:03:49,657 | INFO | time since job start (345540s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:52,467 | INFO | PID=2929398 has CPU usage=10.6% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i
[2026-03-19 20:05:48] 2026-03-20 00:03:52,467 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:48] 2026-03-20 00:03:53,470 | INFO | time since job start (345544s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:55,477 | INFO | time since job start (345546s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:55,478 | INFO | 345546s have passed since pilot start - server update state is 'RUNNING'
[2026-03-19 20:05:48] 2026-03-20 00:03:57,486 | INFO | time since job start (345548s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:03:59,493 | INFO | time since job start (345550s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:00,855 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:04:00,855 | INFO | CPU consumption time changed by a factor of 1.0001092179991262 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:04:00,855 | INFO | (instant) CPU consumption time for pid=2939458: 9157)
[2026-03-19 20:05:48] 2026-03-20 00:04:00,856 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:04:01,503 | INFO | time since job start (345552s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:01,633 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:04:01,633 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:04:03,511 | INFO | time since job start (345554s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:04,137 | INFO | monitor loop #18631: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:04:05,518 | INFO | time since job start (345556s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:07,525 | INFO | time since job start (345558s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:09,532 | INFO | time since job start (345560s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:11,568 | INFO | time since job start (345562s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:13,575 | INFO | time since job start (345564s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:15,915 | INFO | PID=2929398 has CPU usage=7.3% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i P
[2026-03-19 20:05:48] 2026-03-20 00:04:15,915 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:48] 2026-03-20 00:04:16,115 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:04:16,115 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:04:16,115 | INFO | (instant) CPU consumption time for pid=2939458: 9157)
[2026-03-19 20:05:48] 2026-03-20 00:04:16,116 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:04:16,678 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:04:16,720 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:04:16,916 | INFO | time since job start (345567s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:18,923 | INFO | time since job start (345569s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:19,225 | INFO | monitor loop #18632: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:04:20,930 | INFO | time since job start (345571s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:22,937 | INFO | time since job start (345573s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:24,945 | INFO | time since job start (345575s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:26,952 | INFO | time since job start (345577s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:28,959 | INFO | time since job start (345579s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:30,145 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:04:30,145 | INFO | CPU consumption time changed by a factor of 1.0001092060718575 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:04:30,145 | INFO | (instant) CPU consumption time for pid=2939458: 9158)
[2026-03-19 20:05:48] 2026-03-20 00:04:30,146 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:04:30,708 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:04:30,709 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:04:30,966 | INFO | time since job start (345581s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:32,973 | INFO | time since job start (345583s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:33,215 | INFO | monitor loop #18633: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:04:34,979 | INFO | time since job start (345585s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:36,989 | INFO | time since job start (345587s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:38,860 | INFO | PID=2929398 has CPU usage=8.4% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i P
[2026-03-19 20:05:48] 2026-03-20 00:04:38,860 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:48] 2026-03-20 00:04:39,884 | INFO | time since job start (345590s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:41,891 | INFO | time since job start (345592s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:43,937 | INFO | time since job start (345594s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:44,818 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:04:44,818 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:04:44,818 | INFO | (instant) CPU consumption time for pid=2939458: 9158)
[2026-03-19 20:05:48] 2026-03-20 00:04:44,819 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:04:45,565 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:04:45,860 | WARNING | memory limits not set in config, using defaults: 'NoneType' object has no attribute 'get'
[2026-03-19 20:05:48] 2026-03-20 00:04:45,899 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 3275884 kB <= 32768000 kB (subresource=MCORE)
[2026-03-19 20:05:48] 2026-03-20 00:04:45,899 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 651284 B
[2026-03-19 20:05:48] 2026-03-20 00:04:45,900 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6664 B
[2026-03-19 20:05:48] 2026-03-20 00:04:45,900 | INFO | executing command: df -mP /tmp/boinchome/slots/0
[2026-03-19 20:05:48] 2026-03-20 00:04:45,960 | INFO | time since job start (345596s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,001 | INFO | sufficient remaining disk space (55766417408 B)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,001 | INFO | work directory size check will use 5033164800 B as a max limit (20% grace limit added, divider=1)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,005 | INFO | size of work directory /tmp/boinchome/slots/0/PanDA_Pilot-7055964468: 1719645643 B (within 5033164800 B limit)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,006 | INFO | pfn file=/tmp/boinchome/slots/0/PanDA_Pilot-7055964468/HITS.49144843._000002.pool.root.1 does not exist (skip from workdir size calculation)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,006 | INFO | total size of present files: 0 B (workdir size: 1719645643 B)
[2026-03-19 20:05:48] 2026-03-20 00:04:46,006 | INFO | output file size check: skipping output file /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/HITS.49144843._000002.pool.root.1 since it does not exist
[2026-03-19 20:05:48] 2026-03-20 00:04:46,478 | INFO | number of running child processes to parent process 2939458: 13
[2026-03-19 20:05:48] 2026-03-20 00:04:46,478 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:04:47,970 | INFO | time since job start (345598s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:48,985 | INFO | monitor loop #18634: job 0:7055964468 is in state 'running'
[2026-03-19 20:05:48] 2026-03-20 00:04:49,977 | INFO | time since job start (345600s) is within the limit (345600.0s)
[2026-03-19 20:05:48] 2026-03-20 00:04:51,984 | CRITICAL | time since job start (345602s) has exceeded the limit (345600.0s) - time to abort pilot
[2026-03-19 20:05:48] 2026-03-20 00:04:51,985 | CRITICAL | limit = max running time (345600s) * pilot walltime grace (1.0)
[2026-03-19 20:05:48] 2026-03-20 00:04:52,013 | INFO | setting REACHED_MAXTIME and graceful stop
[2026-03-19 20:05:48] 2026-03-20 00:04:52,014 | INFO | current server update state: RUNNING
[2026-03-19 20:05:48] 2026-03-20 00:04:52,014 | INFO | update_server=False
[2026-03-19 20:05:48] 2026-03-20 00:04:52,014 | INFO | [monitor] control thread has ended
[2026-03-19 20:05:48] 2026-03-20 00:04:52,041 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2026-03-19 20:05:48] 2026-03-20 00:04:52,267 | INFO | all data control threads have been joined
[2026-03-19 20:05:48] 2026-03-20 00:04:52,540 | INFO | all job control threads have been joined
[2026-03-19 20:05:48] 2026-03-20 00:04:52,870 | INFO | breaking -- sending SIGTERM to pid=2939458
[2026-03-19 20:05:48] 2026-03-20 00:04:52,871 | INFO | breaking -- sleep 10 s before sending SIGKILL pid=2939458
[2026-03-19 20:05:48] 2026-03-20 00:04:53,273 | INFO | [data] control thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:53,443 | INFO | all payload control threads have been joined
[2026-03-19 20:05:48] 2026-03-20 00:04:53,549 | INFO | [job] control thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,025 | INFO | [data] copytool_out thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,032 | INFO | [payload] failed_post thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,032 | INFO | [payload] validate_post thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,270 | INFO | job.realtimelogging is not enabled
[2026-03-19 20:05:48] 2026-03-20 00:04:54,354 | INFO | [job] create_data_payload thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,357 | INFO | [payload] validate_pre thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,382 | INFO | [job] retrieve thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,448 | INFO | [payload] control thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,473 | INFO | [job] validate thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:54,525 | INFO | [data] copytool_in thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:55,276 | INFO | [payload] run_realtimelog thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:56,030 | INFO | [data] queue_monitor thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:04:59,897 | INFO | system is under heavy CPU load
[2026-03-19 20:05:48] 2026-03-20 00:04:59,897 | INFO | CPU consumption time changed by a factor of 0.00032758244158113123 (below the limit of 10)
[2026-03-19 20:05:48] 2026-03-20 00:04:59,898 | INFO | (instant) CPU consumption time for pid=2939458: 3)
[2026-03-19 20:05:48] 2026-03-20 00:04:59,898 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:48] 2026-03-20 00:05:00,500 | INFO | number of running child processes to parent process 2939458: 1
[2026-03-19 20:05:48] 2026-03-20 00:05:00,500 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:48] 2026-03-20 00:05:00,500 | INFO | will abort loop
[2026-03-19 20:05:48] 2026-03-20 00:05:01,505 | WARNING | REACHED_MAXTIME seen by job monitor - but final job object not set, cannot report
[2026-03-19 20:05:48] 2026-03-20 00:05:01,506 | INFO | [job] job monitor thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:05:02,921 | INFO |
[2026-03-19 20:05:48]
[2026-03-19 20:05:48] finished pid=2939458 exit_code=None state=failed
[2026-03-19 20:05:48]
[2026-03-19 20:05:48] 2026-03-20 00:05:02,934 | WARNING | detected unset exit_code from wait_graceful - reset to -1
[2026-03-19 20:05:48] 2026-03-20 00:05:02,950 | INFO | using pid=2954134 to kill prmon
[2026-03-19 20:05:48] 2026-03-20 00:05:02,951 | INFO | stopping utility process 'MemoryMonitor' with signal 10
[2026-03-19 20:05:48] 2026-03-20 00:05:02,951 | INFO | process 2954134 no longer exists
[2026-03-19 20:05:48] 2026-03-20 00:05:02,952 | INFO | utility process 2939466 cleanup finished with status=True
[2026-03-19 20:05:48] 2026-03-20 00:05:02,952 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#0/#20)
[2026-03-19 20:05:48] 2026-03-20 00:05:06,188 | INFO | copied /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/memory_monitor_summary.json to /tmp/boinchome/slots/0
[2026-03-19 20:05:48] 2026-03-20 00:05:06,244 | INFO | found no lingering processes
[2026-03-19 20:05:48] 2026-03-20 00:05:06,244 | WARNING | pilot error code received a negative transform exit code=-1 - will not set transexitcode
[2026-03-19 20:05:48] 2026-03-20 00:05:06,244 | INFO | CPU consumption time: 55.66 s (rounded to 56 s)
[2026-03-19 20:05:48] 2026-03-20 00:05:06,244 | WARNING | main payload execution returned non-zero exit code: -1
[2026-03-19 20:05:48] 2026-03-20 00:05:06,244 | WARNING | payload was killed (negative exit code)
[2026-03-19 20:05:48] 2026-03-20 00:05:06,245 | INFO | scanning dmesg message for subprocess=2956257 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,245 | INFO | executing command: dmesg|grep 2956257
[2026-03-19 20:05:48] 2026-03-20 00:05:06,300 | INFO | scanning dmesg message for subprocess=2956357 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,302 | INFO | executing command: dmesg|grep 2956357
[2026-03-19 20:05:48] 2026-03-20 00:05:06,364 | INFO | scanning dmesg message for subprocess=2956360 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,365 | INFO | executing command: dmesg|grep 2956360
[2026-03-19 20:05:48] 2026-03-20 00:05:06,417 | INFO | scanning dmesg message for subprocess=2956363 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,417 | INFO | executing command: dmesg|grep 2956363
[2026-03-19 20:05:48] 2026-03-20 00:05:06,476 | INFO | scanning dmesg message for subprocess=2956442 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,476 | INFO | executing command: dmesg|grep 2956442
[2026-03-19 20:05:48] 2026-03-20 00:05:06,514 | INFO | scanning dmesg message for subprocess=2956476 for memory errors
[2026-03-19 20:05:48] 2026-03-20 00:05:06,515 | INFO | executing command: dmesg|grep 2956476
[2026-03-19 20:05:48] 2026-03-20 00:05:06,992 | WARNING | job report does not exist: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/jobReport.json
[2026-03-19 20:05:48] 2026-03-20 00:05:06,992 | WARNING | metadata does not exist: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/metadata.xml
[2026-03-19 20:05:48] 2026-03-20 00:05:06,993 | WARNING | file does not exist: /tmp/boinchome/slots/0/PanDA_Pilot-7055964468/metadata.xml
[2026-03-19 20:05:48] 2026-03-20 00:05:06,993 | INFO | generated guid for lfn=HITS.49144843._000002.pool.root.1: 4CBA28E8-24F2-4EDB-B8BF-42CF3E5FDBA6
[2026-03-19 20:05:48] 2026-03-20 00:05:06,993 | WARNING | aborting payload error diagnosis since an error has already been set: [1315, 1187]
[2026-03-19 20:05:48] 2026-03-20 00:05:08,853 | INFO | [payload] execute_payloads thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:05:15,148 | INFO | [job] queue monitor thread has finished
[2026-03-19 20:05:48] 2026-03-20 00:05:16,543 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139946315175744)>', '<ExcThread(cgroup_monitor, started 139945847015168)>']
[2026-03-19 20:05:48] 2026-03-20 00:05:18,653 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139946315175744)>', '<ExcThread(cgroup_monitor, started 139945847015168)>']
[2026-03-19 20:05:48] 2026-03-20 00:05:20,764 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139946315175744)>', '<ExcThread(cgroup_monitor, started 139945847015168)>']
[2026-03-19 20:05:48] 2026-03-20 00:05:22,874 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139946315175744)>', '<ExcThread(cgroup_monitor, started 139945847015168)>']
[2026-03-19 20:05:48] 2026-03-20 00:05:23,383 | INFO | [monitor] cgroup control has ended
[2026-03-19 20:05:48] 2026-03-20 00:05:24,884 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139946315175744)>'])
[2026-03-19 20:05:48] 2026-03-20 00:05:29,909 | INFO | all workflow threads have been joined
[2026-03-19 20:05:48] 2026-03-20 00:05:29,928 | INFO | end of generic workflow (traces error code: 0)
[2026-03-19 20:05:48] 2026-03-20 00:05:29,929 | INFO | traces error code: 0
[2026-03-19 20:05:48] 2026-03-20 00:05:29,929 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2026-03-19 20:05:48] 2026-03-20 00:05:30,921 [wrapper] ==== pilot stdout END ====
[2026-03-19 20:05:48] 2026-03-20 00:05:30,930 [wrapper] ==== wrapper stdout RESUME ====
[2026-03-19 20:05:48] 2026-03-20 00:05:30,934 [wrapper] pilotpid: 2929398
[2026-03-19 20:05:48] 2026-03-20 00:05:30,938 [wrapper] Pilot exit status: 0
[2026-03-19 20:05:48] 2026-03-20 00:05:30,977 [wrapper] pandaids: 7055964468 7055964468 7055964468
[2026-03-19 20:05:48] 2026-03-20 00:05:31,040 [wrapper] cleanup supervisor_pilot 3988556 2929403
[2026-03-19 20:05:48] 2026-03-20 00:05:31,044 [wrapper] Test setup, not cleaning
[2026-03-19 20:05:48] 2026-03-20 00:05:31,050 [wrapper] apfmon messages muted
[2026-03-19 20:05:48] 2026-03-20 00:05:31,054 [wrapper] ==== wrapper stdout END ====
[2026-03-19 20:05:48] 2026-03-20 00:05:31,058 [wrapper] ==== wrapper stderr END ====
[2026-03-19 20:05:48] *** Error codes and diagnostics ***
[2026-03-19 20:05:48] *** Listing of results directory ***
[2026-03-19 20:05:48] total 778620
[2026-03-19 20:05:48] drwx------. 5 boincer umatlas 4096 Mar 10 12:00 pilot3
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 585013 Mar 15 10:48 pilot3.tar.gz
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 5111 Mar 15 10:48 queuedata.json
[2026-03-19 20:05:48] -rwx------. 1 boincer umatlas 36322 Mar 15 10:49 runpilot2-wrapper.sh
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 100 Mar 15 10:50 wrapper_26015_x86_64-pc-linux-gnu
[2026-03-19 20:05:48] -rwxr-xr-x. 1 boincer umatlas 7986 Mar 15 10:50 run_atlas
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 105 Mar 15 10:50 job.xml
[2026-03-19 20:05:48] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 EVNT.49144833._000001.pool.root.1
[2026-03-19 20:05:48] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 ATLAS.root_0
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 15845 Mar 15 10:50 start_atlas.sh
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 597710 Mar 15 10:50 input.tar.gz
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 0 Mar 15 10:50 boinc_lockfile
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 0 Mar 15 19:48 wrapper_sigint_2855471
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 1511579 Mar 15 19:48 agis_ddmendpoints.agis.ALL.json
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 0 Mar 15 19:51 wrapper_sigkill_2855471
[2026-03-19 20:05:48] drwxrwx--x. 2 boincer umatlas 4096 Mar 15 19:51 shared
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 2935 Mar 15 20:04 pandaJob.out
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 57 Mar 15 20:04 setup.sh.local
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 1006471 Mar 15 20:04 agis_schedconf.cvmfs.json
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 442 Mar 15 20:04 workernode_map.json
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 954 Mar 19 19:39 heartbeat.json
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 6616 Mar 19 20:03 init_data.xml
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 97 Mar 19 20:04 pilot_heartbeat.json
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 533 Mar 19 20:04 boinc_task_state.xml
[2026-03-19 20:05:48] drwxrwx---. 3 boincer umatlas 4096 Mar 19 20:05 PanDA_Pilot-7055964468
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 1082 Mar 19 20:05 memory_monitor_summary.json
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 40405676 Mar 19 20:05 pilotlog.txt
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 40448883 Mar 19 20:05 log.49144843._000002.job.log.1
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 571 Mar 19 20:05 runtime_log
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 40458240 Mar 19 20:05 result.tar.gz
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 8755 Mar 19 20:05 runtime_log.err
[2026-03-19 20:05:48] -rw-------. 1 boincer umatlas 1384 Mar 19 20:05 EDsMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmqEvLDmy4Uslm.diag
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 8192 Mar 19 20:05 boinc_mmap_file
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 30 Mar 19 20:05 wrapper_checkpoint.txt
[2026-03-19 20:05:48] -rw-r--r--. 1 boincer umatlas 47781 Mar 19 20:05 stderr.txt
[2026-03-19 20:05:48] No HITS result produced
[2026-03-19 20:05:48] *** Contents of shared directory: ***
[2026-03-19 20:05:48] total 368268
[2026-03-19 20:05:48] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 ATLAS.root_0
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 15845 Mar 15 10:50 start_atlas.sh
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 597710 Mar 15 10:50 input.tar.gz
[2026-03-19 20:05:48] -rw-r--r--. 2 boincer umatlas 40458240 Mar 19 20:05 result.tar.gz
20:05:50 (2914241): run_atlas exited; CPU time 17005.217664
20:05:50 (2914241): called boinc_finish(0)
</stderr_txt>
]]>
©2026 CERN