Name | GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn_1 |
Workunit | 232821153 |
Created | 3 Jun 2025, 15:39:31 UTC |
Sent | 3 Jun 2025, 16:42:55 UTC |
Report deadline | 11 Jun 2025, 16:42:55 UTC |
Received | 6 Jun 2025, 7:36:52 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10875047 |
Run time | 5 hours 33 min 40 sec |
CPU time | 1 days 11 hours 2 min 19 sec |
Validate state | Valid |
Credit | 311.67 |
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.77 GB |
Peak disk usage | 968.98 MB |
<core_client_version>8.1.0</core_client_version> <![CDATA[ <stderr_txt> 12:43:29 (424718): wrapper (7.7.26015): starting 12:43:29 (424718): wrapper: running run_atlas (--nthreads 8) [2025-06-03 12:43:29] Arguments: --nthreads 8 [2025-06-03 12:43:29] Threads: 8 [2025-06-03 12:43:29] Checking for CVMFS [2025-06-03 12:43:29] Probing /cvmfs/atlas.cern.ch... OK [2025-06-03 12:43:29] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-03 12:43:29] Running cvmfs_config stat atlas.cern.ch [2025-06-03 12:43: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-03 12:43:30] 2.12.6.0 2097083 99818 848928 146749 0 194 19899077 21042177 3039 130560 3 167490265 99.315 304980111 23293 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-03 12:43:30] CVMFS is ok [2025-06-03 12:43:30] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-03 12:43:30] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-03 12:43:30] Further information can be found at the LHC@home message board. [2025-06-03 12:43:30] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-03 12:43:30] Checking for apptainer binary... [2025-06-03 12:43:30] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-03 12:43:30] Running /usr/bin/apptainer --version [2025-06-03 12:43:30] apptainer version 1.4.1-1.el9 [2025-06-03 12:43: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-03 12:43:30] c-16-16.aglt2.org [2025-06-03 12:43:30] apptainer works [2025-06-03 12:43:30] Set ATHENA_PROC_NUMBER=8 [2025-06-03 12:43:30] Set ATHENA_CORE_NUMBER=8 [2025-06-03 12:43:30] Starting ATLAS job with PandaID=6677658130 [2025-06-03 12:43:30] 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 23:49:43 (543392): wrapper (7.7.26015): starting 23:49:43 (543392): wrapper: running run_atlas (--nthreads 10) [2025-06-05 23:49:43] Arguments: --nthreads 10 [2025-06-05 23:49:43] Threads: 10 [2025-06-05 23:49:43] This job has been restarted, cleaning up previous attempt [2025-06-05 23:49:43] Checking for CVMFS [2025-06-05 23:49:43] Probing /cvmfs/atlas.cern.ch... OK [2025-06-05 23:49:43] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-05 23:49:43] Running cvmfs_config stat atlas.cern.ch [2025-06-05 23:49: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-05 23:49:44] 2.12.6.0 3989 314 98632 146842 1 263 14848225 21042177 7532 16776704 0 428976 95.541 3431720 45596 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-05 23:49:44] CVMFS is ok [2025-06-05 23:49:44] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-05 23:49:44] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-05 23:49:44] Further information can be found at the LHC@home message board. [2025-06-05 23:49:44] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-05 23:49:44] Checking for apptainer binary... [2025-06-05 23:49:44] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-05 23:49:44] Running /usr/bin/apptainer --version [2025-06-05 23:49:44] apptainer version 1.4.1-1.el9 [2025-06-05 23:49: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-05 23:49:44] c-16-16.aglt2.org [2025-06-05 23:49:44] apptainer works [2025-06-05 23:49:44] Set ATHENA_PROC_NUMBER=10 [2025-06-05 23:49:44] Set ATHENA_CORE_NUMBER=10 [2025-06-05 23:49:44] Starting ATLAS job with PandaID=6677658130 [2025-06-05 23:49: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 [2025-06-05 23:52:51] Job failed [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/4/ [2025-06-05 23:52:51] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/4/ [2025-06-05 23:52:51] + mv ATLAS.root_0 EVNT.45006593._001404.pool.root.1 [2025-06-05 23:52:51] mv: ‘ATLAS.root_0’ and ‘EVNT.45006593._001404.pool.root.1’ are the same file [2025-06-05 23:52:51] + tar --strip-components=5 -xvf input.tar.gz [2025-06-05 23:52:51] + umask 077 [2025-06-05 23:52:51] ++ date +%s [2025-06-05 23:52:51] + ACCOUNTING_STARTTIME=1749181784 [2025-06-05 23:52:51] + echo 'Detecting resource accounting method available for the job.' [2025-06-05 23:52:51] Detecting resource accounting method available for the job. [2025-06-05 23:52:51] + JOB_ACCOUNTING= [2025-06-05 23:52:51] + command -v arc-job-cgroup [2025-06-05 23:52:51] + '[' -z '' ']' [2025-06-05 23:52:51] + GNU_TIME=/usr/bin/time [2025-06-05 23:52:51] + echo 'Looking for /usr/bin/time tool for accounting measurements' [2025-06-05 23:52:51] Looking for /usr/bin/time tool for accounting measurements [2025-06-05 23:52:51] + '[' '!' -z /usr/bin/time ']' [2025-06-05 23:52:51] + /usr/bin/time --version [2025-06-05 23:52:51] + echo 'GNU time found and will be used for job accounting.' [2025-06-05 23:52:51] GNU time found and will be used for job accounting. [2025-06-05 23:52:51] + JOB_ACCOUNTING=gnutime [2025-06-05 23:52:51] + '[' -z gnutime ']' [2025-06-05 23:52:51] + export PANDA_JSID=harvester-CERN_central_ACTA [2025-06-05 23:52:51] + PANDA_JSID=harvester-CERN_central_ACTA [2025-06-05 23:52:51] + export GTAG=http://aipanda404.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677658130.out [2025-06-05 23:52:51] + GTAG=http://aipanda404.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677658130.out [2025-06-05 23:52:51] + export PILOT_NOKILL=YES [2025-06-05 23:52:51] + PILOT_NOKILL=YES [2025-06-05 23:52:51] + export GRID_GLOBAL_JOBID=GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn [2025-06-05 23:52:51] + GRID_GLOBAL_JOBID=GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn [2025-06-05 23:52:51] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn [2025-06-05 23:52:51] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn [2025-06-05 23:52:51] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-06-05 23:52:51] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-06-05 23:52:51] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-06-05 23:52:51] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/4 [2025-06-05 23:52:51] + RUNTIME_JOB_STDIN=/dev/null [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/4/log.45006595._034928.job.log.1 [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/4/log.45006595._034928.job.log.1 [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/4.diag [2025-06-05 23:52:51] + '[' '!' -z '' ']' [2025-06-05 23:52:51] + RUNTIME_LOCAL_SCRATCH_DIR= [2025-06-05 23:52:51] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv [2025-06-05 23:52:51] + RUNTIME_FRONTEND_SEES_NODE= [2025-06-05 23:52:51] + RUNTIME_NODE_SEES_FRONTEND=yes [2025-06-05 23:52:51] + '[' '!' -z '' ']' [2025-06-05 23:52:51] + '[' -z yes ']' [2025-06-05 23:52:51] ++ pwd [2025-06-05 23:52:51] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/4/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.diag [2025-06-05 23:52:51] + runtimeenvironments= [2025-06-05 23:52:51] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-06-05 23:52:51] + RTE_function_0 1 [2025-06-05 23:52:51] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-05 23:52:51] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-05 23:52:51] + export BOINC_APP=ATLAS [2025-06-05 23:52:51] + BOINC_APP=ATLAS [2025-06-05 23:52:51] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-05 23:52:51] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-05 23:52:51] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-05 23:52:51] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-05 23:52:51] + '[' -z 1 ']' [2025-06-05 23:52:51] + '[' 1 == 1 ']' [2025-06-05 23:52:51] + shift [2025-06-05 23:52:51] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/4/ [2025-06-05 23:52:51] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/4/ [2025-06-05 23:52:51] + '[' 0 -ne 0 ']' [2025-06-05 23:52:51] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;' [2025-06-05 23:52:51] + '[' -f /etc/os-release ']' [2025-06-05 23:52:51] +++ cat /etc/os-release [2025-06-05 23:52:51] ++ 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-05 23:52:51] +++ NAME='CentOS Linux' [2025-06-05 23:52:51] +++ VERSION='7 (Core)' [2025-06-05 23:52:51] +++ ID=centos [2025-06-05 23:52:51] +++ ID_LIKE='rhel fedora' [2025-06-05 23:52:51] +++ VERSION_ID=7 [2025-06-05 23:52:51] +++ PRETTY_NAME='CentOS Linux 7 (Core)' [2025-06-05 23:52:51] +++ ANSI_COLOR='0;31' [2025-06-05 23:52:51] +++ CPE_NAME=cpe:/o:centos:centos:7 [2025-06-05 23:52:51] +++ HOME_URL=https://www.centos.org/ [2025-06-05 23:52:51] +++ BUG_REPORT_URL=https://bugs.centos.org/ [2025-06-05 23:52:51] +++ CENTOS_MANTISBT_PROJECT=CentOS-7 [2025-06-05 23:52:51] +++ CENTOS_MANTISBT_PROJECT_VERSION=7 [2025-06-05 23:52:51] +++ REDHAT_SUPPORT_PRODUCT=centos [2025-06-05 23:52:51] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7 [2025-06-05 23:52:51] ++ echo 'CentOS Linux 7 (Core)' [2025-06-05 23:52:51] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)' [2025-06-05 23:52:51] + '[' -n 'CentOS Linux 7 (Core)' ']' [2025-06-05 23:52:51] + echo 'systemsoftware=CentOS Linux 7 (Core)' [2025-06-05 23:52:51] + HOME=/tmp/boinchome/slots/4 [2025-06-05 23:52:51] + export HOME [2025-06-05 23:52:51] + cd /tmp/boinchome/slots/4 [2025-06-05 23:52:51] + '[' '!' -z '' ']' [2025-06-05 23:52:51] + '[' -z '' ']' [2025-06-05 23:52:51] ++ /bin/hostname -f [2025-06-05 23:52:51] + nodename=c-16-16.aglt2.org [2025-06-05 23:52:51] + echo nodename=c-16-16.aglt2.org [2025-06-05 23:52:51] + echo Processors=2 [2025-06-05 23:52:51] + echo Nodecount=1 [2025-06-05 23:52:51] + echo Benchmark=HEPSPEC:1.0 [2025-06-05 23:52:51] + executable=./runpilot2-wrapper.sh [2025-06-05 23:52:51] + '[' '!' -f ./runpilot2-wrapper.sh ']' [2025-06-05 23:52:51] ++ dd if=./runpilot2-wrapper.sh count=1 [2025-06-05 23:52:51] ++ head -n 1 [2025-06-05 23:52:51] ++ tr -d '\0' [2025-06-05 23:52:51] + line1='#!/bin/bash' [2025-06-05 23:52:51] ++ echo '#!/bin/bash' [2025-06-05 23:52:51] ++ sed -n 's/^#! *//p' [2025-06-05 23:52:51] + shebang=/bin/bash [2025-06-05 23:52:51] ++ echo /bin/bash [2025-06-05 23:52:51] ++ awk '{print $1}' [2025-06-05 23:52:51] + interpreter=/bin/bash [2025-06-05 23:52:51] + '[' /bin/bash = /usr/bin/env ']' [2025-06-05 23:52:51] + '[' x/bin/bash = x ']' [2025-06-05 23:52:51] + type /bin/bash [2025-06-05 23:52:51] + '[' xgnutime = xgnutime ']' [2025-06-05 23:52:51] + /usr/bin/time -o /tmp/boinchome/slots/4/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.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-05 23:52:51] + RESULT=2 [2025-06-05 23:52:51] + sed -i -e /nodename=/d /tmp/boinchome/slots/4/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.diag [2025-06-05 23:52:51] ++ grep domain_name init_data.xml [2025-06-05 23:52:51] ++ awk -F '>' '{print $2}' [2025-06-05 23:52:51] ++ awk -F '<' '{print $1}' [2025-06-05 23:52:51] ++ sed -e 's# #_#g' [2025-06-05 23:52:51] + hostname=c-16-16.aglt2.org [2025-06-05 23:52:51] ++ grep user_name init_data.xml [2025-06-05 23:52:51] ++ awk -F '>' '{print $2}' [2025-06-05 23:52:51] ++ awk -F '<' '{print $1}' [2025-06-05 23:52:51] ++ sed -e 's# #_#g' [2025-06-05 23:52:51] + username=AGLT2 [2025-06-05 23:52:51] + nodename=AGLT2@c-16-16.aglt2.org [2025-06-05 23:52:51] + echo nodename=AGLT2@c-16-16.aglt2.org [2025-06-05 23:52:51] + '[' -n 10 ']' [2025-06-05 23:52:51] + sed -i -e s/Processors=1/Processors=10/ /tmp/boinchome/slots/4/GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.diag [2025-06-05 23:52:51] + echo exitcode=2 [2025-06-05 23:52:51] + runtimeenvironments= [2025-06-05 23:52:51] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-06-05 23:52:51] + RTE_function_0 2 [2025-06-05 23:52:51] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-05 23:52:51] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-06-05 23:52:51] + export BOINC_APP=ATLAS [2025-06-05 23:52:51] + BOINC_APP=ATLAS [2025-06-05 23:52:51] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-05 23:52:51] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-06-05 23:52:51] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-05 23:52:51] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-06-05 23:52:51] + '[' -z 2 ']' [2025-06-05 23:52:51] + '[' 2 == 1 ']' [2025-06-05 23:52:51] + '[' 0 -ne 0 ']' [2025-06-05 23:52:51] + echo 'zip all output files' [2025-06-05 23:52:51] + flist='*.diag ' [2025-06-05 23:52:51] + for f in ./heartbeat.json ./output.list ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 ./gmlog/ [2025-06-05 23:52:51] + '[' -e ./heartbeat.json ']' [2025-06-05 23:52:51] + flist='*.diag ./heartbeat.json' [2025-06-05 23:52:51] + for f in ./heartbeat.json ./output.list ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 ./gmlog/ [2025-06-05 23:52:51] + '[' -e ./output.list ']' [2025-06-05 23:52:51] + for f in ./heartbeat.json ./output.list ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 ./gmlog/ [2025-06-05 23:52:51] + '[' -e ./log.45006595._034928.job.log.1 ']' [2025-06-05 23:52:51] + flist='*.diag ./heartbeat.json ./log.45006595._034928.job.log.1' [2025-06-05 23:52:51] + for f in ./heartbeat.json ./output.list ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 ./gmlog/ [2025-06-05 23:52:51] + '[' -e ./log.45006595._034928.job.log.1 ']' [2025-06-05 23:52:51] + flist='*.diag ./heartbeat.json ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1' [2025-06-05 23:52:51] + for f in ./heartbeat.json ./output.list ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 ./gmlog/ [2025-06-05 23:52:51] + '[' -e ./gmlog/ ']' [2025-06-05 23:52:51] + '[' -f output.list ']' [2025-06-05 23:52:51] + tar cvf result.tar.gz GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.diag ./heartbeat.json ./log.45006595._034928.job.log.1 ./log.45006595._034928.job.log.1 [2025-06-05 23:52:51] + '[' xgnutime = xcgroup ']' [2025-06-05 23:52:51] + '[' -n '' ']' [2025-06-05 23:52:51] + '[' -n '' ']' [2025-06-05 23:52:51] ++ date +%s [2025-06-05 23:52:51] + ACCOUNTING_ENDTIME=1749181971 [2025-06-05 23:52:51] ++ date -d '1970-01-01 UTC 1749181784 seconds' +%Y%m%d%H%M%SZ [2025-06-05 23:52:51] + echo LRMSStartTime=20250605234944Z [2025-06-05 23:52:51] ++ date -d '1970-01-01 UTC 1749181971 seconds' +%Y%m%d%H%M%SZ [2025-06-05 23:52:51] + echo LRMSEndTime=20250605235251Z [2025-06-05 23:52:51] + echo walltime=187 [2025-06-05 23:52:51] + echo exitcode=2 [2025-06-05 23:52:51] + exit 2 [2025-06-05 23:52:51] ./pilot3/pilot/util/loggingsupport.py [2025-06-05 23:52:51] ./pilot3/pilot/util/lokirealtimelogger.py [2025-06-05 23:52:51] ./pilot3/pilot/util/realtimelogger.py [2025-06-05 23:52:51] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc [2025-06-05 23:52:51] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc [2025-06-05 23:52:51] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc [2025-06-05 23:52:51] ./PanDA_Pilot-6677658130/prmon.log [2025-06-05 23:52:51] ./PanDA_Pilot-6677658130/log.EVNTtoHITS [2025-06-05 23:52:51] ./PanDA_Pilot-6677658130/PoolFileCatalog.xml [2025-06-05 23:52:51] ./PanDA_Pilot-6677658130/pilotlog.txt [2025-06-05 23:52:51] ./log.45006595._034928.job.log.1 [2025-06-05 23:52:51] ./log.45006595._034928.job.log.tgz.1 [2025-06-05 23:52:51] ./runtime_log [2025-06-05 23:52:51] ./runtime_log.err [2025-06-05 23:52:51] ./pilotlog.txt 00:03:59 (578527): wrapper (7.7.26015): starting 00:03:59 (578527): wrapper: running run_atlas (--nthreads 10) [2025-06-06 00:03:59] Arguments: --nthreads 10 [2025-06-06 00:03:59] Threads: 10 [2025-06-06 00:03:59] This job has been restarted, cleaning up previous attempt [2025-06-06 00:03:59] Checking for CVMFS [2025-06-06 00:04:00] Probing /cvmfs/atlas.cern.ch... OK [2025-06-06 00:04:00] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-06 00:04:00] Running cvmfs_config stat atlas.cern.ch [2025-06-06 00:04:00] 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-06 00:04:00] 2.12.6.0 3989 329 104740 146842 3 409 15555027 21042176 8281 16776704 0 486270 95.815 3602330 44092 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-06 00:04:00] CVMFS is ok [2025-06-06 00:04:00] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-06 00:04:00] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-06 00:04:00] Further information can be found at the LHC@home message board. [2025-06-06 00:04:00] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-06 00:04:00] Checking for apptainer binary... [2025-06-06 00:04:00] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-06 00:04:00] Running /usr/bin/apptainer --version [2025-06-06 00:04:00] apptainer version 1.4.1-1.el9 [2025-06-06 00:04:00] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-06-06 00:04:00] c-16-16.aglt2.org [2025-06-06 00:04:00] apptainer works [2025-06-06 00:04:00] Set ATHENA_PROC_NUMBER=10 [2025-06-06 00:04:00] Set ATHENA_CORE_NUMBER=10 [2025-06-06 00:04:00] Starting ATLAS job with PandaID=6677658130 [2025-06-06 00:04:00] 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-06 03:31:02] *** The last 200 lines of the pilot log: *** [2025-06-06 03:31:02] 2025-06-06 07:30:49,687 | INFO | CPU arch script returned: x86-64-v2 [2025-06-06 03:31:02] 2025-06-06 07:30:49,688 | INFO | using path: /tmp/boinchome/slots/4/PanDA_Pilot-6677658130/memory_monitor_summary.json (trf name=prmon) [2025-06-06 03:31:02] 2025-06-06 07:30:49,688 | INFO | extracted standard info from prmon json [2025-06-06 03:31:02] 2025-06-06 07:30:49,689 | INFO | extracted standard memory fields from prmon json [2025-06-06 03:31:02] 2025-06-06 07:30:49,689 | WARNING | GPU info not found in prmon json: 'gpu' [2025-06-06 03:31:02] 2025-06-06 07:30:49,689 | WARNING | format EVNTtoHITS has no such key: dbData [2025-06-06 03:31:02] 2025-06-06 07:30:49,689 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-06-06 03:31:02] 2025-06-06 07:30:49,696 | INFO | fitting pss+swap vs Time [2025-06-06 03:31:02] 2025-06-06 07:30:49,696 | INFO | sum of square deviations: 2555464826.9950557 [2025-06-06 03:31:02] 2025-06-06 07:30:49,698 | INFO | sum of deviations: 36378299245.17819 [2025-06-06 03:31:02] 2025-06-06 07:30:49,698 | INFO | mean x: 1749188835.0049505 [2025-06-06 03:31:02] 2025-06-06 07:30:49,698 | INFO | mean y: 2187414.8217821782 [2025-06-06 03:31:02] 2025-06-06 07:30:49,698 | INFO | -- intersect: -24898376351.089848 [2025-06-06 03:31:02] 2025-06-06 07:30:49,698 | INFO | intersect: -24898376351.089848 [2025-06-06 03:31:02] 2025-06-06 07:30:49,699 | INFO | chi2: 1.5927492876299185 [2025-06-06 03:31:02] 2025-06-06 07:30:49,699 | INFO | sum of square deviations: 2370366883.1878204 [2025-06-06 03:31:02] 2025-06-06 07:30:49,701 | INFO | sum of deviations: 37355294309.959404 [2025-06-06 03:31:02] 2025-06-06 07:30:49,701 | INFO | mean x: 1749188682.5177665 [2025-06-06 03:31:02] 2025-06-06 07:30:49,701 | INFO | mean y: 2188199.725888325 [2025-06-06 03:31:02] 2025-06-06 07:30:49,701 | INFO | -- intersect: -27563779964.335682 [2025-06-06 03:31:02] 2025-06-06 07:30:49,701 | INFO | intersect: -27563779964.335682 [2025-06-06 03:31:02] 2025-06-06 07:30:49,702 | INFO | chi2: 1.574051968296133 [2025-06-06 03:31:02] 2025-06-06 07:30:49,702 | INFO | current chi2=1.574051968296133 (change=1.1739022254788158 %) [2025-06-06 03:31:02] 2025-06-06 07:30:49,702 | INFO | right removable region: 196 [2025-06-06 03:31:02] 2025-06-06 07:30:49,703 | INFO | sum of square deviations: 2370304663.1878204 [2025-06-06 03:31:02] 2025-06-06 07:30:49,704 | INFO | sum of deviations: 8666186354.365477 [2025-06-06 03:31:02] 2025-06-06 07:30:49,704 | INFO | mean x: 1749188987.5177665 [2025-06-06 03:31:02] 2025-06-06 07:30:49,704 | INFO | mean y: 2210026.4670050764 [2025-06-06 03:31:02] 2025-06-06 07:30:49,705 | INFO | -- intersect: -6393085046.88689 [2025-06-06 03:31:02] 2025-06-06 07:30:49,705 | INFO | intersect: -6393085046.88689 [2025-06-06 03:31:02] 2025-06-06 07:30:49,705 | INFO | chi2: 0.2395958350768206 [2025-06-06 03:31:02] 2025-06-06 07:30:49,705 | INFO | current chi2=0.2395958350768206 (change=84.95709042611786 %) [2025-06-06 03:31:02] 2025-06-06 07:30:49,706 | INFO | sum of square deviations: 2194307461.8125 [2025-06-06 03:31:02] 2025-06-06 07:30:49,707 | INFO | sum of deviations: 14968367796.312508 [2025-06-06 03:31:02] 2025-06-06 07:30:49,707 | INFO | mean x: 1749189140.03125 [2025-06-06 03:31:02] 2025-06-06 07:30:49,708 | INFO | mean y: 2204535.9479166665 [2025-06-06 03:31:02] 2025-06-06 07:30:49,708 | INFO | -- intersect: -11929809025.942156 [2025-06-06 03:31:02] 2025-06-06 07:30:49,708 | INFO | intersect: -11929809025.942156 [2025-06-06 03:31:02] 2025-06-06 07:30:49,708 | INFO | chi2: 0.16034591931544123 [2025-06-06 03:31:02] 2025-06-06 07:30:49,708 | INFO | current chi2=0.16034591931544123 (change=33.07649973797325 %) [2025-06-06 03:31:02] 2025-06-06 07:30:49,709 | INFO | sum of square deviations: 2027298852.6844926 [2025-06-06 03:31:02] 2025-06-06 07:30:49,710 | INFO | sum of deviations: 13540278580.96257 [2025-06-06 03:31:02] 2025-06-06 07:30:49,710 | INFO | mean x: 1749189292.5187166 [2025-06-06 03:31:02] 2025-06-06 07:30:49,711 | INFO | mean y: 2205886.0106951874 [2025-06-06 03:31:02] 2025-06-06 07:30:49,711 | INFO | -- intersect: -11680585864.291872 [2025-06-06 03:31:02] 2025-06-06 07:30:49,711 | INFO | intersect: -11680585864.291872 [2025-06-06 03:31:02] 2025-06-06 07:30:49,711 | INFO | chi2: 0.12614872083877193 [2025-06-06 03:31:02] 2025-06-06 07:30:49,711 | INFO | current chi2=0.12614872083877193 (change=21.32713986278298 %) [2025-06-06 03:31:02] 2025-06-06 07:30:49,712 | INFO | left removable region: 30 [2025-06-06 03:31:02] 2025-06-06 07:30:49,712 | INFO | sum of square deviations: 1418075159.9036167 [2025-06-06 03:31:02] 2025-06-06 07:30:49,713 | INFO | sum of deviations: 8841121111.72289 [2025-06-06 03:31:02] 2025-06-06 07:30:49,713 | INFO | mean x: 1749189567.0240965 [2025-06-06 03:31:02] 2025-06-06 07:30:49,714 | INFO | mean y: 2214822.8192771086 [2025-06-06 03:31:02] 2025-06-06 07:30:49,714 | INFO | -- intersect: -10903269771.151941 [2025-06-06 03:31:02] 2025-06-06 07:30:49,714 | INFO | intersect: -10903269771.151941 [2025-06-06 03:31:02] 2025-06-06 07:30:49,714 | INFO | chi2: 0.0924216548503766 [2025-06-06 03:31:02] 2025-06-06 07:30:49,714 | INFO | -- intersect: -10903269771.151941 [2025-06-06 03:31:02] 2025-06-06 07:30:49,715 | INFO | current memory leak: 6.23 B/s (using 166 data points, chi2=0.09) [2025-06-06 03:31:02] 2025-06-06 07:30:49,715 | INFO | .............................. [2025-06-06 03:31:02] 2025-06-06 07:30:49,715 | INFO | . Timing measurements: [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . get job = 0 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . initial setup = 1 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . payload setup = 12 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . stage-in = 0 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . payload execution = 12329 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,716 | INFO | . stage-out = 14 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,717 | INFO | . log creation = 0 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,717 | INFO | .............................. [2025-06-06 03:31:02] 2025-06-06 07:30:49,953 | INFO | [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | job summary report [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | -------------------------------------------------- [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | PanDA job id: 6677658130 [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | task id: 45006595 [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | errors: (none) [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | status: LOG_TRANSFER = DONE [2025-06-06 03:31:02] 2025-06-06 07:30:49,954 | INFO | pilot state: finished [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | transexitcode: 0 [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | exeerrorcode: 0 [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | exeerrordiag: [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | exitcode: 0 [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | exitmsg: OK [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | cpuconsumptiontime: 65713 s [2025-06-06 03:31:02] 2025-06-06 07:30:49,955 | INFO | nevents: 400 [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | neventsw: 0 [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | pid: 592027 [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | pgrp: 592027 [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | corecount: 10 [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | event service: False [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | sizes: {0: 2397171, 1: 2397370, 8: 2397576, 12: 2397604, 12345: 2427355, 12360: 2436296, 12364: 2436480, 12368: 2436650} [2025-06-06 03:31:02] 2025-06-06 07:30:49,956 | INFO | -------------------------------------------------- [2025-06-06 03:31:02] 2025-06-06 07:30:49,957 | INFO | [2025-06-06 03:31:02] 2025-06-06 07:30:49,957 | INFO | executing command: ls -lF /tmp/boinchome/slots/4 [2025-06-06 03:31:02] 2025-06-06 07:30:49,969 | INFO | queue jobs had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,969 | INFO | queue payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,969 | INFO | queue data_in had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue data_out had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue current_data_in had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,970 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,971 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,972 | INFO | queue completed_jobids has 1 job(s) [2025-06-06 03:31:02] 2025-06-06 07:30:49,972 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,972 | INFO | queue messages had 0 job(s) [purged] [2025-06-06 03:31:02] 2025-06-06 07:30:49,972 | INFO | job 6677658130 has completed (purged errors) [2025-06-06 03:31:02] 2025-06-06 07:30:49,972 | INFO | overall cleanup function is called [2025-06-06 03:31:02] 2025-06-06 07:30:50,981 | INFO | --- collectZombieJob: --- 10, [592027] [2025-06-06 03:31:02] 2025-06-06 07:30:50,981 | INFO | zombie collector waiting for pid 592027 [2025-06-06 03:31:02] 2025-06-06 07:30:50,981 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-06-06 03:31:02] 2025-06-06 07:30:50,981 | INFO | collected zombie processes [2025-06-06 03:31:02] 2025-06-06 07:30:50,981 | INFO | will attempt to kill all subprocesses of pid=592027 [2025-06-06 03:31:02] 2025-06-06 07:30:51,228 | INFO | process IDs to be killed: [592027] (in reverse order) [2025-06-06 03:31:02] 2025-06-06 07:30:51,315 | WARNING | found no corresponding commands to process id(s) [2025-06-06 03:31:02] 2025-06-06 07:30:51,316 | INFO | Do not look for orphan processes in BOINC jobs [2025-06-06 03:31:02] 2025-06-06 07:30:51,325 | INFO | did not find any defunct processes belonging to 592027 [2025-06-06 03:31:02] 2025-06-06 07:30:51,334 | INFO | did not find any defunct processes belonging to 592027 [2025-06-06 03:31:02] 2025-06-06 07:30:51,334 | INFO | ready for new job [2025-06-06 03:31:02] 2025-06-06 07:30:51,334 | INFO | pilot has finished with previous job - re-establishing logging [2025-06-06 03:31:02] 2025-06-06 07:30:51,336 | INFO | ************************************** [2025-06-06 03:31:02] 2025-06-06 07:30:51,336 | INFO | *** PanDA Pilot version 3.10.2.2 *** [2025-06-06 03:31:02] 2025-06-06 07:30:51,336 | INFO | ************************************** [2025-06-06 03:31:02] 2025-06-06 07:30:51,336 | INFO | [2025-06-06 03:31:02] 2025-06-06 07:30:51,350 | INFO | architecture information: [2025-06-06 03:31:02] 2025-06-06 07:30:51,350 | INFO | executing command: cat /etc/os-release [2025-06-06 03:31:02] 2025-06-06 07:30:51,359 | INFO | cat /etc/os-release: [2025-06-06 03:31:02] NAME="CentOS Linux" [2025-06-06 03:31:02] VERSION="7 (Core)" [2025-06-06 03:31:02] ID="centos" [2025-06-06 03:31:02] ID_LIKE="rhel fedora" [2025-06-06 03:31:02] VERSION_ID="7" [2025-06-06 03:31:02] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-06-06 03:31:02] ANSI_COLOR="0;31" [2025-06-06 03:31:02] CPE_NAME="cpe:/o:centos:centos:7" [2025-06-06 03:31:02] HOME_URL="https://www.centos.org/" [2025-06-06 03:31:02] BUG_REPORT_URL="https://bugs.centos.org/" [2025-06-06 03:31:02] [2025-06-06 03:31:02] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-06-06 03:31:02] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-06-06 03:31:02] REDHAT_SUPPORT_PRODUCT="centos" [2025-06-06 03:31:02] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-06-06 03:31:02] [2025-06-06 03:31:02] 2025-06-06 07:30:51,360 | INFO | ************************************** [2025-06-06 03:31:02] 2025-06-06 07:30:51,863 | INFO | executing command: df -mP /tmp/boinchome/slots/4 [2025-06-06 03:31:02] 2025-06-06 07:30:51,872 | INFO | sufficient remaining disk space (52651098112 B) [2025-06-06 03:31:02] 2025-06-06 07:30:51,873 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-06-06 03:31:02] 2025-06-06 07:30:51,873 | INFO | current server update state: UPDATING_FINAL [2025-06-06 03:31:02] 2025-06-06 07:30:51,873 | INFO | update_server=False [2025-06-06 03:31:02] 2025-06-06 07:30:51,873 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-06-06 03:31:02] 2025-06-06 07:30:51,965 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-06-06 03:31:02] 2025-06-06 07:30:52,294 | INFO | all data control threads have been joined [2025-06-06 03:31:02] 2025-06-06 07:30:52,321 | INFO | found 0 job(s) in 20 queues [2025-06-06 03:31:02] 2025-06-06 07:30:52,321 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-06-06 03:31:02] 2025-06-06 07:30:52,321 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-06-06 03:31:02] 2025-06-06 07:30:52,420 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-06-06 03:31:02] 2025-06-06 07:30:52,420 | INFO | aborting loop [2025-06-06 03:31:02] 2025-06-06 07:30:52,878 | INFO | [job] retrieve thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:52,913 | INFO | [payload] run_realtimelog thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,033 | INFO | [payload] failed_post thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,141 | INFO | all payload control threads have been joined [2025-06-06 03:31:02] 2025-06-06 07:30:53,243 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-06-06 03:31:02] 2025-06-06 07:30:53,299 | INFO | [data] control thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,343 | INFO | all job control threads have been joined [2025-06-06 03:31:02] 2025-06-06 07:30:53,415 | INFO | [job] create_data_payload thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,425 | INFO | [job] job monitor thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,558 | INFO | [job] validate thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:53,833 | INFO | [payload] validate_pre thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,003 | INFO | [payload] execute_payloads thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,110 | INFO | [data] copytool_in thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,146 | INFO | [payload] control thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,222 | INFO | [payload] validate_post thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,349 | INFO | [job] control thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:54,814 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-06-06 03:31:02] 2025-06-06 07:30:55,249 | INFO | [data] copytool_out thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:55,819 | INFO | [job] queue monitor thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:55,971 | INFO | [data] queue_monitor thread has finished [2025-06-06 03:31:02] 2025-06-06 07:30:57,042 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140288148506432)>', '<ExcThread(monitor, started 140287473063680)>'] [2025-06-06 03:31:02] 2025-06-06 07:30:57,346 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-06-06 03:31:02] 2025-06-06 07:30:57,347 | INFO | [monitor] control thread has ended [2025-06-06 03:31:02] 2025-06-06 07:31:02,095 | INFO | all workflow threads have been joined [2025-06-06 03:31:02] 2025-06-06 07:31:02,357 | INFO | end of generic workflow (traces error code: 0) [2025-06-06 03:31:02] 2025-06-06 07:31:02,357 | INFO | traces error code: 0 [2025-06-06 03:31:02] 2025-06-06 07:31:02,357 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-06-06 03:31:02] 2025-06-06 07:31:02,473 [wrapper] ==== pilot stdout END ==== [2025-06-06 03:31:02] 2025-06-06 07:31:02,474 [wrapper] ==== wrapper stdout RESUME ==== [2025-06-06 03:31:02] 2025-06-06 07:31:02,476 [wrapper] pilotpid: 583580 [2025-06-06 03:31:02] 2025-06-06 07:31:02,478 [wrapper] Pilot exit status: 0 [2025-06-06 03:31:02] 2025-06-06 07:31:02,492 [wrapper] pandaids: 6677658130 6677658130 6677658130 [2025-06-06 03:31:02] 2025-06-06 07:31:02,555 [wrapper] cleanup supervisor_pilot 1149715 583581 [2025-06-06 03:31:02] 2025-06-06 07:31:02,557 [wrapper] Test setup, not cleaning [2025-06-06 03:31:02] 2025-06-06 07:31:02,558 [wrapper] apfmon messages muted [2025-06-06 03:31:02] 2025-06-06 07:31:02,560 [wrapper] ==== wrapper stdout END ==== [2025-06-06 03:31:02] 2025-06-06 07:31:02,562 [wrapper] ==== wrapper stderr END ==== [2025-06-06 03:31:02] *** Error codes and diagnostics *** [2025-06-06 03:31:02] "exeErrorCode": 0, [2025-06-06 03:31:02] "exeErrorDiag": "", [2025-06-06 03:31:02] "pilotErrorCode": 0, [2025-06-06 03:31:02] "pilotErrorDiag": "", [2025-06-06 03:31:02] *** Listing of results directory *** [2025-06-06 03:31:02] total 600228 [2025-06-06 03:31:02] drwx------. 4 boincer umatlas 4096 Apr 3 04:00 pilot3 [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 495897 Jun 3 09:40 pilot3.tar.gz [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 5111 Jun 3 10:07 queuedata.json [2025-06-06 03:31:02] -rwx------. 1 boincer umatlas 37140 Jun 3 10:07 runpilot2-wrapper.sh [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 100 Jun 3 12:43 wrapper_26015_x86_64-pc-linux-gnu [2025-06-06 03:31:02] -rwxr-xr-x. 1 boincer umatlas 7986 Jun 3 12:43 run_atlas [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 105 Jun 3 12:43 job.xml [2025-06-06 03:31:02] -rw-r--r--. 3 boincer umatlas 214245781 Jun 3 12:43 EVNT.45006593._001404.pool.root.1 [2025-06-06 03:31:02] -rw-r--r--. 3 boincer umatlas 214245781 Jun 3 12:43 ATLAS.root_0 [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 12:43 start_atlas.sh [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 508885 Jun 3 12:43 input.tar.gz [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 0 Jun 3 12:43 boinc_lockfile [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 0 Jun 5 23:49 wrapper_sigint_547430 [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 0 Jun 5 23:52 wrapper_sigkill_547430 [2025-06-06 03:31:02] drwxrwx--x. 2 boincer umatlas 4096 Jun 5 23:52 shared [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 2525 Jun 6 00:04 pandaJob.out [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 987721 Jun 6 00:04 agis_schedconf.cvmfs.json [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 6523 Jun 6 03:29 init_data.xml [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 179314061 Jun 6 03:29 HITS.45006595._034928.pool.root.1 [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 533 Jun 6 03:30 boinc_task_state.xml [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 99 Jun 6 03:30 pilot_heartbeat.json [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 1048 Jun 6 03:30 memory_monitor_summary.json [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 1598969 Jun 6 03:30 agis_ddmendpoints.agis.ALL.json [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 410301 Jun 6 03:30 log.45006595._034928.job.log.tgz.1 [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 7732 Jun 6 03:30 heartbeat.json [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 8192 Jun 6 03:31 boinc_mmap_file [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 29 Jun 6 03:31 wrapper_checkpoint.txt [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 4353 Jun 6 03:31 pilotlog.txt [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 1070449 Jun 6 03:31 log.45006595._034928.job.log.1 [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 357 Jun 6 03:31 output.list [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 620 Jun 6 03:31 runtime_log [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 1505280 Jun 6 03:31 result.tar.gz [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 8742 Jun 6 03:31 runtime_log.err [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 1886 Jun 6 03:31 GE5NDm4Thg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmJUkKDmVC7otn.diag [2025-06-06 03:31:02] -rw-r--r--. 1 boincer umatlas 38236 Jun 6 03:31 stderr.txt [2025-06-06 03:31:02] HITS file was successfully produced: [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 179314061 Jun 6 03:29 shared/HITS.pool.root.1 [2025-06-06 03:31:02] *** Contents of shared directory: *** [2025-06-06 03:31:02] total 386332 [2025-06-06 03:31:02] -rw-r--r--. 3 boincer umatlas 214245781 Jun 3 12:43 ATLAS.root_0 [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 12:43 start_atlas.sh [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 508885 Jun 3 12:43 input.tar.gz [2025-06-06 03:31:02] -rw-------. 1 boincer umatlas 179314061 Jun 6 03:29 HITS.pool.root.1 [2025-06-06 03:31:02] -rw-r--r--. 2 boincer umatlas 1505280 Jun 6 03:31 result.tar.gz 03:31:03 (578527): run_atlas exited; CPU time 66013.660694 03:31:03 (578527): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN