Name SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn_1
Workunit 237721049
Created 23 Nov 2025, 19:04:02 UTC
Sent 24 Nov 2025, 5:00:27 UTC
Report deadline 2 Dec 2025, 5:00:27 UTC
Received 26 Nov 2025, 14:37:39 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10878592
Run time 7 hours 38 min 52 sec
CPU time 3 days 4 hours 42 min
Validate state Valid
Credit 3,218.19
Device peak FLOPS 35.53 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.63 GB
Peak swap size 31.96 GB
Peak disk usage 2.05 GB

Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
00:00:52 (1545979): wrapper (7.7.26015): starting
00:00:52 (1545979): wrapper: running run_atlas (--nthreads 9)
[2025-11-24 00:00:52] Arguments: --nthreads 9
[2025-11-24 00:00:52] Threads: 9
[2025-11-24 00:00:52] Checking for CVMFS
[2025-11-24 00:00:53] Probing /cvmfs/atlas.cern.ch... OK
[2025-11-24 00:00:53] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-11-24 00:00:53] Running cvmfs_config stat atlas.cern.ch
[2025-11-24 00:00:54] 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
[2025-11-24 00:00:54] 2.13.2.0 6122 31791 369248 153233 3 112 37835235 40960000 16237 16776704 0 63879013 99.590 70904328 40126 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-11-24 00:00:54] CVMFS is ok
[2025-11-24 00:00:54] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-11-24 00:00:54] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-11-24 00:00:54] Further information can be found at the LHC@home message board.
[2025-11-24 00:00:54] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-11-24 00:00:54] Checking for apptainer binary...
[2025-11-24 00:00:54] Using apptainer found in PATH at /usr/bin/apptainer
[2025-11-24 00:00:54] Running /usr/bin/apptainer --version
[2025-11-24 00:00:54] apptainer version 1.4.4-1.el9
[2025-11-24 00:00:54] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-11-24 00:00:55] c-210-35-2.aglt2.org
[2025-11-24 00:00:55] apptainer works
[2025-11-24 00:00:56] Set ATHENA_PROC_NUMBER=9
[2025-11-24 00:00:56] Set ATHENA_CORE_NUMBER=9
[2025-11-24 00:00:56] Starting ATLAS job with PandaID=6895355952
[2025-11-24 00:00:56] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
00:12:03 (126454): wrapper (7.7.26015): starting
00:12:03 (126454): wrapper: running run_atlas (--nthreads 9)
[2025-11-25 00:12:03] Arguments: --nthreads 9
[2025-11-25 00:12:03] Threads: 9
[2025-11-25 00:12:03] This job has been restarted, cleaning up previous attempt
[2025-11-25 00:12:03] Checking for CVMFS
[2025-11-25 00:12:04] Probing /cvmfs/atlas.cern.ch... OK
[2025-11-25 00:12:05] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-11-25 00:12:05] Running cvmfs_config stat atlas.cern.ch
[2025-11-25 00:12:06] 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
[2025-11-25 00:12:06] 2.13.2.0 6122 33242 373560 153271 2 86 29041432 40960000 16549 16776704 0 66778391 99.594 74239690 40391 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-11-25 00:12:06] CVMFS is ok
[2025-11-25 00:12:06] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-11-25 00:12:06] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-11-25 00:12:06] Further information can be found at the LHC@home message board.
[2025-11-25 00:12:06] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-11-25 00:12:06] Checking for apptainer binary...
[2025-11-25 00:12:06] Using apptainer found in PATH at /usr/bin/apptainer
[2025-11-25 00:12:06] Running /usr/bin/apptainer --version
[2025-11-25 00:12:06] apptainer version 1.4.4-1.el9
[2025-11-25 00:12:06] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-11-25 00:12:08] c-210-35-2.aglt2.org
[2025-11-25 00:12:08] apptainer works
[2025-11-25 00:12:08] Set ATHENA_PROC_NUMBER=9
[2025-11-25 00:12:08] Set ATHENA_CORE_NUMBER=9
[2025-11-25 00:12:08] Starting ATLAS job with PandaID=6895355952
[2025-11-25 00:12:08] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-11-25 00:16:28] Job failed
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/2/
[2025-11-25 00:16:28] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/2/
[2025-11-25 00:16:28] + mv ATLAS.root_0 EVNT.47483658._000679.pool.root.1
[2025-11-25 00:16:28] mv: &#226;&#128;&#152;ATLAS.root_0&#226;&#128;&#153; and &#226;&#128;&#152;EVNT.47483658._000679.pool.root.1&#226;&#128;&#153; are the same file
[2025-11-25 00:16:28] + tar --strip-components=5 -xvf input.tar.gz
[2025-11-25 00:16:28] + umask 077
[2025-11-25 00:16:28] ++ date +%s
[2025-11-25 00:16:28] + ACCOUNTING_STARTTIME=1764047530
[2025-11-25 00:16:28] + echo 'Detecting resource accounting method available for the job.'
[2025-11-25 00:16:28] Detecting resource accounting method available for the job.
[2025-11-25 00:16:28] + JOB_ACCOUNTING=
[2025-11-25 00:16:28] + command -v arc-job-cgroup
[2025-11-25 00:16:28] + '[' -z '' ']'
[2025-11-25 00:16:28] + GNU_TIME=/usr/bin/time
[2025-11-25 00:16:28] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2025-11-25 00:16:28] Looking for /usr/bin/time tool for accounting measurements
[2025-11-25 00:16:28] + '[' '!' -z /usr/bin/time ']'
[2025-11-25 00:16:28] + /usr/bin/time --version
[2025-11-25 00:16:28] + echo 'GNU time found and will be used for job accounting.'
[2025-11-25 00:16:28] GNU time found and will be used for job accounting.
[2025-11-25 00:16:28] + JOB_ACCOUNTING=gnutime
[2025-11-25 00:16:28] + '[' -z gnutime ']'
[2025-11-25 00:16:28] + export PANDA_JSID=harvester-CERN_central_ACTA
[2025-11-25 00:16:28] + PANDA_JSID=harvester-CERN_central_ACTA
[2025-11-25 00:16:28] + export GTAG=http://aipanda404.cern.ch/data/jobs/2025-11-23/BOINC_MCORE/6895355952.out
[2025-11-25 00:16:28] + GTAG=http://aipanda404.cern.ch/data/jobs/2025-11-23/BOINC_MCORE/6895355952.out
[2025-11-25 00:16:28] + export PILOT_NOKILL=YES
[2025-11-25 00:16:28] + PILOT_NOKILL=YES
[2025-11-25 00:16:28] + export GRID_GLOBAL_JOBID=SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn
[2025-11-25 00:16:28] + GRID_GLOBAL_JOBID=SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn
[2025-11-25 00:16:28] + export GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn
[2025-11-25 00:16:28] + GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn
[2025-11-25 00:16:28] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-11-25 00:16:28] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-11-25 00:16:28] + export GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2025-11-25 00:16:28] + GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/2
[2025-11-25 00:16:28] + RUNTIME_JOB_STDIN=/dev/null
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/2/log.47556137._006747.job.log.1
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/2/log.47556137._006747.job.log.1
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/2.diag
[2025-11-25 00:16:28] + '[' '!' -z '' ']'
[2025-11-25 00:16:28] + RUNTIME_LOCAL_SCRATCH_DIR=
[2025-11-25 00:16:28] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2025-11-25 00:16:28] + RUNTIME_FRONTEND_SEES_NODE=
[2025-11-25 00:16:28] + RUNTIME_NODE_SEES_FRONTEND=yes
[2025-11-25 00:16:28] + '[' '!' -z '' ']'
[2025-11-25 00:16:28] + '[' -z yes ']'
[2025-11-25 00:16:28] ++ pwd
[2025-11-25 00:16:28] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/2/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.diag
[2025-11-25 00:16:28] + runtimeenvironments=
[2025-11-25 00:16:28] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-11-25 00:16:28] + RTE_function_0 1
[2025-11-25 00:16:28] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-11-25 00:16:28] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-11-25 00:16:28] + export BOINC_APP=ATLAS
[2025-11-25 00:16:28] + BOINC_APP=ATLAS
[2025-11-25 00:16:28] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-11-25 00:16:28] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-11-25 00:16:28] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-11-25 00:16:28] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-11-25 00:16:28] + '[' -z 1 ']'
[2025-11-25 00:16:28] + '[' 1 == 1 ']'
[2025-11-25 00:16:28] + shift
[2025-11-25 00:16:28] + export SITE_NAME=BOINC
[2025-11-25 00:16:28] + SITE_NAME=BOINC
[2025-11-25 00:16:28] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/2/
[2025-11-25 00:16:28] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/2/
[2025-11-25 00:16:28] + '[' -e /tmp/boinchome/slots/2/init_data.xml ']'
[2025-11-25 00:16:28] + grep '<use_http_proxy/>' /tmp/boinchome/slots/2/init_data.xml
[2025-11-25 00:16:28] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_name>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/2/init_data.xml
[2025-11-25 00:16:28] + PROXY_HOST=sl-um-es2.slateci.io
[2025-11-25 00:16:28] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_port>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/2/init_data.xml
[2025-11-25 00:16:28] + PROXY_PORT=6081
[2025-11-25 00:16:28] + '[' -n sl-um-es2.slateci.io ']'
[2025-11-25 00:16:28] + '[' -n 6081 ']'
[2025-11-25 00:16:28] + export FRONTIER_PROXY=http://sl-um-es2.slateci.io:6081
[2025-11-25 00:16:28] + FRONTIER_PROXY=http://sl-um-es2.slateci.io:6081
[2025-11-25 00:16:28] + echo 'export FRONTIER_PROXY="http://sl-um-es2.slateci.io:6081"'
[2025-11-25 00:16:28] + '[' 0 -ne 0 ']'
[2025-11-25 00:16:28] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2025-11-25 00:16:28] + '[' -f /etc/os-release ']'
[2025-11-25 00:16:28] +++ cat /etc/os-release
[2025-11-25 00:16:28] ++ 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"'
[2025-11-25 00:16:28] +++ NAME='CentOS Linux'
[2025-11-25 00:16:28] +++ VERSION='7 (Core)'
[2025-11-25 00:16:28] +++ ID=centos
[2025-11-25 00:16:28] +++ ID_LIKE='rhel fedora'
[2025-11-25 00:16:28] +++ VERSION_ID=7
[2025-11-25 00:16:28] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2025-11-25 00:16:28] +++ ANSI_COLOR='0;31'
[2025-11-25 00:16:28] +++ CPE_NAME=cpe:/o:centos:centos:7
[2025-11-25 00:16:28] +++ HOME_URL=https://www.centos.org/
[2025-11-25 00:16:28] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2025-11-25 00:16:28] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2025-11-25 00:16:28] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2025-11-25 00:16:28] +++ REDHAT_SUPPORT_PRODUCT=centos
[2025-11-25 00:16:28] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2025-11-25 00:16:28] ++ echo 'CentOS Linux 7 (Core)'
[2025-11-25 00:16:28] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2025-11-25 00:16:28] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2025-11-25 00:16:28] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2025-11-25 00:16:28] + HOME=/tmp/boinchome/slots/2
[2025-11-25 00:16:28] + export HOME
[2025-11-25 00:16:28] + cd /tmp/boinchome/slots/2
[2025-11-25 00:16:28] + '[' '!' -z '' ']'
[2025-11-25 00:16:28] + '[' -z '' ']'
[2025-11-25 00:16:28] ++ /bin/hostname -f
[2025-11-25 00:16:28] + nodename=c-210-35-2.aglt2.org
[2025-11-25 00:16:28] + echo nodename=c-210-35-2.aglt2.org
[2025-11-25 00:16:28] + echo Processors=2
[2025-11-25 00:16:28] + echo Nodecount=1
[2025-11-25 00:16:28] + echo Benchmark=HEPSPEC:1.0
[2025-11-25 00:16:28] + executable=./runpilot2-wrapper.sh
[2025-11-25 00:16:28] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2025-11-25 00:16:28] ++ head -n 1
[2025-11-25 00:16:28] ++ dd if=./runpilot2-wrapper.sh count=1
[2025-11-25 00:16:28] ++ tr -d '\0'
[2025-11-25 00:16:28] + line1='#!/bin/bash'
[2025-11-25 00:16:28] ++ sed -n 's/^#! *//p'
[2025-11-25 00:16:28] ++ echo '#!/bin/bash'
[2025-11-25 00:16:28] + shebang=/bin/bash
[2025-11-25 00:16:28] ++ awk '{print $1}'
[2025-11-25 00:16:28] ++ echo /bin/bash
[2025-11-25 00:16:28] + interpreter=/bin/bash
[2025-11-25 00:16:28] + '[' /bin/bash = /usr/bin/env ']'
[2025-11-25 00:16:28] + '[' x/bin/bash = x ']'
[2025-11-25 00:16:28] + type /bin/bash
[2025-11-25 00:16:28] + '[' xgnutime = xgnutime ']'
[2025-11-25 00:16:28] + /usr/bin/time -o /tmp/boinchome/slots/2/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.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.1.15 -z -t --piloturl local --mute --container
[2025-11-25 00:16:28] + RESULT=2
[2025-11-25 00:16:28] + sed -i -e /nodename=/d /tmp/boinchome/slots/2/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.diag
[2025-11-25 00:16:28] ++ grep domain_name init_data.xml
[2025-11-25 00:16:28] ++ sed -e 's# #_#g'
[2025-11-25 00:16:28] ++ awk -F '>' '{print $2}'
[2025-11-25 00:16:28] ++ awk -F '<' '{print $1}'
[2025-11-25 00:16:28] + hostname=c-210-35-2.aglt2.org
[2025-11-25 00:16:28] ++ grep user_name init_data.xml
[2025-11-25 00:16:28] ++ awk -F '>' '{print $2}'
[2025-11-25 00:16:28] ++ awk -F '<' '{print $1}'
[2025-11-25 00:16:28] ++ sed -e 's# #_#g'
[2025-11-25 00:16:28] + username=AGLT2
[2025-11-25 00:16:28] + nodename=AGLT2@c-210-35-2.aglt2.org
[2025-11-25 00:16:28] + echo nodename=AGLT2@c-210-35-2.aglt2.org
[2025-11-25 00:16:28] + '[' -n 9 ']'
[2025-11-25 00:16:28] + sed -i -e s/Processors=1/Processors=9/ /tmp/boinchome/slots/2/SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.diag
[2025-11-25 00:16:28] + echo exitcode=2
[2025-11-25 00:16:28] + runtimeenvironments=
[2025-11-25 00:16:28] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-11-25 00:16:28] + RTE_function_0 2
[2025-11-25 00:16:28] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-11-25 00:16:28] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-11-25 00:16:28] + export BOINC_APP=ATLAS
[2025-11-25 00:16:28] + BOINC_APP=ATLAS
[2025-11-25 00:16:28] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-11-25 00:16:28] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-11-25 00:16:28] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-11-25 00:16:28] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-11-25 00:16:28] + '[' -z 2 ']'
[2025-11-25 00:16:28] + '[' 2 == 1 ']'
[2025-11-25 00:16:28] + '[' 0 -ne 0 ']'
[2025-11-25 00:16:28] + echo 'zip all output files'
[2025-11-25 00:16:28] + flist='*.diag '
[2025-11-25 00:16:28] + for f in ./heartbeat.json ./output.list ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1 ./gmlog/
[2025-11-25 00:16:28] + '[' -e ./heartbeat.json ']'
[2025-11-25 00:16:28] + flist='*.diag  ./heartbeat.json'
[2025-11-25 00:16:28] + for f in ./heartbeat.json ./output.list ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1 ./gmlog/
[2025-11-25 00:16:28] + '[' -e ./output.list ']'
[2025-11-25 00:16:28] + for f in ./heartbeat.json ./output.list ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1 ./gmlog/
[2025-11-25 00:16:28] + '[' -e ./log.47556137._006747.job.log.1 ']'
[2025-11-25 00:16:28] + flist='*.diag  ./heartbeat.json ./log.47556137._006747.job.log.1'
[2025-11-25 00:16:28] + for f in ./heartbeat.json ./output.list ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1 ./gmlog/
[2025-11-25 00:16:28] + '[' -e ./log.47556137._006747.job.log.1 ']'
[2025-11-25 00:16:28] + flist='*.diag  ./heartbeat.json ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1'
[2025-11-25 00:16:28] + for f in ./heartbeat.json ./output.list ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1 ./gmlog/
[2025-11-25 00:16:28] + '[' -e ./gmlog/ ']'
[2025-11-25 00:16:28] + '[' -f output.list ']'
[2025-11-25 00:16:28] + tar cvf result.tar.gz SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.diag ./heartbeat.json ./log.47556137._006747.job.log.1 ./log.47556137._006747.job.log.1
[2025-11-25 00:16:28] + '[' xgnutime = xcgroup ']'
[2025-11-25 00:16:28] + '[' -n '' ']'
[2025-11-25 00:16:28] + '[' -n '' ']'
[2025-11-25 00:16:28] ++ date +%s
[2025-11-25 00:16:28] + ACCOUNTING_ENDTIME=1764047788
[2025-11-25 00:16:28] ++ date -d '1970-01-01 UTC 1764047530 seconds' +%Y%m%d%H%M%SZ
[2025-11-25 00:16:28] + echo LRMSStartTime=20251125001210Z
[2025-11-25 00:16:28] ++ date -d '1970-01-01 UTC 1764047788 seconds' +%Y%m%d%H%M%SZ
[2025-11-25 00:16:28] + echo LRMSEndTime=20251125001628Z
[2025-11-25 00:16:28] + echo walltime=258
[2025-11-25 00:16:28] + echo exitcode=2
[2025-11-25 00:16:28] + exit 2
[2025-11-25 00:16:28] ./runtime_log
[2025-11-25 00:16:28] ./runtime_log.err
[2025-11-25 00:16:28] ./pilotlog.txt
[2025-11-25 00:16:28] ./PanDA_Pilot-6895355952/pilotlog.txt
[2025-11-25 00:16:28] ./PanDA_Pilot-6895355952/PoolFileCatalog.xml
[2025-11-25 00:16:28] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2025-11-25 00:16:28] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2025-11-25 00:16:28] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2025-11-25 00:16:28] ./pilot3/pilot/util/loggingsupport.py
[2025-11-25 00:16:28] ./pilot3/pilot/util/realtimelogger.py
[2025-11-25 00:16:28] ./pilot3/pilot/util/lokirealtimelogger.py
[2025-11-25 00:16:28] ./log.47556137._006747.job.log.1
00:27:26 (172066): wrapper (7.7.26015): starting
00:27:26 (172066): wrapper: running run_atlas (--nthreads 9)
[2025-11-25 00:27:26] Arguments: --nthreads 9
[2025-11-25 00:27:26] Threads: 9
[2025-11-25 00:27:26] This job has been restarted, cleaning up previous attempt
[2025-11-25 00:27:26] Checking for CVMFS
[2025-11-25 00:27:26] Probing /cvmfs/atlas.cern.ch... OK
[2025-11-25 00:27:26] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-11-25 00:27:26] Running cvmfs_config stat atlas.cern.ch
[2025-11-25 00:27:27] 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
[2025-11-25 00:27:27] 2.13.2.0 6122 33258 370484 153272 3 92 29074093 40960000 13235 16776704 0 66848037 99.594 74240985 40391 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-11-25 00:27:27] CVMFS is ok
[2025-11-25 00:27:27] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-11-25 00:27:27] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-11-25 00:27:27] Further information can be found at the LHC@home message board.
[2025-11-25 00:27:27] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-11-25 00:27:27] Checking for apptainer binary...
[2025-11-25 00:27:27] Using apptainer found in PATH at /usr/bin/apptainer
[2025-11-25 00:27:27] Running /usr/bin/apptainer --version
[2025-11-25 00:27:27] apptainer version 1.4.4-1.el9
[2025-11-25 00:27:27] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-11-25 00:27:28] c-210-35-2.aglt2.org
[2025-11-25 00:27:28] apptainer works
[2025-11-25 00:27:28] Set ATHENA_PROC_NUMBER=9
[2025-11-25 00:27:28] Set ATHENA_CORE_NUMBER=9
[2025-11-25 00:27:28] Starting ATLAS job with PandaID=6895355952
[2025-11-25 00:27:28] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-11-26 09:30:32]  *** The last 200 lines of the pilot log: ***
[2025-11-26 09:30:32] 2025-11-26 14:29:26,138 | INFO     | monitor loop #7529: job 0:6895355952 is in state 'finished'
[2025-11-26 09:30:32] 2025-11-26 14:29:26,138 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2025-11-26 09:30:32] 2025-11-26 14:29:26,464 | INFO     | CPU arch script returned: x86-64-v4
[2025-11-26 09:30:32] 2025-11-26 14:29:26,467 | INFO     | found 28 cores (14 cores per socket, 2 sockets) HT, CPU MHz: 2993.7049999999995
[2025-11-26 09:30:32] 2025-11-26 14:29:26,492 | INFO     | using path: /tmp/boinchome/slots/2/PanDA_Pilot-6895355952/memory_monitor_summary.json (trf name=prmon)
[2025-11-26 09:30:32] 2025-11-26 14:29:26,492 | INFO     | extracted standard info from prmon json
[2025-11-26 09:30:32] 2025-11-26 14:29:26,493 | INFO     | extracted standard memory fields from prmon json
[2025-11-26 09:30:32] 2025-11-26 14:29:26,493 | WARNING  | GPU info not found in prmon json: 'gpu'
[2025-11-26 09:30:32] 2025-11-26 14:29:26,548 | INFO     | fitting pss+swap vs Time
[2025-11-26 09:30:32] 2025-11-26 14:29:26,550 | INFO     | sum of square deviations: 2292127157958.946
[2025-11-26 09:30:32] 2025-11-26 14:29:26,797 | INFO     | sum of deviations: 13430844326805.9
[2025-11-26 09:30:32] 2025-11-26 14:29:26,798 | INFO     | mean x: 1764107932.8639631
[2025-11-26 09:30:32] 2025-11-26 14:29:26,798 | INFO     | mean y: 3003448.8336755647
[2025-11-26 09:30:32] 2025-11-26 14:29:26,798 | INFO     | intersect: -10333883376.885622
[2025-11-26 09:30:32] 2025-11-26 14:29:26,802 | INFO     | chi2: 12.686964618717957
[2025-11-26 09:30:32] 2025-11-26 14:29:26,805 | INFO     | sum of square deviations: 2274524305552.2144
[2025-11-26 09:30:32] 2025-11-26 14:29:26,957 | INFO     | sum of deviations: 14147847282105.889
[2025-11-26 09:30:32] 2025-11-26 14:29:26,957 | INFO     | mean x: 1764107780.3726196
[2025-11-26 09:30:32] 2025-11-26 14:29:26,957 | INFO     | mean y: 3009660.080288214
[2025-11-26 09:30:32] 2025-11-26 14:29:26,957 | INFO     | intersect: -10969978144.429974
[2025-11-26 09:30:32] 2025-11-26 14:29:26,963 | INFO     | chi2: 9.126710543107398
[2025-11-26 09:30:32] 2025-11-26 14:29:26,963 | INFO     | current chi2=9.126710543107398 (change=28.06230002689429 %)
[2025-11-26 09:30:32] 2025-11-26 14:29:26,970 | INFO     | sum of square deviations: 2257011826932.709
[2025-11-26 09:30:32] 2025-11-26 14:29:27,091 | INFO     | sum of deviations: 14925103034946.87
[2025-11-26 09:30:32] 2025-11-26 14:29:27,092 | INFO     | mean x: 1764107627.881321
[2025-11-26 09:30:32] 2025-11-26 14:29:27,092 | INFO     | mean y: 3016428.408152735
[2025-11-26 09:30:32] 2025-11-26 14:29:27,092 | INFO     | intersect: -11662623864.955458
[2025-11-26 09:30:32] 2025-11-26 14:29:27,094 | INFO     | chi2: 5.118429705960778
[2025-11-26 09:30:32] 2025-11-26 14:29:27,094 | INFO     | current chi2=5.118429705960778 (change=43.91813258692336 %)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,101 | INFO     | sum of square deviations: 2239588544562.0967
[2025-11-26 09:30:32] 2025-11-26 14:29:27,329 | INFO     | sum of deviations: 15260437639708.46
[2025-11-26 09:30:32] 2025-11-26 14:29:27,329 | INFO     | mean x: 1764107475.3859286
[2025-11-26 09:30:32] 2025-11-26 14:29:27,329 | INFO     | mean y: 3019363.083807553
[2025-11-26 09:30:32] 2025-11-26 14:29:27,329 | INFO     | intersect: -12017515472.762268
[2025-11-26 09:30:32] 2025-11-26 14:29:27,332 | INFO     | chi2: 4.099155155919751
[2025-11-26 09:30:32] 2025-11-26 14:29:27,332 | INFO     | current chi2=4.099155155919751 (change=19.913813583373198 %)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,332 | INFO     | right removable region: 1932
[2025-11-26 09:30:32] 2025-11-26 14:29:27,338 | INFO     | sum of square deviations: 2274520308222.2114
[2025-11-26 09:30:32] 2025-11-26 14:29:27,346 | INFO     | time since job start (118894s) is within the limit (172800.0s)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,481 | INFO     | sum of deviations: 12753363425732.355
[2025-11-26 09:30:32] 2025-11-26 14:29:27,481 | INFO     | mean x: 1764108085.3726196
[2025-11-26 09:30:32] 2025-11-26 14:29:27,486 | INFO     | mean y: 3009315.4539372106
[2025-11-26 09:30:32] 2025-11-26 14:29:27,486 | INFO     | intersect: -9888444040.095484
[2025-11-26 09:30:32] 2025-11-26 14:29:27,488 | INFO     | chi2: 9.936397563621775
[2025-11-26 09:30:32] 2025-11-26 14:29:27,488 | INFO     | current chi2=9.936397563621775 (change=21.680261100737052 %)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,489 | INFO     | left removable region: 10
[2025-11-26 09:30:32] 2025-11-26 14:29:27,496 | INFO     | sum of square deviations: 2201568268007.6133
[2025-11-26 09:30:32] 2025-11-26 14:29:27,633 | INFO     | sum of deviations: 14315630283747.322
[2025-11-26 09:30:32] 2025-11-26 14:29:27,633 | INFO     | mean x: 1764107749.9021852
[2025-11-26 09:30:32] 2025-11-26 14:29:27,633 | INFO     | mean y: 3028586.2518210197
[2025-11-26 09:30:32] 2025-11-26 14:29:27,633 | INFO     | intersect: -11468028066.989212
[2025-11-26 09:30:32] 2025-11-26 14:29:27,636 | INFO     | chi2: 0.6870652715989408
[2025-11-26 09:30:32] 2025-11-26 14:29:27,641 | INFO     | current memory leak: 6.50 B/s (using 1922 data points, chi2=0.69)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,643 | INFO     | could have reported an average CPU frequency of 2922 MHz (68 samples)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,643 | INFO     | ..............................
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . Timing measurements:
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . get job = 0 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . initial setup = 1 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . payload setup = 20 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . stage-in = 0 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . payload execution = 118806 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . stage-out = 6 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | . log creation = 2 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,644 | INFO     | ..............................
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | 
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | job summary report
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | --------------------------------------------------
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | PanDA job id: 6895355952
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | task id: 47556137
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | errors: (none)
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | status: LOG_TRANSFER = DONE 
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | pilot state: finished 
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | transexitcode: 0
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | exeerrorcode: 0
[2025-11-26 09:30:32] 2025-11-26 14:29:27,981 | INFO     | exeerrordiag: 
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | exitcode: 0
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | exitmsg: OK
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | cpuconsumptiontime: 240139 s
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | nevents: 1000
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | neventsw: 0
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | pid: 234623
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | pgrp: 234623
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | corecount: 9
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | event service: False
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | sizes: {0: 2284082, 1: 2284337, 2: 2284337, 13: 2284655, 23: 2284683, 118831: 2366465, 118837: 2375464, 118840: 2375520, 118861: 2375766}
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | --------------------------------------------------
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | 
[2025-11-26 09:30:32] 2025-11-26 14:29:27,982 | INFO     | executing command: ls -lF /tmp/boinchome/slots/2
[2025-11-26 09:30:32] 2025-11-26 14:29:28,089 | INFO     | queue jobs had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue data_in had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue data_out had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,090 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue completed_jobids has 1 job(s)
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,091 | INFO     | queue messages had 0 job(s) [purged]
[2025-11-26 09:30:32] 2025-11-26 14:29:28,092 | INFO     | job 6895355952 has completed (purged errors)
[2025-11-26 09:30:32] 2025-11-26 14:29:28,092 | INFO     | overall cleanup function is called
[2025-11-26 09:30:32] 2025-11-26 14:29:29,130 | INFO     | --- collectZombieJob: --- 10, [234623]
[2025-11-26 09:30:32] 2025-11-26 14:29:29,130 | INFO     | zombie collector waiting for pid 234623
[2025-11-26 09:30:32] 2025-11-26 14:29:29,130 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-11-26 09:30:32] 2025-11-26 14:29:29,130 | INFO     | collected zombie processes
[2025-11-26 09:30:32] 2025-11-26 14:29:29,130 | INFO     | will attempt to kill all subprocesses of pid=234623
[2025-11-26 09:30:32] 2025-11-26 14:29:29,614 | INFO     | process IDs to be killed: [234623] (in reverse order)
[2025-11-26 09:30:32] 2025-11-26 14:29:29,850 | WARNING  | found no corresponding commands to process id(s)
[2025-11-26 09:30:32] 2025-11-26 14:29:29,851 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-11-26 09:30:32] 2025-11-26 14:29:29,867 | INFO     | did not find any defunct processes belonging to 234623
[2025-11-26 09:30:32] 2025-11-26 14:29:29,877 | INFO     | did not find any defunct processes belonging to 234623
[2025-11-26 09:30:32] 2025-11-26 14:29:29,878 | WARNING  | condor_chirp not found. condor_config_val not found. | If you're on a worker node/container, HTCondor may not expose configs to your env. Try: export CONDOR_CONFIG
[2025-11-26 09:30:32] 2025-11-26 14:29:29,879 | INFO     | ready for new job
[2025-11-26 09:30:32] 2025-11-26 14:29:29,879 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-11-26 09:30:32] 2025-11-26 14:29:29,887 | INFO     | ***************************************
[2025-11-26 09:30:32] 2025-11-26 14:29:29,887 | INFO     | ***  PanDA Pilot version 3.11.1.15  ***
[2025-11-26 09:30:32] 2025-11-26 14:29:29,887 | INFO     | ***************************************
[2025-11-26 09:30:32] 2025-11-26 14:29:29,887 | INFO     | 
[2025-11-26 09:30:32] 2025-11-26 14:29:29,890 | INFO     | architecture information:
[2025-11-26 09:30:32] 2025-11-26 14:29:29,891 | INFO     | executing command: cat /etc/os-release
[2025-11-26 09:30:32] 2025-11-26 14:29:29,941 | INFO     | cat /etc/os-release:
[2025-11-26 09:30:32] NAME="CentOS Linux"
[2025-11-26 09:30:32] VERSION="7 (Core)"
[2025-11-26 09:30:32] ID="centos"
[2025-11-26 09:30:32] ID_LIKE="rhel fedora"
[2025-11-26 09:30:32] VERSION_ID="7"
[2025-11-26 09:30:32] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-11-26 09:30:32] ANSI_COLOR="0;31"
[2025-11-26 09:30:32] CPE_NAME="cpe:/o:centos:centos:7"
[2025-11-26 09:30:32] HOME_URL="https://www.centos.org/"
[2025-11-26 09:30:32] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-11-26 09:30:32] 
[2025-11-26 09:30:32] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-11-26 09:30:32] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-11-26 09:30:32] REDHAT_SUPPORT_PRODUCT="centos"
[2025-11-26 09:30:32] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-11-26 09:30:32] 
[2025-11-26 09:30:32] 2025-11-26 14:29:29,941 | INFO     | ***************************************
[2025-11-26 09:30:32] 2025-11-26 14:29:30,446 | INFO     | executing command: df -mP /tmp/boinchome/slots/2
[2025-11-26 09:30:32] 2025-11-26 14:29:30,522 | INFO     | sufficient remaining disk space (64867008512 B)
[2025-11-26 09:30:32] 2025-11-26 14:29:30,522 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-11-26 09:30:32] 2025-11-26 14:29:30,523 | INFO     | current server update state: UPDATING_FINAL
[2025-11-26 09:30:32] 2025-11-26 14:29:30,523 | INFO     | update_server=False
[2025-11-26 09:30:32] 2025-11-26 14:29:30,523 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-11-26 09:30:32] 2025-11-26 14:29:30,523 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-11-26 09:30:32] 2025-11-26 14:29:30,523 | INFO     | aborting loop
[2025-11-26 09:30:32] 2025-11-26 14:29:30,525 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-11-26 09:30:32] 2025-11-26 14:29:30,871 | INFO     | all job control threads have been joined
[2025-11-26 09:30:32] 2025-11-26 14:29:31,235 | INFO     | all payload control threads have been joined
[2025-11-26 09:30:32] 2025-11-26 14:29:31,529 | INFO     | [job] retrieve thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:31,529 | INFO     | [job] job monitor thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:31,530 | INFO     | [payload] run_realtimelog thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:31,542 | INFO     | all data control threads have been joined
[2025-11-26 09:30:32] 2025-11-26 14:29:31,558 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-11-26 09:30:32] 2025-11-26 14:29:31,593 | INFO     | [job] validate thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:31,878 | INFO     | [job] control thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:31,936 | INFO     | [payload] failed_post thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,122 | INFO     | [data] copytool_in thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,180 | INFO     | [payload] execute_payloads thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,207 | INFO     | [job] create_data_payload thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,242 | INFO     | [payload] control thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,532 | INFO     | [data] copytool_out thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,584 | INFO     | [data] control thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,836 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-11-26 09:30:32] 2025-11-26 14:29:32,852 | INFO     | [payload] validate_post thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:32,929 | INFO     | [payload] validate_pre thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:33,842 | INFO     | [job] queue monitor thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:29:35,577 | INFO     | [data] queue_monitor thread has finished
[2025-11-26 09:30:32] 2025-11-26 14:30:00,834 | INFO     | PID=190626 has CPU usage=2.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 PR
[2025-11-26 09:30:32] 2025-11-26 14:30:00,834 | INFO     | .. there are 20 such processes running
[2025-11-26 09:30:32] 2025-11-26 14:30:00,835 | INFO     | found 0 job(s) in 20 queues
[2025-11-26 09:30:32] 2025-11-26 14:30:00,835 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-11-26 09:30:32] 2025-11-26 14:30:00,835 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-11-26 09:30:32] 2025-11-26 14:30:24,570 | INFO     | [monitor] cgroup control has ended
[2025-11-26 09:30:32] 2025-11-26 14:30:26,347 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140261629306688)>', '<ExcThread(monitor, started 140261361424128)>']
[2025-11-26 09:30:32] 2025-11-26 14:30:27,004 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-11-26 09:30:32] 2025-11-26 14:30:27,004 | INFO     | [monitor] control thread has ended
[2025-11-26 09:30:32] 2025-11-26 14:30:31,372 | INFO     | all workflow threads have been joined
[2025-11-26 09:30:32] 2025-11-26 14:30:31,373 | INFO     | end of generic workflow (traces error code: 0)
[2025-11-26 09:30:32] 2025-11-26 14:30:31,373 | INFO     | traces error code: 0
[2025-11-26 09:30:32] 2025-11-26 14:30:31,373 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-11-26 09:30:32] 2025-11-26 14:30:31,543 [wrapper] ==== pilot stdout END ====
[2025-11-26 09:30:32] 2025-11-26 14:30:31,551 [wrapper] ==== wrapper stdout RESUME ====
[2025-11-26 09:30:32] 2025-11-26 14:30:31,569 [wrapper] pilotpid: 190626
[2025-11-26 09:30:32] 2025-11-26 14:30:31,577 [wrapper] Pilot exit status: 0
[2025-11-26 09:30:32] 2025-11-26 14:30:31,640 [wrapper] pandaids: 6895355952 6895355952 6895355952
[2025-11-26 09:30:32] 2025-11-26 14:30:31,721 [wrapper] cleanup supervisor_pilot  843686 190628
[2025-11-26 09:30:32] 2025-11-26 14:30:31,745 [wrapper] Test setup, not cleaning
[2025-11-26 09:30:32] 2025-11-26 14:30:31,763 [wrapper] apfmon messages muted
[2025-11-26 09:30:32] 2025-11-26 14:30:31,775 [wrapper] ==== wrapper stdout END ====
[2025-11-26 09:30:32] 2025-11-26 14:30:31,791 [wrapper] ==== wrapper stderr END ====
[2025-11-26 09:30:32]  *** Error codes and diagnostics ***
[2025-11-26 09:30:32]     "exeErrorCode": 0,
[2025-11-26 09:30:32]     "exeErrorDiag": "",
[2025-11-26 09:30:32]     "pilotErrorCode": 0,
[2025-11-26 09:30:32]     "pilotErrorDiag": "",
[2025-11-26 09:30:32]  *** Listing of results directory ***
[2025-11-26 09:30:32] total 1741352
[2025-11-26 09:30:32] drwx------. 5 boincer umatlas      4096 Nov  5 12:16 pilot3
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas    576529 Nov 23 04:19 pilot3.tar.gz
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas      5112 Nov 23 04:24 queuedata.json
[2025-11-26 09:30:32] -rwx------. 1 boincer umatlas     36292 Nov 23 04:26 runpilot2-wrapper.sh
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas       100 Nov 24 00:00 wrapper_26015_x86_64-pc-linux-gnu
[2025-11-26 09:30:32] -rwxr-xr-x. 1 boincer umatlas      7986 Nov 24 00:00 run_atlas
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas       105 Nov 24 00:00 job.xml
[2025-11-26 09:30:32] -rw-r--r--. 3 boincer umatlas 409110739 Nov 24 00:00 EVNT.47483658._000679.pool.root.1
[2025-11-26 09:30:32] -rw-r--r--. 3 boincer umatlas 409110739 Nov 24 00:00 ATLAS.root_0
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas     15847 Nov 24 00:00 start_atlas.sh
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas    590103 Nov 24 00:00 input.tar.gz
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas         0 Nov 24 00:00 boinc_lockfile
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas         0 Nov 25 00:13 wrapper_sigint_136144
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas         0 Nov 25 00:16 wrapper_sigkill_136144
[2025-11-26 09:30:32] drwxrwx--x. 2 boincer umatlas      4096 Nov 25 00:16 shared
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas      2785 Nov 25 00:27 pandaJob.out
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas        57 Nov 25 00:27 setup.sh.local
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas    991801 Nov 25 00:27 agis_schedconf.cvmfs.json
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas       533 Nov 26 09:06 boinc_task_state.xml
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas      6843 Nov 26 09:22 init_data.xml
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas 923927484 Nov 26 09:28 HITS.47556137._006747.pool.root.1
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas      1082 Nov 26 09:28 memory_monitor_summary.json
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas   1516240 Nov 26 09:29 agis_ddmendpoints.agis.ALL.json
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas   2986431 Nov 26 09:29 log.47556137._006747.job.log.tgz.1
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas        98 Nov 26 09:29 pilot_heartbeat.json
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas      8635 Nov 26 09:29 heartbeat.json
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas      4823 Nov 26 09:30 pilotlog.txt
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas  15533074 Nov 26 09:30 log.47556137._006747.job.log.1
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas       353 Nov 26 09:30 output.list
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas      8192 Nov 26 09:30 boinc_mmap_file
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas       620 Nov 26 09:30 runtime_log
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas  18544640 Nov 26 09:30 result.tar.gz
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas        29 Nov 26 09:30 wrapper_checkpoint.txt
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas      1397 Nov 26 09:30 SV4MDmwXLh8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmuUIKDmUA1zLn.diag
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas      9439 Nov 26 09:30 runtime_log.err
[2025-11-26 09:30:32] -rw-r--r--. 1 boincer umatlas     39502 Nov 26 09:30 stderr.txt
[2025-11-26 09:30:32] HITS file was successfully produced:
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas 923927484 Nov 26 09:28 shared/HITS.pool.root.1
[2025-11-26 09:30:32]  *** Contents of shared directory: ***
[2025-11-26 09:30:32] total 1320516
[2025-11-26 09:30:32] -rw-r--r--. 3 boincer umatlas 409110739 Nov 24 00:00 ATLAS.root_0
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas     15847 Nov 24 00:00 start_atlas.sh
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas    590103 Nov 24 00:00 input.tar.gz
[2025-11-26 09:30:32] -rw-------. 1 boincer umatlas 923927484 Nov 26 09:28 HITS.pool.root.1
[2025-11-26 09:30:32] -rw-r--r--. 2 boincer umatlas  18544640 Nov 26 09:30 result.tar.gz
09:30:34 (172066): run_atlas exited; CPU time 242405.034331
09:30:34 (172066): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN