Name | rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn_1 |
Workunit | 232822193 |
Created | 3 Jun 2025, 16:56:31 UTC |
Sent | 3 Jun 2025, 17:56:09 UTC |
Report deadline | 11 Jun 2025, 17:56: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 | 55 min 30 sec |
CPU time | 1 days 5 hours 36 min 39 sec |
Validate state | Valid |
Credit | 37.73 |
Device peak FLOPS | 12.00 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.66 GB |
Peak swap size | 31.77 GB |
Peak disk usage | 648.76 MB |
<core_client_version>8.1.0</core_client_version> <![CDATA[ <stderr_txt> 13:56:44 (2747462): wrapper (7.7.26015): starting 13:56:44 (2747462): wrapper: running run_atlas (--nthreads 8) [2025-06-03 13:56:44] Arguments: --nthreads 8 [2025-06-03 13:56:44] Threads: 8 [2025-06-03 13:56:44] Checking for CVMFS [2025-06-03 13:56:44] Probing /cvmfs/atlas.cern.ch... OK [2025-06-03 13:56:44] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-06-03 13:56:44] Running cvmfs_config stat atlas.cern.ch [2025-06-03 13:56: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 13:56:44] 2.12.6.0 3235747 90366 597428 146750 3 197 11560920 21042177 3976 16776704 2 240775981 99.288 467119488 25477 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-06-03 13:56:44] CVMFS is ok [2025-06-03 13:56:44] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-06-03 13:56:44] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-06-03 13:56:44] Further information can be found at the LHC@home message board. [2025-06-03 13:56:44] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-06-03 13:56:44] Checking for apptainer binary... [2025-06-03 13:56:44] Using apptainer found in PATH at /usr/bin/apptainer [2025-06-03 13:56:44] Running /usr/bin/apptainer --version [2025-06-03 13:56:44] apptainer version 1.4.1-1.el9 [2025-06-03 13:56: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 13:56:45] c-16-11.aglt2.org [2025-06-03 13:56:45] apptainer works [2025-06-03 13:56:45] Set ATHENA_PROC_NUMBER=8 [2025-06-03 13:56:45] Set ATHENA_CORE_NUMBER=8 [2025-06-03 13:56:45] Starting ATLAS job with PandaID=6677675465 [2025-06-03 13:56:45] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh 17:00:11 (2747462): BOINC client no longer exists - exiting 17:00:11 (2747462): timer handler: client dead, exiting 11:36:30 (34523): wrapper (7.7.26015): starting 11:36:30 (34523): 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 824 16776704 0 49538 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:30] c-16-11.aglt2.org [2025-06-04 11:36:30] apptainer works [2025-06-04 11:36:30] Set ATHENA_PROC_NUMBER=8 [2025-06-04 11:36:30] Set ATHENA_CORE_NUMBER=8 [2025-06-04 11:36:30] Starting ATLAS job with PandaID=6677675465 [2025-06-04 11:36:30] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /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/3/ [2025-06-04 11:39:35] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/3/ [2025-06-04 11:39:35] + mv ATLAS.root_0 EVNT.45006593._001439.pool.root.1 [2025-06-04 11:39:35] mv: ‘ATLAS.root_0’ and ‘EVNT.45006593._001439.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=1749051390 [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/6677675465.out [2025-06-04 11:39:35] + GTAG=http://aipanda403.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677675465.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=rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn [2025-06-04 11:39:35] + GRID_GLOBAL_JOBID=rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn [2025-06-04 11:39:35] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn [2025-06-04 11:39:35] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn [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/3 [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/3/log.45006595._035822.job.log.1 [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/3/log.45006595._035822.job.log.1 [2025-06-04 11:39:35] ++ pwd [2025-06-04 11:39:35] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/3.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/3/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.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/3/ [2025-06-04 11:39:35] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/3/ [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/3 [2025-06-04 11:39:35] + export HOME [2025-06-04 11:39:35] + cd /tmp/boinchome/slots/3 [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/3/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.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/3/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.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/3/rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.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._035822.job.log.1 ./log.45006595._035822.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._035822.job.log.1 ./log.45006595._035822.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._035822.job.log.1 ./log.45006595._035822.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./log.45006595._035822.job.log.1 ']' [2025-06-04 11:39:35] + flist='*.diag ./heartbeat.json ./log.45006595._035822.job.log.1' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._035822.job.log.1 ./log.45006595._035822.job.log.1 ./gmlog/ [2025-06-04 11:39:35] + '[' -e ./log.45006595._035822.job.log.1 ']' [2025-06-04 11:39:35] + flist='*.diag ./heartbeat.json ./log.45006595._035822.job.log.1 ./log.45006595._035822.job.log.1' [2025-06-04 11:39:35] + for f in ./heartbeat.json ./output.list ./log.45006595._035822.job.log.1 ./log.45006595._035822.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 rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.diag ./heartbeat.json ./log.45006595._035822.job.log.1 ./log.45006595._035822.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 1749051390 seconds' +%Y%m%d%H%M%SZ [2025-06-04 11:39:35] + echo LRMSStartTime=20250604113630Z [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=185 [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] ./PanDA_Pilot-6677675465/log.EVNTtoHITS [2025-06-04 11:39:35] ./PanDA_Pilot-6677675465/prmon.log [2025-06-04 11:39:35] ./PanDA_Pilot-6677675465/pilotlog.txt [2025-06-04 11:39:35] ./PanDA_Pilot-6677675465/PoolFileCatalog.xml [2025-06-04 11:39:35] ./log.45006595._035822.job.log.1 [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 11:49:01 (97661): wrapper (7.7.26015): starting 11:49:01 (97661): 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=6677675465 [2025-06-04 11:49:02] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-06-05 06:39:52] *** The last 200 lines of the pilot log: *** [2025-06-05 06:39:52] 2025-06-05 09:34:26,315 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:39:52] 2025-06-05 09:34:28,819 | INFO | monitor loop #2150: job 0:6677675465 is in state 'finished' [2025-06-05 06:39:52] 2025-06-05 09:34:28,826 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:39:52] 2025-06-05 09:34:31,331 | INFO | monitor loop #2151: job 0:6677675465 is in state 'finished' [2025-06-05 06:39:52] 2025-06-05 09:34:31,332 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-06-05 06:39:52] 2025-06-05 09:34:32,760 | INFO | CPU arch script returned: x86-64-v2 [2025-06-05 06:39:52] 2025-06-05 09:34:32,760 | INFO | using path: /tmp/boinchome/slots/3/PanDA_Pilot-6677675465/memory_monitor_summary.json (trf name=prmon) [2025-06-05 06:39:52] 2025-06-05 09:34:32,762 | INFO | extracted standard info from prmon json [2025-06-05 06:39:52] 2025-06-05 09:34:32,762 | INFO | extracted standard memory fields from prmon json [2025-06-05 06:39:52] 2025-06-05 09:34:32,762 | WARNING | GPU info not found in prmon json: 'gpu' [2025-06-05 06:39:52] 2025-06-05 09:34:32,763 | WARNING | format EVNTtoHITS has no such key: dbData [2025-06-05 06:39:52] 2025-06-05 09:34:32,763 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-06-05 06:39:52] 2025-06-05 09:34:32,792 | INFO | fitting pss+swap vs Time [2025-06-05 06:39:52] 2025-06-05 09:34:32,794 | INFO | sum of square deviations: 355892664957.9106 [2025-06-05 06:39:52] 2025-06-05 09:34:32,825 | INFO | sum of deviations: 413876451351.12244 [2025-06-05 06:39:52] 2025-06-05 09:34:32,825 | INFO | mean x: 1749084095.0697231 [2025-06-05 06:39:52] 2025-06-05 09:34:32,826 | INFO | mean y: 2054870.6284622732 [2025-06-05 06:39:52] 2025-06-05 09:34:32,826 | INFO | -- intersect: -2031998622.62844 [2025-06-05 06:39:52] 2025-06-05 09:34:32,826 | INFO | intersect: -2031998622.62844 [2025-06-05 06:39:52] 2025-06-05 09:34:32,828 | INFO | chi2: 3.27858152298869 [2025-06-05 06:39:52] 2025-06-05 09:34:32,830 | INFO | sum of square deviations: 350818512658.8085 [2025-06-05 06:39:52] 2025-06-05 09:34:32,860 | INFO | sum of deviations: 469444121517.36066 [2025-06-05 06:39:52] 2025-06-05 09:34:32,860 | INFO | mean x: 1749083942.5738964 [2025-06-05 06:39:52] 2025-06-05 09:34:32,860 | INFO | mean y: 2056534.2485604608 [2025-06-05 06:39:52] 2025-06-05 09:34:32,861 | INFO | -- intersect: -2338461839.9351006 [2025-06-05 06:39:52] 2025-06-05 09:34:32,861 | INFO | intersect: -2338461839.9351006 [2025-06-05 06:39:52] 2025-06-05 09:34:32,862 | INFO | chi2: 2.605787997952313 [2025-06-05 06:39:52] 2025-06-05 09:34:32,863 | INFO | current chi2=2.605787997952313 (change=20.520872222297886 %) [2025-06-05 06:39:52] 2025-06-05 09:34:32,863 | INFO | right removable region: 1041 [2025-06-05 06:39:52] 2025-06-05 09:34:32,865 | INFO | sum of square deviations: 350817893324.66113 [2025-06-05 06:39:52] 2025-06-05 09:34:32,895 | INFO | sum of deviations: 285708530106.3456 [2025-06-05 06:39:52] 2025-06-05 09:34:32,896 | INFO | mean x: 1749084247.574856 [2025-06-05 06:39:52] 2025-06-05 09:34:32,896 | INFO | mean y: 2058713.3032629557 [2025-06-05 06:39:52] 2025-06-05 09:34:32,896 | INFO | -- intersect: -1422407652.0548651 [2025-06-05 06:39:52] 2025-06-05 09:34:32,896 | INFO | intersect: -1422407652.0548651 [2025-06-05 06:39:52] 2025-06-05 09:34:32,898 | INFO | chi2: 1.907628105490251 [2025-06-05 06:39:52] 2025-06-05 09:34:32,898 | INFO | current chi2=1.907628105490251 (change=41.815443901138835 %) [2025-06-05 06:39:52] 2025-06-05 09:34:32,900 | INFO | sum of square deviations: 345791587716.35645 [2025-06-05 06:39:52] 2025-06-05 09:34:32,930 | INFO | sum of deviations: 310395550813.64594 [2025-06-05 06:39:52] 2025-06-05 09:34:32,930 | INFO | mean x: 1749084400.0800385 [2025-06-05 06:39:52] 2025-06-05 09:34:32,930 | INFO | mean y: 2057963.8476374156 [2025-06-05 06:39:52] 2025-06-05 09:34:32,931 | INFO | -- intersect: -1567986059.9755561 [2025-06-05 06:39:52] 2025-06-05 09:34:32,931 | INFO | intersect: -1567986059.9755561 [2025-06-05 06:39:52] 2025-06-05 09:34:32,932 | INFO | chi2: 1.8660774271776894 [2025-06-05 06:39:52] 2025-06-05 09:34:32,933 | INFO | current chi2=1.8660774271776894 (change=2.178133053972977 %) [2025-06-05 06:39:52] 2025-06-05 09:34:32,933 | INFO | left removable region: 20 [2025-06-05 06:39:52] 2025-06-05 09:34:32,934 | INFO | sum of square deviations: 330031149702.59326 [2025-06-05 06:39:52] 2025-06-05 09:34:32,963 | INFO | sum of deviations: 418132972571.13007 [2025-06-05 06:39:52] 2025-06-05 09:34:32,963 | INFO | mean x: 1749084522.0959842 [2025-06-05 06:39:52] 2025-06-05 09:34:32,964 | INFO | mean y: 2057918.6415279137 [2025-06-05 06:39:52] 2025-06-05 09:34:32,964 | INFO | -- intersect: -2213944756.1399355 [2025-06-05 06:39:52] 2025-06-05 09:34:32,964 | INFO | intersect: -2213944756.1399355 [2025-06-05 06:39:52] 2025-06-05 09:34:32,966 | INFO | chi2: 1.0793109680665642 [2025-06-05 06:39:52] 2025-06-05 09:34:32,966 | INFO | -- intersect: -2213944756.1399355 [2025-06-05 06:39:52] 2025-06-05 09:34:32,966 | INFO | current memory leak: 1.27 B/s (using 1021 data points, chi2=1.08) [2025-06-05 06:39:52] 2025-06-05 09:34:32,976 | INFO | .............................. [2025-06-05 06:39:52] 2025-06-05 09:34:32,976 | INFO | . Timing measurements: [2025-06-05 06:39:52] 2025-06-05 09:34:32,976 | INFO | . get job = 0 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,976 | INFO | . initial setup = 1 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | . payload setup = 10 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | . stage-in = 0 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | . payload execution = 63843 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | . stage-out = 15 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | . log creation = 0 s [2025-06-05 06:39:52] 2025-06-05 09:34:32,977 | INFO | .............................. [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | job summary report [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | -------------------------------------------------- [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | PanDA job id: 6677675465 [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | task id: 45006595 [2025-06-05 06:39:52] 2025-06-05 09:34:33,515 | INFO | errors: (none) [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | status: LOG_TRANSFER = DONE [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | pilot state: finished [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | transexitcode: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | exeerrorcode: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | exeerrordiag: [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | exitcode: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:33,516 | INFO | exitmsg: OK [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | cpuconsumptiontime: 70053 s [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | nevents: 400 [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | neventsw: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | pid: 138708 [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | pgrp: 138708 [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | corecount: 8 [2025-06-05 06:39:52] 2025-06-05 09:34:33,517 | INFO | event service: False [2025-06-05 06:39:52] 2025-06-05 09:34:33,518 | INFO | sizes: {0: 2397171, 1: 2397370, 2: 2397370, 7: 2397604, 12: 2397632, 63858: 2445225, 63874: 2454166, 63878: 2454222, 63899: 2454392} [2025-06-05 06:39:52] 2025-06-05 09:34:33,518 | INFO | -------------------------------------------------- [2025-06-05 06:39:52] 2025-06-05 09:34:33,518 | INFO | [2025-06-05 06:39:52] 2025-06-05 09:34:33,518 | INFO | executing command: ls -lF /tmp/boinchome/slots/3 [2025-06-05 06:39:52] 2025-06-05 09:34:33,571 | INFO | queue jobs had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,571 | INFO | queue payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,575 | INFO | queue data_in had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue data_out had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue current_data_in had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,576 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,577 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,578 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,578 | INFO | queue completed_jobids has 1 job(s) [2025-06-05 06:39:52] 2025-06-05 09:34:33,578 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,578 | INFO | queue messages had 0 job(s) [purged] [2025-06-05 06:39:52] 2025-06-05 09:34:33,578 | INFO | job 6677675465 has completed (purged errors) [2025-06-05 06:39:52] 2025-06-05 09:34:33,579 | INFO | overall cleanup function is called [2025-06-05 06:39:52] 2025-06-05 09:34:34,600 | INFO | --- collectZombieJob: --- 10, [138708] [2025-06-05 06:39:52] 2025-06-05 09:34:34,601 | INFO | zombie collector waiting for pid 138708 [2025-06-05 06:39:52] 2025-06-05 09:34:34,601 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-06-05 06:39:52] 2025-06-05 09:34:34,601 | INFO | collected zombie processes [2025-06-05 06:39:52] 2025-06-05 09:34:34,603 | INFO | will attempt to kill all subprocesses of pid=138708 [2025-06-05 06:39:52] 2025-06-05 09:34:35,968 | INFO | PID=112456 has CPU usage=5.4% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR [2025-06-05 06:39:52] 2025-06-05 09:34:35,968 | INFO | .. there are 30 such processes running [2025-06-05 06:39:52] 2025-06-05 09:34:36,409 | INFO | process IDs to be killed: [138708] (in reverse order) [2025-06-05 06:39:52] 2025-06-05 09:34:36,567 | WARNING | found no corresponding commands to process id(s) [2025-06-05 06:39:52] 2025-06-05 09:34:36,568 | INFO | Do not look for orphan processes in BOINC jobs [2025-06-05 06:39:52] 2025-06-05 09:34:36,612 | INFO | did not find any defunct processes belonging to 138708 [2025-06-05 06:39:52] 2025-06-05 09:34:36,622 [wrapper] supervise_pilot (15 min periods counter: 72) [2025-06-05 06:39:52] 2025-06-05 09:34:36,748 | INFO | did not find any defunct processes belonging to 138708 [2025-06-05 06:39:52] 2025-06-05 09:34:36,748 | INFO | ready for new job [2025-06-05 06:39:52] 2025-06-05 09:34:36,748 | INFO | pilot has finished with previous job - re-establishing logging [2025-06-05 06:39:52] 2025-06-05 09:34:36,773 | INFO | ************************************** [2025-06-05 06:39:52] 2025-06-05 09:34:36,773 | INFO | *** PanDA Pilot version 3.10.2.2 *** [2025-06-05 06:39:52] 2025-06-05 09:34:36,773 | INFO | ************************************** [2025-06-05 06:39:52] 2025-06-05 09:34:36,773 | INFO | [2025-06-05 06:39:52] 2025-06-05 09:34:36,788 | INFO | architecture information: [2025-06-05 06:39:52] 2025-06-05 09:34:36,811 | INFO | executing command: cat /etc/os-release [2025-06-05 06:39:52] 2025-06-05 09:34:36,876 | INFO | cat /etc/os-release: [2025-06-05 06:39:52] NAME="CentOS Linux" [2025-06-05 06:39:52] VERSION="7 (Core)" [2025-06-05 06:39:52] ID="centos" [2025-06-05 06:39:52] ID_LIKE="rhel fedora" [2025-06-05 06:39:52] VERSION_ID="7" [2025-06-05 06:39:52] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-06-05 06:39:52] ANSI_COLOR="0;31" [2025-06-05 06:39:52] CPE_NAME="cpe:/o:centos:centos:7" [2025-06-05 06:39:52] HOME_URL="https://www.centos.org/" [2025-06-05 06:39:52] BUG_REPORT_URL="https://bugs.centos.org/" [2025-06-05 06:39:52] [2025-06-05 06:39:52] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-06-05 06:39:52] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-06-05 06:39:52] REDHAT_SUPPORT_PRODUCT="centos" [2025-06-05 06:39:52] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-06-05 06:39:52] [2025-06-05 06:39:52] 2025-06-05 09:34:36,877 | INFO | ************************************** [2025-06-05 06:39:52] 2025-06-05 09:34:37,383 | INFO | executing command: df -mP /tmp/boinchome/slots/3 [2025-06-05 06:39:52] 2025-06-05 09:34:37,426 | INFO | sufficient remaining disk space (52081721344 B) [2025-06-05 06:39:52] 2025-06-05 09:34:37,426 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-06-05 06:39:52] 2025-06-05 09:34:37,427 | INFO | current server update state: UPDATING_FINAL [2025-06-05 06:39:52] 2025-06-05 09:34:37,427 | INFO | update_server=False [2025-06-05 06:39:52] 2025-06-05 09:34:37,427 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-06-05 06:39:52] 2025-06-05 09:34:37,427 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-06-05 06:39:52] 2025-06-05 09:34:37,428 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-06-05 06:39:52] 2025-06-05 09:34:37,428 | INFO | aborting loop [2025-06-05 06:39:52] 2025-06-05 09:34:38,001 | INFO | found 0 job(s) in 20 queues [2025-06-05 06:39:52] 2025-06-05 09:34:38,007 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-06-05 06:39:52] 2025-06-05 09:34:38,007 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-06-05 06:39:52] 2025-06-05 09:34:38,214 | INFO | all payload control threads have been joined [2025-06-05 06:39:52] 2025-06-05 09:34:38,314 | INFO | all data control threads have been joined [2025-06-05 06:39:52] 2025-06-05 09:34:38,434 | INFO | [job] retrieve thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:38,439 | INFO | [job] job monitor thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:38,551 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-06-05 06:39:52] 2025-06-05 09:34:38,577 | INFO | all job control threads have been joined [2025-06-05 06:39:52] 2025-06-05 09:34:38,803 | INFO | [payload] validate_pre thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:38,818 | INFO | [payload] failed_post thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:38,841 | INFO | [job] create_data_payload thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:38,858 | INFO | [job] validate thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,195 | INFO | [data] copytool_in thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,223 | INFO | [payload] control thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,330 | INFO | [data] control thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,398 | INFO | [payload] run_realtimelog thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,434 | INFO | [data] copytool_out thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,557 | INFO | [job] queue monitor thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,583 | INFO | [job] control thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,614 | INFO | [payload] execute_payloads thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:39,846 | INFO | [payload] validate_post thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:40,686 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-06-05 06:39:52] 2025-06-05 09:34:44,695 | INFO | [data] queue_monitor thread has finished [2025-06-05 06:39:52] 2025-06-05 09:34:46,387 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139936547313472)>', '<ExcThread(monitor, started 139935923296000)>'] [2025-06-05 06:39:52] 2025-06-05 09:34:47,063 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-06-05 06:39:52] 2025-06-05 09:34:47,064 | INFO | [monitor] control thread has ended [2025-06-05 06:39:52] 2025-06-05 09:34:51,413 | INFO | all workflow threads have been joined [2025-06-05 06:39:52] 2025-06-05 09:34:51,414 | INFO | end of generic workflow (traces error code: 0) [2025-06-05 06:39:52] 2025-06-05 09:34:51,414 | INFO | traces error code: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:51,414 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-06-05 06:39:52] 2025-06-05 09:34:51,750 [wrapper] ==== pilot stdout END ==== [2025-06-05 06:39:52] 2025-06-05 09:34:51,754 [wrapper] ==== wrapper stdout RESUME ==== [2025-06-05 06:39:52] 2025-06-05 09:34:51,761 [wrapper] pilotpid: 112456 [2025-06-05 06:39:52] 2025-06-05 09:34:51,779 [wrapper] Pilot exit status: 0 [2025-06-05 06:39:52] 2025-06-05 09:34:51,864 [wrapper] pandaids: 6677675465 6677675465 6677675465 [2025-06-05 06:39:52] 2025-06-05 09:34:52,052 [wrapper] cleanup supervisor_pilot 889600 112457 [2025-06-05 06:39:52] 2025-06-05 09:34:52,069 [wrapper] Test setup, not cleaning [2025-06-05 06:39:52] 2025-06-05 09:34:52,103 [wrapper] apfmon messages muted [2025-06-05 06:39:52] 2025-06-05 09:34:52,134 [wrapper] ==== wrapper stdout END ==== [2025-06-05 06:39:52] 2025-06-05 09:34:52,164 [wrapper] ==== wrapper stderr END ==== [2025-06-05 06:39:52] *** Error codes and diagnostics *** [2025-06-05 06:39:52] "exeErrorCode": 0, [2025-06-05 06:39:52] "exeErrorDiag": "", [2025-06-05 06:39:52] "pilotErrorCode": 0, [2025-06-05 06:39:52] "pilotErrorDiag": "", [2025-06-05 06:39:52] *** Listing of results directory *** [2025-06-05 06:39:52] total 604272 [2025-06-05 06:39:52] drwx------. 4 boincer umatlas 4096 Apr 3 04:00 pilot3 [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 495897 Jun 3 10:31 pilot3.tar.gz [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 5111 Jun 3 10:41 queuedata.json [2025-06-05 06:39:52] -rwx------. 1 boincer umatlas 37140 Jun 3 10:43 runpilot2-wrapper.sh [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 100 Jun 3 13:56 wrapper_26015_x86_64-pc-linux-gnu [2025-06-05 06:39:52] -rwxr-xr-x. 1 boincer umatlas 7986 Jun 3 13:56 run_atlas [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 105 Jun 3 13:56 job.xml [2025-06-05 06:39:52] -rw-r--r--. 3 boincer umatlas 213424764 Jun 3 13:56 EVNT.45006593._001439.pool.root.1 [2025-06-05 06:39:52] -rw-r--r--. 3 boincer umatlas 213424764 Jun 3 13:56 ATLAS.root_0 [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 13:56 start_atlas.sh [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 508884 Jun 3 13:56 input.tar.gz [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 0 Jun 3 13:56 boinc_lockfile [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 0 Jun 4 11:36 wrapper_sigint_43734 [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 0 Jun 4 11:39 wrapper_sigkill_43734 [2025-06-05 06:39:52] drwxrwx--x. 2 boincer umatlas 4096 Jun 4 11:39 shared [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 2525 Jun 4 11:49 pandaJob.out [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 990989 Jun 4 11:49 agis_schedconf.cvmfs.json [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 179917514 Jun 5 05:32 HITS.45006595._035822.pool.root.1 [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 531 Jun 5 05:33 boinc_task_state.xml [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 98 Jun 5 05:33 pilot_heartbeat.json [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 1046 Jun 5 05:33 memory_monitor_summary.json [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 1598969 Jun 5 05:34 agis_ddmendpoints.agis.ALL.json [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 694701 Jun 5 05:34 log.45006595._035822.job.log.tgz.1 [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 7730 Jun 5 05:34 heartbeat.json [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 4353 Jun 5 05:34 pilotlog.txt [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 3384728 Jun 5 05:34 log.45006595._035822.job.log.1 [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 357 Jun 5 05:34 output.list [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 620 Jun 5 05:34 runtime_log [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 4096000 Jun 5 05:34 result.tar.gz [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 8740 Jun 5 05:34 runtime_log.err [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 1388 Jun 5 05:34 rhoMDmH2hg7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmebkKDmqAN7Hn.diag [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 6521 Jun 5 06:37 init_data.xml [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 28 Jun 5 06:39 wrapper_checkpoint.txt [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 8192 Jun 5 06:39 boinc_mmap_file [2025-06-05 06:39:52] -rw-r--r--. 1 boincer umatlas 38598 Jun 5 06:39 stderr.txt [2025-06-05 06:39:52] HITS file was successfully produced: [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 179917514 Jun 5 05:32 shared/HITS.pool.root.1 [2025-06-05 06:39:52] *** Contents of shared directory: *** [2025-06-05 06:39:52] total 388648 [2025-06-05 06:39:52] -rw-r--r--. 3 boincer umatlas 213424764 Jun 3 13:56 ATLAS.root_0 [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 13:56 start_atlas.sh [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 508884 Jun 3 13:56 input.tar.gz [2025-06-05 06:39:52] -rw-------. 1 boincer umatlas 179917514 Jun 5 05:32 HITS.pool.root.1 [2025-06-05 06:39:52] -rw-r--r--. 2 boincer umatlas 4096000 Jun 5 05:34 result.tar.gz 06:40:14 (97661): run_atlas exited; CPU time 72623.858282 06:40:14 (97661): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN