Name | 6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn_1 |
Workunit | 232823414 |
Created | 3 Jun 2025, 17:00:39 UTC |
Sent | 3 Jun 2025, 18:01:09 UTC |
Report deadline | 11 Jun 2025, 18:01:09 UTC |
Received | 5 Jun 2025, 10:47:57 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10874990 |
Run time | 51 min 12 sec |
CPU time | 1 days 3 hours 15 min 34 sec |
Validate state | Valid |
Credit | 34.71 |
Device peak FLOPS | 12.00 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.67 GB |
Peak swap size | 31.84 GB |
Peak disk usage | 660.95 MB |
<core_client_version>8.1.0</core_client_version> <![CDATA[ <stderr_txt> 14:01:43 (2771354): wrapper (7.7.26015): starting 14:01:43 (2771354): wrapper: running run_atlas (--nthreads 8) [2025-06-03 14:01:43] Arguments: --nthreads 8 [2025-06-03 14:01:43] Threads: 8 [2025-06-03 14:01:43] Checking for CVMFS [2025-06-03 14:01:43] Probing /cvmfs/atlas.cern.ch... OK [2025-06-03 14:01:44] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-03 14:01:44] Running cvmfs_config stat atlas.cern.ch [2025-06-03 14:01:44] 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-06-03 14:01:44] 2.12.6.0 3235747 90371 599348 146750 2 197 11560920 21042177 3970 16776704 2 240831764 99.288 467119488 25477 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-03 14:01:44] CVMFS is ok [2025-06-03 14:01:44] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-03 14:01:44] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-03 14:01:44] Further information can be found at the LHC@home message board. [2025-06-03 14:01:44] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-03 14:01:44] Checking for apptainer binary... [2025-06-03 14:01:44] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-03 14:01:44] Running /usr/bin/apptainer --version [2025-06-03 14:01:44] apptainer version 1.4.1-1.el9 [2025-06-03 14:01:44] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-06-03 14:01:44] c-16-11.aglt2.org [2025-06-03 14:01:44] apptainer works [2025-06-03 14:01:44] Set ATHENA_PROC_NUMBER=8 [2025-06-03 14:01:44] Set ATHENA_CORE_NUMBER=8 [2025-06-03 14:01:44] Starting ATLAS job with PandaID=6677676764 [2025-06-03 14:01:44] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/4 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh 17:00:12 (2771354): BOINC client no longer exists - exiting 17:00:12 (2771354): timer handler: client dead, exiting 11:36:30 (34524): wrapper (7.7.26015): starting 11:36:30 (34524): wrapper: running run_atlas (--nthreads 8) [2025-06-04 11:36:30] Arguments: --nthreads 8 [2025-06-04 11:36:30] Threads: 8 [2025-06-04 11:36:30] This job has been restarted, cleaning up previous attempt [2025-06-04 11:36:30] Checking for CVMFS [2025-06-04 11:36:30] Probing /cvmfs/atlas.cern.ch... OK [2025-06-04 11:36:30] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-04 11:36:30] Running cvmfs_config stat atlas.cern.ch [2025-06-04 11:36:30] 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-06-04 11:36:30] 2.12.6.0 4059 8 48644 146786 3 187 17980523 21042177 831 16776704 0 49599 99.961 71312 27726 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-04 11:36:30] CVMFS is ok [2025-06-04 11:36:30] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-04 11:36:30] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-04 11:36:30] Further information can be found at the LHC@home message board. [2025-06-04 11:36:30] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-04 11:36:30] Checking for apptainer binary... [2025-06-04 11:36:30] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-04 11:36:30] Running /usr/bin/apptainer --version [2025-06-04 11:36:30] apptainer version 1.4.1-1.el9 [2025-06-04 11:36:30] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-06-04 11:36:31] c-16-11.aglt2.org [2025-06-04 11:36:31] apptainer works [2025-06-04 11:36:31] Set ATHENA_PROC_NUMBER=8 [2025-06-04 11:36:31] Set ATHENA_CORE_NUMBER=8 [2025-06-04 11:36:31] Starting ATLAS job with PandaID=6677676764 [2025-06-04 11:36:31] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/4 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-06-04 11:39:35] Job failed [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/4/ [2025-06-04 11:39:35] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/4/ [2025-06-04 11:39:35] + mv ATLAS.root_0 EVNT.45006593._001481.pool.root.1 [2025-06-04 11:39:35] mv: ‘ATLAS.root_0’ and ‘EVNT.45006593._001481.pool.root.1’ are the same file [2025-06-04 11:39:35] + tar --strip-components=5 -xvf input.tar.gz [2025-06-04 11:39:35] + umask 077 [2025-06-04 11:39:35] ++ date +%s [2025-06-04 11:39:35] + ACCOUNTING_STARTTIME=1749051391 [2025-06-04 11:39:35] + echo 'Detecting resource accounting method available for the job.' [2025-06-04 11:39:35] Detecting resource accounting method available for the job. [2025-06-04 11:39:35] + JOB_ACCOUNTING= [2025-06-04 11:39:35] + command -v arc-job-cgroup [2025-06-04 11:39:35] + '[' -z '' ']' [2025-06-04 11:39:35] + GNU_TIME=/usr/bin/time [2025-06-04 11:39:35] + echo 'Looking for /usr/bin/time tool for accounting measurements' [2025-06-04 11:39:35] Looking for /usr/bin/time tool for accounting measurements [2025-06-04 11:39:35] + '[' '!' -z /usr/bin/time ']' [2025-06-04 11:39:35] + /usr/bin/time --version [2025-06-04 11:39:35] + echo 'GNU time found and will be used for job accounting.' [2025-06-04 11:39:35] GNU time found and will be used for job accounting. [2025-06-04 11:39:35] + JOB_ACCOUNTING=gnutime [2025-06-04 11:39:35] + '[' -z gnutime ']' [2025-06-04 11:39:35] + export PANDA_JSID=harvester-CERN_central_ACTA [2025-06-04 11:39:35] + PANDA_JSID=harvester-CERN_central_ACTA [2025-06-04 11:39:35] + export GTAG=http://aipanda403.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677676764.out [2025-06-04 11:39:35] + GTAG=http://aipanda403.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677676764.out [2025-06-04 11:39:35] + export PILOT_NOKILL=YES [2025-06-04 11:39:35] + PILOT_NOKILL=YES [2025-06-04 11:39:35] + export GRID_GLOBAL_JOBID=6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn [2025-06-04 11:39:35] + GRID_GLOBAL_JOBID=6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn [2025-06-04 11:39:35] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn [2025-06-04 11:39:35] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn [2025-06-04 11:39:35] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-06-04 11:39:35] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-06-04 11:39:35] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-06-04 11:39:35] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/4 [2025-06-04 11:39:35] + RUNTIME_JOB_STDIN=/dev/null [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/4/log.45006595._036854.job.log.1 [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/4/log.45006595._036854.job.log.1 [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/4.diag [2025-06-04 11:39:35] + '[' '!' -z '' ']' [2025-06-04 11:39:35] + RUNTIME_LOCAL_SCRATCH_DIR= [2025-06-04 11:39:35] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv [2025-06-04 11:39:35] + RUNTIME_FRONTEND_SEES_NODE= [2025-06-04 11:39:35] + RUNTIME_NODE_SEES_FRONTEND=yes [2025-06-04 11:39:35] + '[' '!' -z '' ']' [2025-06-04 11:39:35] + '[' -z yes ']' [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/4/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.diag [2025-06-04 11:39:35] + runtimeenvironments= [2025-06-04 11:39:35] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-06-04 11:39:35] + RTE_function_0 1 [2025-06-04 11:39:35] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-04 11:39:35] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-04 11:39:35] + export BOINC_APP=ATLAS [2025-06-04 11:39:35] + BOINC_APP=ATLAS [2025-06-04 11:39:35] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-04 11:39:35] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-04 11:39:35] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-04 11:39:35] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-04 11:39:35] + '[' -z 1 ']' [2025-06-04 11:39:35] + '[' 1 == 1 ']' [2025-06-04 11:39:35] + shift [2025-06-04 11:39:35] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/4/ [2025-06-04 11:39:35] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/4/ [2025-06-04 11:39:35] + '[' 0 -ne 0 ']' [2025-06-04 11:39:35] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;' [2025-06-04 11:39:35] + '[' -f /etc/os-release ']' [2025-06-04 11:39:35] +++ cat /etc/os-release [2025-06-04 11:39:35] ++ 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-06-04 11:39:35] +++ NAME='CentOS Linux' [2025-06-04 11:39:35] +++ VERSION='7 (Core)' [2025-06-04 11:39:35] +++ ID=centos [2025-06-04 11:39:35] +++ ID_LIKE='rhel fedora' [2025-06-04 11:39:35] +++ VERSION_ID=7 [2025-06-04 11:39:35] +++ PRETTY_NAME='CentOS Linux 7 (Core)' [2025-06-04 11:39:35] +++ ANSI_COLOR='0;31' [2025-06-04 11:39:35] +++ CPE_NAME=cpe:/o:centos:centos:7 [2025-06-04 11:39:35] +++ HOME_URL=https://www.centos.org/ [2025-06-04 11:39:35] +++ BUG_REPORT_URL=https://bugs.centos.org/ [2025-06-04 11:39:35] +++ CENTOS_MANTISBT_PROJECT=CentOS-7 [2025-06-04 11:39:35] +++ CENTOS_MANTISBT_PROJECT_VERSION=7 [2025-06-04 11:39:35] +++ REDHAT_SUPPORT_PRODUCT=centos [2025-06-04 11:39:35] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7 [2025-06-04 11:39:35] ++ echo 'CentOS Linux 7 (Core)' [2025-06-04 11:39:35] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)' [2025-06-04 11:39:35] + '[' -n 'CentOS Linux 7 (Core)' ']' [2025-06-04 11:39:35] + echo 'systemsoftware=CentOS Linux 7 (Core)' [2025-06-04 11:39:35] + HOME=/tmp/boinchome/slots/4 [2025-06-04 11:39:35] + export HOME [2025-06-04 11:39:35] + cd /tmp/boinchome/slots/4 [2025-06-04 11:39:35] + '[' '!' -z '' ']' [2025-06-04 11:39:35] + '[' -z '' ']' [2025-06-04 11:39:35] ++ /bin/hostname -f [2025-06-04 11:39:35] + nodename=c-16-11.aglt2.org [2025-06-04 11:39:35] + echo nodename=c-16-11.aglt2.org [2025-06-04 11:39:35] + echo Processors=2 [2025-06-04 11:39:35] + echo Nodecount=1 [2025-06-04 11:39:35] + echo Benchmark=HEPSPEC:1.0 [2025-06-04 11:39:35] + executable=./runpilot2-wrapper.sh [2025-06-04 11:39:35] + '[' '!' -f ./runpilot2-wrapper.sh ']' [2025-06-04 11:39:35] ++ dd if=./runpilot2-wrapper.sh count=1 [2025-06-04 11:39:35] ++ head -n 1 [2025-06-04 11:39:35] ++ tr -d '\0' [2025-06-04 11:39:35] + line1='#!/bin/bash' [2025-06-04 11:39:35] ++ echo '#!/bin/bash' [2025-06-04 11:39:35] ++ sed -n 's/^#! *//p' [2025-06-04 11:39:35] + shebang=/bin/bash [2025-06-04 11:39:35] ++ echo /bin/bash [2025-06-04 11:39:35] ++ awk '{print $1}' [2025-06-04 11:39:35] + interpreter=/bin/bash [2025-06-04 11:39:35] + '[' /bin/bash = /usr/bin/env ']' [2025-06-04 11:39:35] + '[' x/bin/bash = x ']' [2025-06-04 11:39:35] + type /bin/bash [2025-06-04 11:39:35] + '[' xgnutime = xgnutime ']' [2025-06-04 11:39:35] + /usr/bin/time -o /tmp/boinchome/slots/4/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.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.10.2.2 -z -t --piloturl local --mute --container [2025-06-04 11:39:35] + RESULT=2 [2025-06-04 11:39:35] + sed -i -e /nodename=/d /tmp/boinchome/slots/4/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.diag [2025-06-04 11:39:35] ++ grep domain_name init_data.xml [2025-06-04 11:39:35] ++ awk -F '>' '{print $2}' [2025-06-04 11:39:35] ++ awk -F '<' '{print $1}' [2025-06-04 11:39:35] ++ sed -e 's# #_#g' [2025-06-04 11:39:35] + hostname=c-16-11.aglt2.org [2025-06-04 11:39:35] ++ grep user_name init_data.xml [2025-06-04 11:39:35] ++ awk -F '>' '{print $2}' [2025-06-04 11:39:35] ++ awk -F '<' '{print $1}' [2025-06-04 11:39:35] ++ sed -e 's# #_#g' [2025-06-04 11:39:35] + username=AGLT2 [2025-06-04 11:39:35] + nodename=AGLT2@c-16-11.aglt2.org [2025-06-04 11:39:35] + echo nodename=AGLT2@c-16-11.aglt2.org [2025-06-04 11:39:35] + '[' -n 8 ']' [2025-06-04 11:39:35] + sed -i -e s/Processors=1/Processors=8/ /tmp/boinchome/slots/4/6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.diag [2025-06-04 11:39:35] + echo exitcode=2 [2025-06-04 11:39:35] + runtimeenvironments= [2025-06-04 11:39:35] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-06-04 11:39:35] + RTE_function_0 2 [2025-06-04 11:39:35] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-04 11:39:35] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-04 11:39:35] + export BOINC_APP=ATLAS [2025-06-04 11:39:35] + BOINC_APP=ATLAS [2025-06-04 11:39:35] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-04 11:39:35] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-04 11:39:35] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-04 11:39:35] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-04 11:39:35] + '[' -z 2 ']' [2025-06-04 11:39:35] + '[' 2 == 1 ']' [2025-06-04 11:39:35] + '[' 0 -ne 0 ']' [2025-06-04 11:39:35] + echo 'zip all output files' [2025-06-04 11:39:35] + flist='*.diag ' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./heartbeat.json ']' [2025-06-04 11:39:35] + flist='*.diag ./heartbeat.json' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./output.list ']' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./log.45006595._036854.job.log.1 ']' [2025-06-04 11:39:35] + flist='*.diag ./heartbeat.json ./log.45006595._036854.job.log.1' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./log.45006595._036854.job.log.1 ']' [2025-06-04 11:39:35] + flist='*.diag ./heartbeat.json ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./gmlog/ ']' [2025-06-04 11:39:35] + '[' -f output.list ']' [2025-06-04 11:39:35] + tar cvf result.tar.gz 6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.diag ./heartbeat.json ./log.45006595._036854.job.log.1 ./log.45006595._036854.job.log.1 [2025-06-04 11:39:35] + '[' xgnutime = xcgroup ']' [2025-06-04 11:39:35] + '[' -n '' ']' [2025-06-04 11:39:35] + '[' -n '' ']' [2025-06-04 11:39:35] ++ date +%s [2025-06-04 11:39:35] + ACCOUNTING_ENDTIME=1749051575 [2025-06-04 11:39:35] ++ date -d '1970-01-01 UTC 1749051391 seconds' +%Y%m%d%H%M%SZ [2025-06-04 11:39:35] + echo LRMSStartTime=20250604113631Z [2025-06-04 11:39:35] ++ date -d '1970-01-01 UTC 1749051575 seconds' +%Y%m%d%H%M%SZ [2025-06-04 11:39:35] + echo LRMSEndTime=20250604113935Z [2025-06-04 11:39:35] + echo walltime=184 [2025-06-04 11:39:35] + echo exitcode=2 [2025-06-04 11:39:35] + exit 2 [2025-06-04 11:39:35] ./runtime_log [2025-06-04 11:39:35] ./pilotlog.txt [2025-06-04 11:39:35] ./runtime_log.err [2025-06-04 11:39:35] ./pilot3/pilot/util/lokirealtimelogger.py [2025-06-04 11:39:35] ./pilot3/pilot/util/loggingsupport.py [2025-06-04 11:39:35] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc [2025-06-04 11:39:35] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc [2025-06-04 11:39:35] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc [2025-06-04 11:39:35] ./pilot3/pilot/util/realtimelogger.py [2025-06-04 11:39:35] ./PanDA_Pilot-6677676764/log.EVNTtoHITS [2025-06-04 11:39:35] ./PanDA_Pilot-6677676764/prmon.log [2025-06-04 11:39:35] ./PanDA_Pilot-6677676764/pilotlog.txt [2025-06-04 11:39:35] ./PanDA_Pilot-6677676764/PoolFileCatalog.xml [2025-06-04 11:39:35] ./log.45006595._036854.job.log.1 11:49:01 (97662): wrapper (7.7.26015): starting 11:49:01 (97662): wrapper: running run_atlas (--nthreads 8) [2025-06-04 11:49:01] Arguments: --nthreads 8 [2025-06-04 11:49:01] Threads: 8 [2025-06-04 11:49:01] This job has been restarted, cleaning up previous attempt [2025-06-04 11:49:01] Checking for CVMFS [2025-06-04 11:49:01] Probing /cvmfs/atlas.cern.ch... OK [2025-06-04 11:49:02] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-04 11:49:02] Running cvmfs_config stat atlas.cern.ch [2025-06-04 11:49:02] 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-06-04 11:49:02] 2.12.6.0 4059 20 54372 146786 3 187 17984889 21042177 0 16776704 0 197677 99.990 71314 27705 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-04 11:49:02] CVMFS is ok [2025-06-04 11:49:02] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-04 11:49:02] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-04 11:49:02] Further information can be found at the LHC@home message board. [2025-06-04 11:49:02] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-04 11:49:02] Checking for apptainer binary... [2025-06-04 11:49:02] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-04 11:49:02] Running /usr/bin/apptainer --version [2025-06-04 11:49:02] apptainer version 1.4.1-1.el9 [2025-06-04 11:49:02] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-06-04 11:49:02] c-16-11.aglt2.org [2025-06-04 11:49:02] apptainer works [2025-06-04 11:49:02] Set ATHENA_PROC_NUMBER=8 [2025-06-04 11:49:02] Set ATHENA_CORE_NUMBER=8 [2025-06-04 11:49:02] Starting ATLAS job with PandaID=6677676764 [2025-06-04 11:49:02] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/4 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-06-05 06:40:17] *** The last 200 lines of the pilot log: *** [2025-06-05 06:40:17] 2025-06-05 09:26:49,478 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:40:17] 2025-06-05 09:26:51,986 | INFO | monitor loop #2117: job 0:6677676764 is in state 'finished' [2025-06-05 06:40:17] 2025-06-05 09:26:51,986 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:40:17] 2025-06-05 09:26:54,493 | INFO | monitor loop #2118: job 0:6677676764 is in state 'finished' [2025-06-05 06:40:17] 2025-06-05 09:26:54,500 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:40:17] 2025-06-05 09:26:55,914 | INFO | CPU arch script returned: x86-64-v2 [2025-06-05 06:40:17] 2025-06-05 09:26:55,915 | INFO | using path: /tmp/boinchome/slots/4/PanDA_Pilot-6677676764/memory_monitor_summary.json (trf name=prmon) [2025-06-05 06:40:17] 2025-06-05 09:26:55,916 | INFO | extracted standard info from prmon json [2025-06-05 06:40:17] 2025-06-05 09:26:55,916 | INFO | extracted standard memory fields from prmon json [2025-06-05 06:40:17] 2025-06-05 09:26:55,916 | WARNING | GPU info not found in prmon json: 'gpu' [2025-06-05 06:40:17] 2025-06-05 09:26:55,917 | WARNING | format EVNTtoHITS has no such key: dbData [2025-06-05 06:40:17] 2025-06-05 09:26:55,917 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-06-05 06:40:17] 2025-06-05 09:26:56,266 | INFO | fitting pss+swap vs Time [2025-06-05 06:40:17] 2025-06-05 09:26:56,268 | INFO | sum of square deviations: 347799119842.4387 [2025-06-05 06:40:17] 2025-06-05 09:26:56,414 | INFO | sum of deviations: 15757040531.011513 [2025-06-05 06:40:17] 2025-06-05 09:26:56,433 | INFO | mean x: 1749083851.1183832 [2025-06-05 06:40:17] 2025-06-05 09:26:56,433 | INFO | mean y: 2067799.292589028 [2025-06-05 06:40:17] 2025-06-05 09:26:56,433 | INFO | -- intersect: -77174451.6558768 [2025-06-05 06:40:17] 2025-06-05 09:26:56,433 | INFO | intersect: -77174451.6558768 [2025-06-05 06:40:17] 2025-06-05 09:26:56,435 | INFO | chi2: 3.1351030782390867 [2025-06-05 06:40:17] 2025-06-05 09:26:56,453 | INFO | sum of square deviations: 342802478228.655 [2025-06-05 06:40:17] 2025-06-05 09:26:56,690 | INFO | sum of deviations: 92095434605.43715 [2025-06-05 06:40:17] 2025-06-05 09:26:56,690 | INFO | mean x: 1749083698.6237912 [2025-06-05 06:40:17] 2025-06-05 09:26:56,690 | INFO | mean y: 2070123.9497098646 [2025-06-05 06:40:17] 2025-06-05 09:26:56,690 | INFO | -- intersect: -467829114.289165 [2025-06-05 06:40:17] 2025-06-05 09:26:56,691 | INFO | intersect: -467829114.289165 [2025-06-05 06:40:17] 2025-06-05 09:26:56,692 | INFO | chi2: 2.42948583886208 [2025-06-05 06:40:17] 2025-06-05 09:26:56,692 | INFO | current chi2=2.42948583886208 (change=22.506986908173218 %) [2025-06-05 06:40:17] 2025-06-05 09:26:56,692 | INFO | right removable region: 1033 [2025-06-05 06:40:17] 2025-06-05 09:26:56,706 | INFO | sum of square deviations: 342801769408.6551 [2025-06-05 06:40:17] 2025-06-05 09:26:56,823 | INFO | sum of deviations: -112026253825.78629 [2025-06-05 06:40:17] 2025-06-05 09:26:56,823 | INFO | mean x: 1749084003.6237912 [2025-06-05 06:40:17] 2025-06-05 09:26:56,823 | INFO | mean y: 2071689.4709864603 [2025-06-05 06:40:17] 2025-06-05 09:26:56,824 | INFO | -- intersect: 573665380.1645623 [2025-06-05 06:40:17] 2025-06-05 09:26:56,824 | INFO | intersect: 573665380.1645623 [2025-06-05 06:40:17] 2025-06-05 09:26:56,834 | INFO | chi2: 1.7262389552854351 [2025-06-05 06:40:17] 2025-06-05 09:26:56,834 | INFO | current chi2=1.7262389552854351 (change=44.93836686687116 %) [2025-06-05 06:40:17] 2025-06-05 09:26:56,836 | INFO | sum of square deviations: 337852512899.8095 [2025-06-05 06:40:17] 2025-06-05 09:26:56,949 | INFO | sum of deviations: -90517619620.16324 [2025-06-05 06:40:17] 2025-06-05 09:26:57,029 | INFO | mean x: 1749084156.1292517 [2025-06-05 06:40:17] 2025-06-05 09:26:57,029 | INFO | mean y: 2071026.4373177842 [2025-06-05 06:40:17] 2025-06-05 09:26:57,029 | INFO | -- intersect: 470686556.24133205 [2025-06-05 06:40:17] 2025-06-05 09:26:57,029 | INFO | intersect: 470686556.24133205 [2025-06-05 06:40:17] 2025-06-05 09:26:57,147 | INFO | monitor loop #2119: job 0:6677676764 is in state 'finished' [2025-06-05 06:40:17] 2025-06-05 09:26:57,148 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:40:17] 2025-06-05 09:26:57,166 | INFO | chi2: 1.7058935945733844 [2025-06-05 06:40:17] 2025-06-05 09:26:57,166 | INFO | current chi2=1.7058935945733844 (change=1.1785946928006041 %) [2025-06-05 06:40:17] 2025-06-05 09:26:57,167 | INFO | left removable region: 20 [2025-06-05 06:40:17] 2025-06-05 09:26:57,168 | INFO | sum of square deviations: 322336224943.084 [2025-06-05 06:40:17] 2025-06-05 09:26:57,429 | INFO | sum of deviations: 65282524373.349365 [2025-06-05 06:40:17] 2025-06-05 09:26:57,430 | INFO | mean x: 1749084278.1470878 [2025-06-05 06:40:17] 2025-06-05 09:26:57,430 | INFO | mean y: 2072162.1184600198 [2025-06-05 06:40:17] 2025-06-05 09:26:57,430 | INFO | -- intersect: -352168621.831099 [2025-06-05 06:40:17] 2025-06-05 09:26:57,431 | INFO | intersect: -352168621.831099 [2025-06-05 06:40:17] 2025-06-05 09:26:57,437 | INFO | chi2: 0.8092369149272799 [2025-06-05 06:40:17] 2025-06-05 09:26:57,438 | INFO | -- intersect: -352168621.831099 [2025-06-05 06:40:17] 2025-06-05 09:26:57,438 | INFO | current memory leak: 0.20 B/s (using 1013 data points, chi2=0.81) [2025-06-05 06:40:17] 2025-06-05 09:26:57,440 | INFO | .............................. [2025-06-05 06:40:17] 2025-06-05 09:26:57,440 | INFO | . Timing measurements: [2025-06-05 06:40:17] 2025-06-05 09:26:57,441 | INFO | . get job = 0 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,441 | INFO | . initial setup = 1 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,441 | INFO | . payload setup = 10 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,441 | INFO | . stage-in = 0 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,445 | INFO | . payload execution = 63368 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,446 | INFO | . stage-out = 17 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,446 | INFO | . log creation = 1 s [2025-06-05 06:40:17] 2025-06-05 09:26:57,446 | INFO | .............................. [2025-06-05 06:40:17] 2025-06-05 09:26:58,716 | INFO | [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | job summary report [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | -------------------------------------------------- [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | PanDA job id: 6677676764 [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | task id: 45006595 [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | errors: (none) [2025-06-05 06:40:17] 2025-06-05 09:26:58,717 | INFO | status: LOG_TRANSFER = DONE [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | pilot state: finished [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | transexitcode: 0 [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | exeerrorcode: 0 [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | exeerrordiag: [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | exitcode: 0 [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | exitmsg: OK [2025-06-05 06:40:17] 2025-06-05 09:26:58,718 | INFO | cpuconsumptiontime: 67629 s [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | nevents: 400 [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | neventsw: 0 [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | pid: 138707 [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | pgrp: 138707 [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | corecount: 8 [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | event service: False [2025-06-05 06:40:17] 2025-06-05 09:26:58,719 | INFO | sizes: {0: 2397169, 1: 2397368, 7: 2397574, 12: 2397602, 63383: 2444759, 63384: 2444758, 63402: 2453939, 63445: 2454053} [2025-06-05 06:40:17] 2025-06-05 09:26:58,720 | INFO | -------------------------------------------------- [2025-06-05 06:40:17] 2025-06-05 09:26:58,720 | INFO | [2025-06-05 06:40:17] 2025-06-05 09:26:58,720 | INFO | executing command: ls -lF /tmp/boinchome/slots/4 [2025-06-05 06:40:17] 2025-06-05 09:26:58,837 | INFO | queue jobs had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue data_in had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue data_out had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue current_data_in had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,838 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,846 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,847 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,848 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,848 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,848 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,848 | INFO | queue completed_jobids has 1 job(s) [2025-06-05 06:40:17] 2025-06-05 09:26:58,848 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,853 | INFO | queue messages had 0 job(s) [purged] [2025-06-05 06:40:17] 2025-06-05 09:26:58,854 | INFO | job 6677676764 has completed (purged errors) [2025-06-05 06:40:17] 2025-06-05 09:26:58,854 | INFO | overall cleanup function is called [2025-06-05 06:40:17] 2025-06-05 09:26:59,876 | INFO | --- collectZombieJob: --- 10, [138707] [2025-06-05 06:40:17] 2025-06-05 09:26:59,877 | INFO | zombie collector waiting for pid 138707 [2025-06-05 06:40:17] 2025-06-05 09:26:59,877 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-06-05 06:40:17] 2025-06-05 09:26:59,877 | INFO | collected zombie processes [2025-06-05 06:40:17] 2025-06-05 09:26:59,877 | INFO | will attempt to kill all subprocesses of pid=138707 [2025-06-05 06:40:17] 2025-06-05 09:27:01,423 | INFO | process IDs to be killed: [138707] (in reverse order) [2025-06-05 06:40:17] 2025-06-05 09:27:01,621 | WARNING | found no corresponding commands to process id(s) [2025-06-05 06:40:17] 2025-06-05 09:27:01,621 | INFO | Do not look for orphan processes in BOINC jobs [2025-06-05 06:40:17] 2025-06-05 09:27:01,648 | INFO | did not find any defunct processes belonging to 138707 [2025-06-05 06:40:17] 2025-06-05 09:27:01,669 | INFO | did not find any defunct processes belonging to 138707 [2025-06-05 06:40:17] 2025-06-05 09:27:01,670 | INFO | ready for new job [2025-06-05 06:40:17] 2025-06-05 09:27:01,670 | INFO | pilot has finished with previous job - re-establishing logging [2025-06-05 06:40:17] 2025-06-05 09:27:01,673 | INFO | ************************************** [2025-06-05 06:40:17] 2025-06-05 09:27:01,674 | INFO | *** PanDA Pilot version 3.10.2.2 *** [2025-06-05 06:40:17] 2025-06-05 09:27:01,674 | INFO | ************************************** [2025-06-05 06:40:17] 2025-06-05 09:27:01,674 | INFO | [2025-06-05 06:40:17] 2025-06-05 09:27:01,677 | INFO | architecture information: [2025-06-05 06:40:17] 2025-06-05 09:27:01,677 | INFO | executing command: cat /etc/os-release [2025-06-05 06:40:17] 2025-06-05 09:27:01,709 | INFO | cat /etc/os-release: [2025-06-05 06:40:17] NAME="CentOS Linux" [2025-06-05 06:40:17] VERSION="7 (Core)" [2025-06-05 06:40:17] ID="centos" [2025-06-05 06:40:17] ID_LIKE="rhel fedora" [2025-06-05 06:40:17] VERSION_ID="7" [2025-06-05 06:40:17] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-06-05 06:40:17] ANSI_COLOR="0;31" [2025-06-05 06:40:17] CPE_NAME="cpe:/o:centos:centos:7" [2025-06-05 06:40:17] HOME_URL="https://www.centos.org/" [2025-06-05 06:40:17] BUG_REPORT_URL="https://bugs.centos.org/" [2025-06-05 06:40:17] [2025-06-05 06:40:17] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-06-05 06:40:17] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-06-05 06:40:17] REDHAT_SUPPORT_PRODUCT="centos" [2025-06-05 06:40:17] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-06-05 06:40:17] [2025-06-05 06:40:17] 2025-06-05 09:27:01,709 | INFO | ************************************** [2025-06-05 06:40:17] 2025-06-05 09:27:02,213 | INFO | executing command: df -mP /tmp/boinchome/slots/4 [2025-06-05 06:40:17] 2025-06-05 09:27:02,290 | INFO | sufficient remaining disk space (52095352832 B) [2025-06-05 06:40:17] 2025-06-05 09:27:02,291 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-06-05 06:40:17] 2025-06-05 09:27:02,291 | INFO | current server update state: UPDATING_FINAL [2025-06-05 06:40:17] 2025-06-05 09:27:02,291 | INFO | update_server=False [2025-06-05 06:40:17] 2025-06-05 09:27:02,291 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-06-05 06:40:17] 2025-06-05 09:27:02,292 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-06-05 06:40:17] 2025-06-05 09:27:02,292 | WARNING | aborting monitor loop since graceful_stop has been set (timing out remaining threads) [2025-06-05 06:40:17] 2025-06-05 09:27:02,292 | INFO | found 0 job(s) in 20 queues [2025-06-05 06:40:17] 2025-06-05 09:27:02,292 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-06-05 06:40:17] 2025-06-05 09:27:02,293 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-06-05 06:40:17] 2025-06-05 09:27:02,983 | INFO | all data control threads have been joined [2025-06-05 06:40:17] 2025-06-05 09:27:03,213 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-06-05 06:40:17] 2025-06-05 09:27:03,214 | INFO | aborting loop [2025-06-05 06:40:17] 2025-06-05 09:27:03,280 | INFO | all payload control threads have been joined [2025-06-05 06:40:17] 2025-06-05 09:27:03,299 | INFO | [payload] run_realtimelog thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:03,318 | INFO | [job] retrieve thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:03,346 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-06-05 06:40:17] 2025-06-05 09:27:03,364 | INFO | [payload] validate_pre thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:03,698 | INFO | [payload] validate_post thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:03,726 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-06-05 06:40:17] 2025-06-05 09:27:03,773 | INFO | [payload] execute_payloads thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:03,886 | INFO | all job control threads have been joined [2025-06-05 06:40:17] 2025-06-05 09:27:03,989 | INFO | [data] control thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,083 | INFO | [data] copytool_in thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,097 | INFO | [job] create_data_payload thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,219 | INFO | [job] job monitor thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,283 | INFO | [job] validate thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,286 | INFO | [payload] control thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,324 | INFO | [data] copytool_out thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,482 | INFO | [payload] failed_post thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,733 | INFO | [job] queue monitor thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:04,892 | INFO | [job] control thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:07,355 | INFO | [data] queue_monitor thread has finished [2025-06-05 06:40:17] 2025-06-05 09:27:09,096 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139706788472640)>', '<ExcThread(monitor, started 139706008327936)>'] [2025-06-05 06:40:17] 2025-06-05 09:27:09,385 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-06-05 06:40:17] 2025-06-05 09:27:09,386 | INFO | [monitor] control thread has ended [2025-06-05 06:40:17] 2025-06-05 09:27:14,123 | INFO | all workflow threads have been joined [2025-06-05 06:40:17] 2025-06-05 09:27:14,124 | INFO | end of generic workflow (traces error code: 0) [2025-06-05 06:40:17] 2025-06-05 09:27:14,125 | INFO | traces error code: 0 [2025-06-05 06:40:17] 2025-06-05 09:27:14,125 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-06-05 06:40:17] 2025-06-05 09:27:14,710 [wrapper] ==== pilot stdout END ==== [2025-06-05 06:40:17] 2025-06-05 09:27:14,730 [wrapper] ==== wrapper stdout RESUME ==== [2025-06-05 06:40:17] 2025-06-05 09:27:14,762 [wrapper] pilotpid: 112435 [2025-06-05 06:40:17] 2025-06-05 09:27:14,773 [wrapper] Pilot exit status: 0 [2025-06-05 06:40:17] 2025-06-05 09:27:14,876 [wrapper] pandaids: 6677676764 6677676764 6677676764 [2025-06-05 06:40:17] 2025-06-05 09:27:15,099 [wrapper] cleanup supervisor_pilot 822642 112437 [2025-06-05 06:40:17] 2025-06-05 09:27:15,107 [wrapper] Test setup, not cleaning [2025-06-05 06:40:17] 2025-06-05 09:27:15,111 [wrapper] apfmon messages muted [2025-06-05 06:40:17] 2025-06-05 09:27:15,142 [wrapper] ==== wrapper stdout END ==== [2025-06-05 06:40:17] 2025-06-05 09:27:15,164 [wrapper] ==== wrapper stderr END ==== [2025-06-05 06:40:17] *** Error codes and diagnostics *** [2025-06-05 06:40:17] "exeErrorCode": 0, [2025-06-05 06:40:17] "exeErrorDiag": "", [2025-06-05 06:40:17] "pilotErrorCode": 0, [2025-06-05 06:40:17] "pilotErrorDiag": "", [2025-06-05 06:40:17] *** Listing of results directory *** [2025-06-05 06:40:17] total 609432 [2025-06-05 06:40:17] drwx------. 4 boincer umatlas 4096 Apr 3 04:00 pilot3 [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 495897 Jun 3 11:19 pilot3.tar.gz [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 5111 Jun 3 11:29 queuedata.json [2025-06-05 06:40:17] -rwx------. 1 boincer umatlas 37140 Jun 3 11:30 runpilot2-wrapper.sh [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 100 Jun 3 14:01 wrapper_26015_x86_64-pc-linux-gnu [2025-06-05 06:40:17] -rwxr-xr-x. 1 boincer umatlas 7986 Jun 3 14:01 run_atlas [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 105 Jun 3 14:01 job.xml [2025-06-05 06:40:17] -rw-r--r--. 3 boincer umatlas 216430167 Jun 3 14:01 EVNT.45006593._001481.pool.root.1 [2025-06-05 06:40:17] -rw-r--r--. 3 boincer umatlas 216430167 Jun 3 14:01 ATLAS.root_0 [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 14:01 start_atlas.sh [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 508881 Jun 3 14:01 input.tar.gz [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 0 Jun 3 14:01 boinc_lockfile [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 0 Jun 4 11:36 wrapper_sigint_44545 [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 0 Jun 4 11:39 wrapper_sigkill_44545 [2025-06-05 06:40:17] drwxrwx--x. 2 boincer umatlas 4096 Jun 4 11:39 shared [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 2524 Jun 4 11:49 pandaJob.out [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 990989 Jun 4 11:49 agis_schedconf.cvmfs.json [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 179330663 Jun 5 05:24 HITS.45006595._036854.pool.root.1 [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 530 Jun 5 05:25 boinc_task_state.xml [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 1046 Jun 5 05:25 memory_monitor_summary.json [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 1598969 Jun 5 05:26 agis_ddmendpoints.agis.ALL.json [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 665081 Jun 5 05:26 log.45006595._036854.job.log.tgz.1 [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 98 Jun 5 05:26 pilot_heartbeat.json [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 7727 Jun 5 05:26 heartbeat.json [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 4476 Jun 5 05:27 pilotlog.txt [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 3337722 Jun 5 05:27 log.45006595._036854.job.log.1 [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 357 Jun 5 05:27 output.list [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 620 Jun 5 05:27 runtime_log [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 4024320 Jun 5 05:27 result.tar.gz [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 8740 Jun 5 05:27 runtime_log.err [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 1389 Jun 5 05:27 6g6LDmUmig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm1nkKDm5lLJOn.diag [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 6520 Jun 5 06:37 init_data.xml [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 27 Jun 5 06:39 wrapper_checkpoint.txt [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 8192 Jun 5 06:40 boinc_mmap_file [2025-06-05 06:40:17] -rw-r--r--. 1 boincer umatlas 38549 Jun 5 06:40 stderr.txt [2025-06-05 06:40:17] HITS file was successfully produced: [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 179330663 Jun 5 05:24 shared/HITS.pool.root.1 [2025-06-05 06:40:17] *** Contents of shared directory: *** [2025-06-05 06:40:17] total 390944 [2025-06-05 06:40:17] -rw-r--r--. 3 boincer umatlas 216430167 Jun 3 14:01 ATLAS.root_0 [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 14:01 start_atlas.sh [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 508881 Jun 3 14:01 input.tar.gz [2025-06-05 06:40:17] -rw-------. 1 boincer umatlas 179330663 Jun 5 05:24 HITS.pool.root.1 [2025-06-05 06:40:17] -rw-r--r--. 2 boincer umatlas 4024320 Jun 5 05:27 result.tar.gz 06:40:19 (97662): run_atlas exited; CPU time 70203.148355 06:40:19 (97662): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN