| Name | 9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn_0 |
| Workunit | 239937382 |
| 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 | 2 days 18 hours 33 min 44 sec |
| CPU time | 11 days 7 hours 18 min 46 sec |
| Priority | 28 |
| Validate state | Valid |
| Credit | 5,962.69 |
| 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.23 GB |
| Peak disk usage | 2.57 GB |
Stderr output
<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
10:50:23 (2317174): wrapper (7.7.26015): starting
10:50:23 (2317174): wrapper: running run_atlas (--nthreads 10)
[2026-03-15 10:50:23] Arguments: --nthreads 10
[2026-03-15 10:50:23] Threads: 10
[2026-03-15 10:50:23] Checking for CVMFS
[2026-03-15 10:50:23] Probing /cvmfs/atlas.cern.ch... OK
[2026-03-15 10:50:23] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-03-15 10:50:23] Running cvmfs_config stat atlas.cern.ch
[2026-03-15 10:50:23] 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:23] 2.13.3.0 7202 115016 148116 157317 0 61 38408564 40960000 7691 16776704 0 75868757 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:23] CVMFS is ok
[2026-03-15 10:50:23] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-03-15 10:50:23] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-03-15 10:50:23] Further information can be found at the LHC@home message board.
[2026-03-15 10:50:23] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-03-15 10:50:23] Checking for apptainer binary...
[2026-03-15 10:50:23] Using apptainer found in PATH at /usr/bin/apptainer
[2026-03-15 10:50:23] Running /usr/bin/apptainer --version
[2026-03-15 10:50:23] apptainer version 1.4.5-2.el9
[2026-03-15 10:50:23] 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:23] c-211-10.aglt2.org
[2026-03-15 10:50:23] apptainer works
[2026-03-15 10:50:23] Set ATHENA_PROC_NUMBER=10
[2026-03-15 10:50:23] Set ATHENA_CORE_NUMBER=10
[2026-03-15 10:50:23] Starting ATLAS job with PandaID=7055964470
[2026-03-15 10:50:23] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
19:47:56 (2843308): wrapper (7.7.26015): starting
19:47:56 (2843308): 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=7055964470
[2026-03-15 19:47:58] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /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/1/
[2026-03-15 19:51:04] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/1/
[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/7055964470.out
[2026-03-15 19:51:04] + GTAG=http://aipanda404.cern.ch/data/jobs/2026-03-15/BOINC_MCORE/7055964470.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=9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBID=9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn
[2026-03-15 19:51:04] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn
[2026-03-15 19:51:04] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn
[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/1
[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/1/log.49144843._000004.job.log.1
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/1/log.49144843._000004.job.log.1
[2026-03-15 19:51:04] ++ pwd
[2026-03-15 19:51:04] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/1.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/1/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.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/1/
[2026-03-15 19:51:04] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/1/
[2026-03-15 19:51:04] + '[' -e /tmp/boinchome/slots/1/init_data.xml ']'
[2026-03-15 19:51:04] + grep '<use_http_proxy/>' /tmp/boinchome/slots/1/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/1/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/1/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/1
[2026-03-15 19:51:04] + export HOME
[2026-03-15 19:51:04] + cd /tmp/boinchome/slots/1
[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/1/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.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/1/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.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/1/9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.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._000004.job.log.1 ./log.49144843._000004.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._000004.job.log.1 ./log.49144843._000004.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._000004.job.log.1 ./log.49144843._000004.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./log.49144843._000004.job.log.1 ']'
[2026-03-15 19:51:04] + flist='*.diag ./heartbeat.json ./log.49144843._000004.job.log.1'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000004.job.log.1 ./log.49144843._000004.job.log.1 ./gmlog/
[2026-03-15 19:51:04] + '[' -e ./log.49144843._000004.job.log.1 ']'
[2026-03-15 19:51:04] + flist='*.diag ./heartbeat.json ./log.49144843._000004.job.log.1 ./log.49144843._000004.job.log.1'
[2026-03-15 19:51:04] + for f in ./heartbeat.json ./output.list ./log.49144843._000004.job.log.1 ./log.49144843._000004.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 9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.diag ./heartbeat.json ./log.49144843._000004.job.log.1 ./log.49144843._000004.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] ./PanDA_Pilot-7055964470/prmon.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/log.EVNTtoHITS
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/pilotlog.txt
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_1/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_1/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_1/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_7/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_7/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_7/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/evt_counter/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/evt_counter/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/evt_counter/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_4/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_4/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_4/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_6/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_6/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_6/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_2/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_2/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_2/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_0/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_0/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_0/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_5/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_5/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_5/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_3/AthenaMP.log
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_3/PoolFileCatalog.xml
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/athenaMP-workers-EVNTtoHITS-sim/worker_3/PoolFileCatalog.xml.BAK
[2026-03-15 19:51:04] ./PanDA_Pilot-7055964470/PoolFileCatalog.xml.AthenaMP-saved
[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] ./log.49144843._000004.job.log.1
20:04:43 (2914242): wrapper (7.7.26015): starting
20:04:43 (2914242): 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=7055964470
[2026-03-15 20:04:43] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-03-19 20:05:53] *** The last 200 lines of the pilot log: ***
[2026-03-19 20:05:53] 2026-03-20 00:03:30,653 | INFO | (instant) CPU consumption time for pid=2939459: 8931)
[2026-03-19 20:05:53] 2026-03-20 00:03:30,653 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:03:30,901 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,095 | WARNING | memory limits not set in config, using defaults: 'NoneType' object has no attribute 'get'
[2026-03-19 20:05:53] 2026-03-20 00:03:31,095 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 3243371 kB <= 32768000 kB (subresource=MCORE)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,096 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 651280 B
[2026-03-19 20:05:53] 2026-03-20 00:03:31,096 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6664 B
[2026-03-19 20:05:53] 2026-03-20 00:03:31,097 | INFO | executing command: df -mP /tmp/boinchome/slots/1
[2026-03-19 20:05:53] 2026-03-20 00:03:31,259 | INFO | sufficient remaining disk space (55767465984 B)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,259 | INFO | work directory size check will use 5033164800 B as a max limit (20% grace limit added, divider=1)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,299 | INFO | time since job start (345522s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,310 | INFO | size of work directory /tmp/boinchome/slots/1/PanDA_Pilot-7055964470: 1666142995 B (within 5033164800 B limit)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,311 | INFO | pfn file=/tmp/boinchome/slots/1/PanDA_Pilot-7055964470/HITS.49144843._000004.pool.root.1 does not exist (skip from workdir size calculation)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,311 | INFO | total size of present files: 0 B (workdir size: 1666142995 B)
[2026-03-19 20:05:53] 2026-03-20 00:03:31,311 | INFO | output file size check: skipping output file /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/HITS.49144843._000004.pool.root.1 since it does not exist
[2026-03-19 20:05:53] 2026-03-20 00:03:32,417 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:03:32,418 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:03:33,306 | INFO | time since job start (345524s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:34,952 | INFO | monitor loop #18442: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:03:35,197 | INFO | PID=2929401 has CPU usage=10.7% 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:53] 2026-03-20 00:03:35,198 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:53] 2026-03-20 00:03:36,200 | INFO | time since job start (345527s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:38,206 | INFO | time since job start (345529s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:40,213 | INFO | time since job start (345531s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:42,235 | INFO | time since job start (345533s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:44,242 | INFO | time since job start (345535s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:45,940 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:03:45,940 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:03:45,941 | INFO | (instant) CPU consumption time for pid=2939459: 8931)
[2026-03-19 20:05:53] 2026-03-20 00:03:45,941 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:03:46,285 | INFO | time since job start (345537s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:47,056 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:03:47,057 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:03:48,305 | INFO | time since job start (345539s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:49,563 | INFO | monitor loop #18443: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:03:50,312 | INFO | time since job start (345541s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:52,319 | INFO | time since job start (345543s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:54,326 | INFO | time since job start (345545s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:56,333 | INFO | time since job start (345547s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:03:58,234 | INFO | PID=2929401 has CPU usage=6.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:53] 2026-03-20 00:03:58,234 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:53] 2026-03-20 00:03:59,235 | INFO | time since job start (345550s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:00,583 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:04:00,583 | INFO | CPU consumption time changed by a factor of 1.000111969544284 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:04:00,598 | INFO | (instant) CPU consumption time for pid=2939459: 8932)
[2026-03-19 20:05:53] 2026-03-20 00:04:00,599 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:04:01,242 | INFO | time since job start (345552s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:01,475 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:04:01,476 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:04:03,255 | INFO | time since job start (345554s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:03,980 | INFO | monitor loop #18444: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:04:05,262 | INFO | time since job start (345556s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:07,269 | INFO | time since job start (345558s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:09,277 | INFO | time since job start (345560s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:11,288 | INFO | time since job start (345562s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:13,320 | INFO | time since job start (345564s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:14,963 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:04:14,963 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:04:14,963 | INFO | (instant) CPU consumption time for pid=2939459: 8932)
[2026-03-19 20:05:53] 2026-03-20 00:04:14,964 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:04:15,353 | INFO | time since job start (345566s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:15,944 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:04:15,944 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:04:17,359 | INFO | time since job start (345568s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:18,449 | INFO | monitor loop #18445: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:04:19,366 | INFO | time since job start (345570s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:20,827 | INFO | PID=2929401 has CPU usage=9.8% 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:53] 2026-03-20 00:04:20,827 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:53] 2026-03-20 00:04:21,829 | INFO | time since job start (345572s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:23,836 | INFO | time since job start (345574s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:25,845 | INFO | time since job start (345576s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:27,856 | INFO | time since job start (345578s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:29,478 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:04:29,478 | INFO | CPU consumption time changed by a factor of 1.0 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:04:29,478 | INFO | (instant) CPU consumption time for pid=2939459: 8932)
[2026-03-19 20:05:53] 2026-03-20 00:04:29,479 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:04:29,864 | INFO | time since job start (345580s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:30,185 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:04:30,186 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:04:31,870 | INFO | time since job start (345582s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:32,690 | INFO | monitor loop #18446: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:04:33,877 | INFO | time since job start (345584s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:35,886 | INFO | time since job start (345586s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:37,918 | INFO | time since job start (345588s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:39,925 | INFO | time since job start (345590s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:41,932 | INFO | time since job start (345592s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:45,682 | INFO | PID=2929401 has CPU usage=7.0% 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:53] 2026-03-20 00:04:45,682 | INFO | .. there are 9 such processes running
[2026-03-19 20:05:53] 2026-03-20 00:04:46,014 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:04:46,014 | INFO | CPU consumption time changed by a factor of 1.0001119570085086 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,014 | INFO | (instant) CPU consumption time for pid=2939459: 8933)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,014 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,277 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,443 | WARNING | memory limits not set in config, using defaults: 'NoneType' object has no attribute 'get'
[2026-03-19 20:05:53] 2026-03-20 00:04:46,444 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 3243371 kB <= 32768000 kB (subresource=MCORE)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,444 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 651280 B
[2026-03-19 20:05:53] 2026-03-20 00:04:46,445 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6664 B
[2026-03-19 20:05:53] 2026-03-20 00:04:46,445 | INFO | executing command: df -mP /tmp/boinchome/slots/1
[2026-03-19 20:05:53] 2026-03-20 00:04:46,496 | INFO | sufficient remaining disk space (55766417408 B)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,496 | INFO | work directory size check will use 5033164800 B as a max limit (20% grace limit added, divider=1)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,505 | INFO | size of work directory /tmp/boinchome/slots/1/PanDA_Pilot-7055964470: 1666969258 B (within 5033164800 B limit)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,506 | INFO | pfn file=/tmp/boinchome/slots/1/PanDA_Pilot-7055964470/HITS.49144843._000004.pool.root.1 does not exist (skip from workdir size calculation)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,506 | INFO | total size of present files: 0 B (workdir size: 1666969258 B)
[2026-03-19 20:05:53] 2026-03-20 00:04:46,506 | INFO | output file size check: skipping output file /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/HITS.49144843._000004.pool.root.1 since it does not exist
[2026-03-19 20:05:53] 2026-03-20 00:04:46,691 | INFO | time since job start (345597s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:47,166 | INFO | number of running child processes to parent process 2939459: 13
[2026-03-19 20:05:53] 2026-03-20 00:04:47,191 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:04:48,698 | INFO | time since job start (345599s) is within the limit (345600.0s)
[2026-03-19 20:05:53] 2026-03-20 00:04:49,697 | INFO | monitor loop #18447: job 0:7055964470 is in state 'running'
[2026-03-19 20:05:53] 2026-03-20 00:04:50,708 | CRITICAL | time since job start (345601s) has exceeded the limit (345600.0s) - time to abort pilot
[2026-03-19 20:05:53] 2026-03-20 00:04:50,708 | CRITICAL | limit = max running time (345600s) * pilot walltime grace (1.0)
[2026-03-19 20:05:53] 2026-03-20 00:04:50,708 | INFO | setting REACHED_MAXTIME and graceful stop
[2026-03-19 20:05:53] 2026-03-20 00:04:50,730 | INFO | current server update state: RUNNING
[2026-03-19 20:05:53] 2026-03-20 00:04:50,731 | INFO | update_server=False
[2026-03-19 20:05:53] 2026-03-20 00:04:50,731 | INFO | [monitor] control thread has ended
[2026-03-19 20:05:53] 2026-03-20 00:04:50,747 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2026-03-19 20:05:53] 2026-03-20 00:04:50,848 | INFO | all data control threads have been joined
[2026-03-19 20:05:53] 2026-03-20 00:04:51,007 | INFO | all payload control threads have been joined
[2026-03-19 20:05:53] 2026-03-20 00:04:51,576 | INFO | breaking -- sending SIGTERM to pid=2939459
[2026-03-19 20:05:53] 2026-03-20 00:04:51,577 | INFO | breaking -- sleep 10 s before sending SIGKILL pid=2939459
[2026-03-19 20:05:53] 2026-03-20 00:04:51,854 | INFO | [data] control thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:51,884 | INFO | all job control threads have been joined
[2026-03-19 20:05:53] 2026-03-20 00:04:51,950 | INFO | [job] retrieve thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,003 | INFO | [data] copytool_in thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,017 | INFO | [payload] control thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,237 | INFO | [job] create_data_payload thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,337 | INFO | job.realtimelogging is not enabled
[2026-03-19 20:05:53] 2026-03-20 00:04:52,370 | INFO | [payload] validate_post thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,406 | INFO | [job] validate thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,482 | INFO | [payload] validate_pre thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,750 | INFO | [data] copytool_out thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,781 | INFO | [payload] failed_post thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:52,890 | INFO | [job] control thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:53,343 | INFO | [payload] run_realtimelog thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:55,456 | INFO | [data] queue_monitor thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:04:56,822 | INFO | [monitor] cgroup control has ended
[2026-03-19 20:05:53] 2026-03-20 00:05:00,641 | INFO | system is under heavy CPU load
[2026-03-19 20:05:53] 2026-03-20 00:05:00,641 | INFO | CPU consumption time changed by a factor of 0.0003358334266203963 (below the limit of 10)
[2026-03-19 20:05:53] 2026-03-20 00:05:00,641 | INFO | (instant) CPU consumption time for pid=2939459: 3)
[2026-03-19 20:05:53] 2026-03-20 00:05:00,642 | INFO | using path: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_output.txt (trf name=prmon)
[2026-03-19 20:05:53] 2026-03-20 00:05:01,158 | INFO | number of running child processes to parent process 2939459: 1
[2026-03-19 20:05:53] 2026-03-20 00:05:01,158 | INFO | maximum number of monitored processes: 16
[2026-03-19 20:05:53] 2026-03-20 00:05:01,158 | INFO | will abort loop
[2026-03-19 20:05:53] 2026-03-20 00:05:01,627 | INFO |
[2026-03-19 20:05:53]
[2026-03-19 20:05:53] finished pid=2939459 exit_code=None state=failed
[2026-03-19 20:05:53]
[2026-03-19 20:05:53] 2026-03-20 00:05:01,627 | WARNING | detected unset exit_code from wait_graceful - reset to -1
[2026-03-19 20:05:53] 2026-03-20 00:05:01,644 | INFO | using pid=2954145 to kill prmon
[2026-03-19 20:05:53] 2026-03-20 00:05:01,644 | INFO | stopping utility process 'MemoryMonitor' with signal 10
[2026-03-19 20:05:53] 2026-03-20 00:05:01,644 | INFO | process 2954145 no longer exists
[2026-03-19 20:05:53] 2026-03-20 00:05:01,645 | INFO | utility process 2939468 cleanup finished with status=True
[2026-03-19 20:05:53] 2026-03-20 00:05:01,645 | 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:53] 2026-03-20 00:05:02,166 | WARNING | REACHED_MAXTIME seen by job monitor - but final job object not set, cannot report
[2026-03-19 20:05:53] 2026-03-20 00:05:02,166 | INFO | [job] job monitor thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:05:04,856 | INFO | copied /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/memory_monitor_summary.json to /tmp/boinchome/slots/1
[2026-03-19 20:05:53] 2026-03-20 00:05:04,916 | INFO | found no lingering processes
[2026-03-19 20:05:53] 2026-03-20 00:05:04,916 | WARNING | pilot error code received a negative transform exit code=-1 - will not set transexitcode
[2026-03-19 20:05:53] 2026-03-20 00:05:04,916 | INFO | CPU consumption time: 55.34 s (rounded to 55 s)
[2026-03-19 20:05:53] 2026-03-20 00:05:04,917 | WARNING | main payload execution returned non-zero exit code: -1
[2026-03-19 20:05:53] 2026-03-20 00:05:04,917 | WARNING | payload was killed (negative exit code)
[2026-03-19 20:05:53] 2026-03-20 00:05:04,930 | INFO | scanning dmesg message for subprocess=2956258 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:04,931 | INFO | executing command: dmesg|grep 2956258
[2026-03-19 20:05:53] 2026-03-20 00:05:04,999 | INFO | scanning dmesg message for subprocess=2956358 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:05,000 | INFO | executing command: dmesg|grep 2956358
[2026-03-19 20:05:53] 2026-03-20 00:05:05,064 | INFO | scanning dmesg message for subprocess=2956361 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:05,065 | INFO | executing command: dmesg|grep 2956361
[2026-03-19 20:05:53] 2026-03-20 00:05:05,133 | INFO | scanning dmesg message for subprocess=2956364 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:05,134 | INFO | executing command: dmesg|grep 2956364
[2026-03-19 20:05:53] 2026-03-20 00:05:05,195 | INFO | scanning dmesg message for subprocess=2956475 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:05,195 | INFO | executing command: dmesg|grep 2956475
[2026-03-19 20:05:53] 2026-03-20 00:05:05,250 | INFO | scanning dmesg message for subprocess=2956443 for memory errors
[2026-03-19 20:05:53] 2026-03-20 00:05:05,251 | INFO | executing command: dmesg|grep 2956443
[2026-03-19 20:05:53] 2026-03-20 00:05:05,733 | WARNING | job report does not exist: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/jobReport.json
[2026-03-19 20:05:53] 2026-03-20 00:05:05,733 | WARNING | metadata does not exist: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/metadata.xml
[2026-03-19 20:05:53] 2026-03-20 00:05:05,734 | WARNING | file does not exist: /tmp/boinchome/slots/1/PanDA_Pilot-7055964470/metadata.xml
[2026-03-19 20:05:53] 2026-03-20 00:05:05,734 | INFO | generated guid for lfn=HITS.49144843._000004.pool.root.1: FFBBFDD0-448C-487F-9BCB-FFDC97050482
[2026-03-19 20:05:53] 2026-03-20 00:05:05,734 | WARNING | aborting payload error diagnosis since an error has already been set: [1315, 1187]
[2026-03-19 20:05:53] 2026-03-20 00:05:07,513 | INFO | [payload] execute_payloads thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:05:07,741 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139943346173760)>', '<ExcThread(queue_monitor, started 139942785185536)>']
[2026-03-19 20:05:53] 2026-03-20 00:05:09,767 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139943346173760)>', '<ExcThread(queue_monitor, started 139942785185536)>']
[2026-03-19 20:05:53] 2026-03-20 00:05:11,777 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139943346173760)>', '<ExcThread(queue_monitor, started 139942785185536)>']
[2026-03-19 20:05:53] 2026-03-20 00:05:13,783 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139943346173760)>', '<ExcThread(queue_monitor, started 139942785185536)>']
[2026-03-19 20:05:53] 2026-03-20 00:05:13,854 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139943346173760)>', '<ExcThread(queue_monitor, started 139942785185536)>']
[2026-03-19 20:05:53] 2026-03-20 00:05:13,854 | INFO | [job] queue monitor thread has finished
[2026-03-19 20:05:53] 2026-03-20 00:05:15,794 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139943346173760)>'])
[2026-03-19 20:05:53] 2026-03-20 00:05:20,820 | INFO | all workflow threads have been joined
[2026-03-19 20:05:53] 2026-03-20 00:05:20,820 | INFO | end of generic workflow (traces error code: 0)
[2026-03-19 20:05:53] 2026-03-20 00:05:20,821 | INFO | traces error code: 0
[2026-03-19 20:05:53] 2026-03-20 00:05:20,821 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2026-03-19 20:05:53] 2026-03-20 00:05:22,481 [wrapper] ==== pilot stdout END ====
[2026-03-19 20:05:53] 2026-03-20 00:05:22,486 [wrapper] ==== wrapper stdout RESUME ====
[2026-03-19 20:05:53] 2026-03-20 00:05:22,491 [wrapper] pilotpid: 2929401
[2026-03-19 20:05:53] 2026-03-20 00:05:22,496 [wrapper] Pilot exit status: 0
[2026-03-19 20:05:53] 2026-03-20 00:05:22,539 [wrapper] pandaids: 7055964470 7055964470 7055964470
[2026-03-19 20:05:53] 2026-03-20 00:05:22,704 [wrapper] cleanup supervisor_pilot 3988500 2929405
[2026-03-19 20:05:53] 2026-03-20 00:05:22,710 [wrapper] Test setup, not cleaning
[2026-03-19 20:05:53] 2026-03-20 00:05:22,734 [wrapper] apfmon messages muted
[2026-03-19 20:05:53] 2026-03-20 00:05:22,739 [wrapper] ==== wrapper stdout END ====
[2026-03-19 20:05:53] 2026-03-20 00:05:22,743 [wrapper] ==== wrapper stderr END ====
[2026-03-19 20:05:53] *** Error codes and diagnostics ***
[2026-03-19 20:05:53] *** Listing of results directory ***
[2026-03-19 20:05:53] total 777908
[2026-03-19 20:05:53] drwx------. 5 boincer umatlas 4096 Mar 10 12:00 pilot3
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 585013 Mar 15 10:48 pilot3.tar.gz
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 5111 Mar 15 10:48 queuedata.json
[2026-03-19 20:05:53] -rwx------. 1 boincer umatlas 36322 Mar 15 10:49 runpilot2-wrapper.sh
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 100 Mar 15 10:50 wrapper_26015_x86_64-pc-linux-gnu
[2026-03-19 20:05:53] -rwxr-xr-x. 1 boincer umatlas 7986 Mar 15 10:50 run_atlas
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 105 Mar 15 10:50 job.xml
[2026-03-19 20:05:53] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 EVNT.49144833._000001.pool.root.1
[2026-03-19 20:05:53] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 ATLAS.root_0
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 597708 Mar 15 10:50 input.tar.gz
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 15845 Mar 15 10:50 start_atlas.sh
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 0 Mar 15 10:50 boinc_lockfile
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 0 Mar 15 19:48 wrapper_sigint_2855468
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 1511579 Mar 15 19:48 agis_ddmendpoints.agis.ALL.json
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 0 Mar 15 19:51 wrapper_sigkill_2855468
[2026-03-19 20:05:53] drwxrwx--x. 2 boincer umatlas 4096 Mar 15 19:51 shared
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 2935 Mar 15 20:04 pandaJob.out
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 23355 Mar 15 20:04 stderr.txt
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 57 Mar 15 20:04 setup.sh.local
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 1006471 Mar 15 20:04 agis_schedconf.cvmfs.json
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 435 Mar 15 20:04 workernode_map.json
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 955 Mar 19 19:38 heartbeat.json
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 6616 Mar 19 20:03 init_data.xml
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 97 Mar 19 20:04 pilot_heartbeat.json
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 533 Mar 19 20:05 boinc_task_state.xml
[2026-03-19 20:05:53] drwxrwx---. 3 boincer umatlas 4096 Mar 19 20:05 PanDA_Pilot-7055964470
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 1082 Mar 19 20:05 memory_monitor_summary.json
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 40171373 Mar 19 20:05 pilotlog.txt
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 40214580 Mar 19 20:05 log.49144843._000004.job.log.1
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 571 Mar 19 20:05 runtime_log
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 40222720 Mar 19 20:05 result.tar.gz
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 8755 Mar 19 20:05 runtime_log.err
[2026-03-19 20:05:53] -rw-------. 1 boincer umatlas 1383 Mar 19 20:05 9PvMDmfx1L9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmsEvLDmzvKMvn.diag
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 8192 Mar 19 20:05 boinc_mmap_file
[2026-03-19 20:05:53] -rw-r--r--. 1 boincer umatlas 30 Mar 19 20:05 wrapper_checkpoint.txt
[2026-03-19 20:05:53] No HITS result produced
[2026-03-19 20:05:53] *** Contents of shared directory: ***
[2026-03-19 20:05:53] total 368036
[2026-03-19 20:05:53] -rw-r--r--. 3 boincer umatlas 336024765 Mar 15 10:50 ATLAS.root_0
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 597708 Mar 15 10:50 input.tar.gz
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 15845 Mar 15 10:50 start_atlas.sh
[2026-03-19 20:05:53] -rw-r--r--. 2 boincer umatlas 40222720 Mar 19 20:05 result.tar.gz
20:05:55 (2914242): run_atlas exited; CPU time 16908.794563
20:05:55 (2914242): called boinc_finish(0)
</stderr_txt>
]]>
©2026 CERN