| Name | HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun_1 |
| Workunit | 232822358 |
| Created | 3 Jun 2025, 16:19:37 UTC |
| Sent | 3 Jun 2025, 17:23:59 UTC |
| Report deadline | 11 Jun 2025, 17:23:59 UTC |
| Received | 4 Jun 2025, 4:37:45 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10874990 |
| Run time | 9 hours 18 min 8 sec |
| CPU time | 1 days 10 hours 52 min 34 sec |
| Validate state | Valid |
| Credit | 287.42 |
| 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 | 796.75 MB |
Stderr output
<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
13:24:33 (2645410): wrapper (7.7.26015): starting
13:24:33 (2645410): wrapper: running run_atlas (--nthreads 8)
[2025-06-03 13:24:33] Arguments: --nthreads 8
[2025-06-03 13:24:33] Threads: 8
[2025-06-03 13:24:33] Checking for CVMFS
[2025-06-03 13:24:34] Probing /cvmfs/atlas.cern.ch... OK
[2025-06-03 13:24:34] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-06-03 13:24:34] Running cvmfs_config stat atlas.cern.ch
[2025-06-03 13:24:34] 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:24:34] 2.12.6.0 3235747 90333 596396 146750 3 66 11555818 21042177 4030 16776704 2 240588561 99.288 467119415 25477 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1
[2025-06-03 13:24:34] CVMFS is ok
[2025-06-03 13:24:34] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-06-03 13:24:34] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-06-03 13:24:34] Further information can be found at the LHC@home message board.
[2025-06-03 13:24:34] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-06-03 13:24:34] Checking for apptainer binary...
[2025-06-03 13:24:34] Using apptainer found in PATH at /usr/bin/apptainer
[2025-06-03 13:24:34] Running /usr/bin/apptainer --version
[2025-06-03 13:24:34] apptainer version 1.4.1-1.el9
[2025-06-03 13:24:34] 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:24:35] c-16-11.aglt2.org
[2025-06-03 13:24:35] apptainer works
[2025-06-03 13:24:35] Set ATHENA_PROC_NUMBER=8
[2025-06-03 13:24:35] Set ATHENA_CORE_NUMBER=8
[2025-06-03 13:24:35] Starting ATLAS job with PandaID=6677675632
[2025-06-03 13:24:35] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
18:27:42 (160291): wrapper (7.7.26015): starting
18:27:42 (160291): wrapper: running run_atlas (--nthreads 6)
[2025-06-03 18:27:42] Arguments: --nthreads 6
[2025-06-03 18:27:42] Threads: 6
[2025-06-03 18:27:42] This job has been restarted, cleaning up previous attempt
[2025-06-03 18:27:42] Checking for CVMFS
[2025-06-03 18:27:42] Probing /cvmfs/atlas.cern.ch... OK
[2025-06-03 18:27:42] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-06-03 18:27:42] Running cvmfs_config stat atlas.cern.ch
[2025-06-03 18:27:43] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2025-06-03 18:27:43] 2.12.6.0 3235747 90637 596228 146760 1 70 18444509 21042176 13261 16776704 2 242547356 99.290 469168434 25454 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1
[2025-06-03 18:27:43] CVMFS is ok
[2025-06-03 18:27:43] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-06-03 18:27:43] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-06-03 18:27:43] Further information can be found at the LHC@home message board.
[2025-06-03 18:27:43] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-06-03 18:27:43] Checking for apptainer binary...
[2025-06-03 18:27:43] Using apptainer found in PATH at /usr/bin/apptainer
[2025-06-03 18:27:43] Running /usr/bin/apptainer --version
[2025-06-03 18:27:43] apptainer version 1.4.1-1.el9
[2025-06-03 18:27:43] 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 18:27:43] c-16-11.aglt2.org
[2025-06-03 18:27:43] apptainer works
[2025-06-03 18:27:43] Set ATHENA_PROC_NUMBER=6
[2025-06-03 18:27:43] Set ATHENA_CORE_NUMBER=6
[2025-06-03 18:27:43] Starting ATLAS job with PandaID=6677675632
[2025-06-03 18:27:43] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-06-03 18:31:04] Job failed
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/0/
[2025-06-03 18:31:04] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/0/
[2025-06-03 18:31:04] + mv ATLAS.root_0 EVNT.45006593._001444.pool.root.1
[2025-06-03 18:31:04] mv: ‘ATLAS.root_0’ and ‘EVNT.45006593._001444.pool.root.1’ are the same file
[2025-06-03 18:31:04] + tar --strip-components=5 -xvf input.tar.gz
[2025-06-03 18:31:04] + umask 077
[2025-06-03 18:31:04] ++ date +%s
[2025-06-03 18:31:04] + ACCOUNTING_STARTTIME=1748989664
[2025-06-03 18:31:04] + echo 'Detecting resource accounting method available for the job.'
[2025-06-03 18:31:04] Detecting resource accounting method available for the job.
[2025-06-03 18:31:04] + JOB_ACCOUNTING=
[2025-06-03 18:31:04] + command -v arc-job-cgroup
[2025-06-03 18:31:04] + '[' -z '' ']'
[2025-06-03 18:31:04] + GNU_TIME=/usr/bin/time
[2025-06-03 18:31:04] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2025-06-03 18:31:04] Looking for /usr/bin/time tool for accounting measurements
[2025-06-03 18:31:04] + '[' '!' -z /usr/bin/time ']'
[2025-06-03 18:31:04] + /usr/bin/time --version
[2025-06-03 18:31:04] + echo 'GNU time found and will be used for job accounting.'
[2025-06-03 18:31:04] GNU time found and will be used for job accounting.
[2025-06-03 18:31:04] + JOB_ACCOUNTING=gnutime
[2025-06-03 18:31:04] + '[' -z gnutime ']'
[2025-06-03 18:31:04] + export PANDA_JSID=harvester-CERN_central_ACTA
[2025-06-03 18:31:04] + PANDA_JSID=harvester-CERN_central_ACTA
[2025-06-03 18:31:04] + export GTAG=http://aipanda403.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677675632.out
[2025-06-03 18:31:04] + GTAG=http://aipanda403.cern.ch/data/jobs/2025-06-03/BOINC_MCORE/6677675632.out
[2025-06-03 18:31:04] + export PILOT_NOKILL=YES
[2025-06-03 18:31:04] + PILOT_NOKILL=YES
[2025-06-03 18:31:04] + export GRID_GLOBAL_JOBID=HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun
[2025-06-03 18:31:04] + GRID_GLOBAL_JOBID=HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun
[2025-06-03 18:31:04] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun
[2025-06-03 18:31:04] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun
[2025-06-03 18:31:04] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-06-03 18:31:04] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-06-03 18:31:04] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-06-03 18:31:04] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/0
[2025-06-03 18:31:04] + RUNTIME_JOB_STDIN=/dev/null
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/0/log.45006595._035932.job.log.1
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/0/log.45006595._035932.job.log.1
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/0.diag
[2025-06-03 18:31:04] + '[' '!' -z '' ']'
[2025-06-03 18:31:04] + RUNTIME_LOCAL_SCRATCH_DIR=
[2025-06-03 18:31:04] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2025-06-03 18:31:04] + RUNTIME_FRONTEND_SEES_NODE=
[2025-06-03 18:31:04] + RUNTIME_NODE_SEES_FRONTEND=yes
[2025-06-03 18:31:04] + '[' '!' -z '' ']'
[2025-06-03 18:31:04] + '[' -z yes ']'
[2025-06-03 18:31:04] ++ pwd
[2025-06-03 18:31:04] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/0/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.diag
[2025-06-03 18:31:04] + runtimeenvironments=
[2025-06-03 18:31:04] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-06-03 18:31:04] + RTE_function_0 1
[2025-06-03 18:31:04] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-06-03 18:31:04] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-06-03 18:31:04] + export BOINC_APP=ATLAS
[2025-06-03 18:31:04] + BOINC_APP=ATLAS
[2025-06-03 18:31:04] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-06-03 18:31:04] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-06-03 18:31:04] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-06-03 18:31:04] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-06-03 18:31:04] + '[' -z 1 ']'
[2025-06-03 18:31:04] + '[' 1 == 1 ']'
[2025-06-03 18:31:04] + shift
[2025-06-03 18:31:04] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/0/
[2025-06-03 18:31:04] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/0/
[2025-06-03 18:31:04] + '[' 0 -ne 0 ']'
[2025-06-03 18:31:04] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2025-06-03 18:31:04] + '[' -f /etc/os-release ']'
[2025-06-03 18:31:04] +++ cat /etc/os-release
[2025-06-03 18:31:04] ++ eval 'NAME="CentOS' 'Linux"' 'VERSION="7' '(Core)"' 'ID="centos"' 'ID_LIKE="rhel' 'fedora"' 'VERSION_ID="7"' 'PRETTY_NAME="CentOS' Linux 7 '(Core)"' 'ANSI_COLOR="0;31"' 'CPE_NAME="cpe:/o:centos:centos:7"' 'HOME_URL="https://www.centos.org/"' 'BUG_REPORT_URL="https://bugs.centos.org/"' 'CENTOS_MANTISBT_PROJECT="CentOS-7"' 'CENTOS_MANTISBT_PROJECT_VERSION="7"' 'REDHAT_SUPPORT_PRODUCT="centos"' 'REDHAT_SUPPORT_PRODUCT_VERSION="7"'
[2025-06-03 18:31:04] +++ NAME='CentOS Linux'
[2025-06-03 18:31:04] +++ VERSION='7 (Core)'
[2025-06-03 18:31:04] +++ ID=centos
[2025-06-03 18:31:04] +++ ID_LIKE='rhel fedora'
[2025-06-03 18:31:04] +++ VERSION_ID=7
[2025-06-03 18:31:04] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2025-06-03 18:31:04] +++ ANSI_COLOR='0;31'
[2025-06-03 18:31:04] +++ CPE_NAME=cpe:/o:centos:centos:7
[2025-06-03 18:31:04] +++ HOME_URL=https://www.centos.org/
[2025-06-03 18:31:04] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2025-06-03 18:31:04] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2025-06-03 18:31:04] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2025-06-03 18:31:04] +++ REDHAT_SUPPORT_PRODUCT=centos
[2025-06-03 18:31:04] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2025-06-03 18:31:04] ++ echo 'CentOS Linux 7 (Core)'
[2025-06-03 18:31:04] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2025-06-03 18:31:04] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2025-06-03 18:31:04] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2025-06-03 18:31:04] + HOME=/tmp/boinchome/slots/0
[2025-06-03 18:31:04] + export HOME
[2025-06-03 18:31:04] + cd /tmp/boinchome/slots/0
[2025-06-03 18:31:04] + '[' '!' -z '' ']'
[2025-06-03 18:31:04] + '[' -z '' ']'
[2025-06-03 18:31:04] ++ /bin/hostname -f
[2025-06-03 18:31:04] + nodename=c-16-11.aglt2.org
[2025-06-03 18:31:04] + echo nodename=c-16-11.aglt2.org
[2025-06-03 18:31:04] + echo Processors=2
[2025-06-03 18:31:04] + echo Nodecount=1
[2025-06-03 18:31:04] + echo Benchmark=HEPSPEC:1.0
[2025-06-03 18:31:04] + executable=./runpilot2-wrapper.sh
[2025-06-03 18:31:04] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2025-06-03 18:31:04] ++ dd if=./runpilot2-wrapper.sh count=1
[2025-06-03 18:31:04] ++ head -n 1
[2025-06-03 18:31:04] ++ tr -d '\0'
[2025-06-03 18:31:04] + line1='#!/bin/bash'
[2025-06-03 18:31:04] ++ echo '#!/bin/bash'
[2025-06-03 18:31:04] ++ sed -n 's/^#! *//p'
[2025-06-03 18:31:04] + shebang=/bin/bash
[2025-06-03 18:31:04] ++ echo /bin/bash
[2025-06-03 18:31:04] ++ awk '{print $1}'
[2025-06-03 18:31:04] + interpreter=/bin/bash
[2025-06-03 18:31:04] + '[' /bin/bash = /usr/bin/env ']'
[2025-06-03 18:31:04] + '[' x/bin/bash = x ']'
[2025-06-03 18:31:04] + type /bin/bash
[2025-06-03 18:31:04] + '[' xgnutime = xgnutime ']'
[2025-06-03 18:31:04] + /usr/bin/time -o /tmp/boinchome/slots/0/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.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-03 18:31:04] + RESULT=2
[2025-06-03 18:31:04] + sed -i -e /nodename=/d /tmp/boinchome/slots/0/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.diag
[2025-06-03 18:31:04] ++ grep domain_name init_data.xml
[2025-06-03 18:31:04] ++ awk -F '>' '{print $2}'
[2025-06-03 18:31:04] ++ sed -e 's# #_#g'
[2025-06-03 18:31:04] ++ awk -F '<' '{print $1}'
[2025-06-03 18:31:04] + hostname=c-16-11.aglt2.org
[2025-06-03 18:31:04] ++ grep user_name init_data.xml
[2025-06-03 18:31:04] ++ awk -F '>' '{print $2}'
[2025-06-03 18:31:04] ++ awk -F '<' '{print $1}'
[2025-06-03 18:31:04] ++ sed -e 's# #_#g'
[2025-06-03 18:31:04] + username=AGLT2
[2025-06-03 18:31:04] + nodename=AGLT2@c-16-11.aglt2.org
[2025-06-03 18:31:04] + echo nodename=AGLT2@c-16-11.aglt2.org
[2025-06-03 18:31:04] + '[' -n 6 ']'
[2025-06-03 18:31:04] + sed -i -e s/Processors=1/Processors=6/ /tmp/boinchome/slots/0/HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.diag
[2025-06-03 18:31:04] + echo exitcode=2
[2025-06-03 18:31:04] + runtimeenvironments=
[2025-06-03 18:31:04] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-06-03 18:31:04] + RTE_function_0 2
[2025-06-03 18:31:04] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-06-03 18:31:04] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-06-03 18:31:04] + export BOINC_APP=ATLAS
[2025-06-03 18:31:04] + BOINC_APP=ATLAS
[2025-06-03 18:31:04] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-06-03 18:31:04] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-06-03 18:31:04] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-06-03 18:31:04] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-06-03 18:31:04] + '[' -z 2 ']'
[2025-06-03 18:31:04] + '[' 2 == 1 ']'
[2025-06-03 18:31:04] + '[' 0 -ne 0 ']'
[2025-06-03 18:31:04] + echo 'zip all output files'
[2025-06-03 18:31:04] + flist='*.diag '
[2025-06-03 18:31:04] + for f in ./heartbeat.json ./output.list ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1 ./gmlog/
[2025-06-03 18:31:04] + '[' -e ./heartbeat.json ']'
[2025-06-03 18:31:04] + flist='*.diag ./heartbeat.json'
[2025-06-03 18:31:04] + for f in ./heartbeat.json ./output.list ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1 ./gmlog/
[2025-06-03 18:31:04] + '[' -e ./output.list ']'
[2025-06-03 18:31:04] + for f in ./heartbeat.json ./output.list ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1 ./gmlog/
[2025-06-03 18:31:04] + '[' -e ./log.45006595._035932.job.log.1 ']'
[2025-06-03 18:31:04] + flist='*.diag ./heartbeat.json ./log.45006595._035932.job.log.1'
[2025-06-03 18:31:04] + for f in ./heartbeat.json ./output.list ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1 ./gmlog/
[2025-06-03 18:31:04] + '[' -e ./log.45006595._035932.job.log.1 ']'
[2025-06-03 18:31:04] + flist='*.diag ./heartbeat.json ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1'
[2025-06-03 18:31:04] + for f in ./heartbeat.json ./output.list ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1 ./gmlog/
[2025-06-03 18:31:04] + '[' -e ./gmlog/ ']'
[2025-06-03 18:31:04] + '[' -f output.list ']'
[2025-06-03 18:31:04] + tar cvf result.tar.gz HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.diag ./heartbeat.json ./log.45006595._035932.job.log.1 ./log.45006595._035932.job.log.1
[2025-06-03 18:31:04] + '[' xgnutime = xcgroup ']'
[2025-06-03 18:31:04] + '[' -n '' ']'
[2025-06-03 18:31:04] + '[' -n '' ']'
[2025-06-03 18:31:04] ++ date +%s
[2025-06-03 18:31:04] + ACCOUNTING_ENDTIME=1748989864
[2025-06-03 18:31:04] ++ date -d '1970-01-01 UTC 1748989664 seconds' +%Y%m%d%H%M%SZ
[2025-06-03 18:31:04] + echo LRMSStartTime=20250603182744Z
[2025-06-03 18:31:04] ++ date -d '1970-01-01 UTC 1748989864 seconds' +%Y%m%d%H%M%SZ
[2025-06-03 18:31:04] + echo LRMSEndTime=20250603183104Z
[2025-06-03 18:31:04] + echo walltime=200
[2025-06-03 18:31:04] + echo exitcode=2
[2025-06-03 18:31:04] + exit 2
[2025-06-03 18:31:04] ./runtime_log
[2025-06-03 18:31:04] ./log.45006595._035932.job.log.1
[2025-06-03 18:31:04] ./pilotlog.txt
[2025-06-03 18:31:04] ./PanDA_Pilot-6677675632/log.EVNTtoHITS
[2025-06-03 18:31:04] ./PanDA_Pilot-6677675632/prmon.log
[2025-06-03 18:31:04] ./PanDA_Pilot-6677675632/pilotlog.txt
[2025-06-03 18:31:04] ./PanDA_Pilot-6677675632/PoolFileCatalog.xml
[2025-06-03 18:31:04] ./runtime_log.err
[2025-06-03 18:31:04] ./pilot3/pilot/util/lokirealtimelogger.py
[2025-06-03 18:31:04] ./pilot3/pilot/util/loggingsupport.py
[2025-06-03 18:31:04] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2025-06-03 18:31:04] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2025-06-03 18:31:04] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2025-06-03 18:31:04] ./pilot3/pilot/util/realtimelogger.py
18:47:52 (280784): wrapper (7.7.26015): starting
18:47:52 (280784): wrapper: running run_atlas (--nthreads 9)
[2025-06-03 18:47:52] Arguments: --nthreads 9
[2025-06-03 18:47:52] Threads: 9
[2025-06-03 18:47:52] This job has been restarted, cleaning up previous attempt
[2025-06-03 18:47:52] Checking for CVMFS
[2025-06-03 18:47:52] Probing /cvmfs/atlas.cern.ch... OK
[2025-06-03 18:47:52] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-06-03 18:47:52] Running cvmfs_config stat atlas.cern.ch
[2025-06-03 18:47:52] 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 18:47:52] 2.12.6.0 3235747 90657 598320 146760 1 246 18445822 21042177 13261 16776704 2 242702584 99.290 469168518 25454 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1
[2025-06-03 18:47:52] CVMFS is ok
[2025-06-03 18:47:52] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-06-03 18:47:52] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-06-03 18:47:52] Further information can be found at the LHC@home message board.
[2025-06-03 18:47:52] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-06-03 18:47:52] Checking for apptainer binary...
[2025-06-03 18:47:52] Using apptainer found in PATH at /usr/bin/apptainer
[2025-06-03 18:47:52] Running /usr/bin/apptainer --version
[2025-06-03 18:47:53] apptainer version 1.4.1-1.el9
[2025-06-03 18:47:53] 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 18:47:53] c-16-11.aglt2.org
[2025-06-03 18:47:53] apptainer works
[2025-06-03 18:47:53] Set ATHENA_PROC_NUMBER=9
[2025-06-03 18:47:53] Set ATHENA_CORE_NUMBER=9
[2025-06-03 18:47:53] Starting ATLAS job with PandaID=6677675632
[2025-06-03 18:47:53] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-06-04 00:30:07] *** The last 200 lines of the pilot log: ***
[2025-06-04 00:30:07] 2025-06-04 04:29:47,863 | INFO | extracted standard info from prmon json
[2025-06-04 00:30:07] 2025-06-04 04:29:47,863 | INFO | extracted standard memory fields from prmon json
[2025-06-04 00:30:07] 2025-06-04 04:29:47,863 | WARNING | GPU info not found in prmon json: 'gpu'
[2025-06-04 00:30:07] 2025-06-04 04:29:47,866 | WARNING | format EVNTtoHITS has no such key: dbData
[2025-06-04 00:30:07] 2025-06-04 04:29:47,866 | WARNING | format EVNTtoHITS has no such key: dbTime
[2025-06-04 00:30:07] 2025-06-04 04:29:47,881 | INFO | fitting pss+swap vs Time
[2025-06-04 00:30:07] 2025-06-04 04:29:47,882 | INFO | sum of square deviations: 11657884977.809013
[2025-06-04 00:30:07] 2025-06-04 04:29:47,891 | INFO | sum of deviations: 68158786203.60592
[2025-06-04 00:30:07] 2025-06-04 04:29:47,892 | INFO | mean x: 1749001133.4238806
[2025-06-04 00:30:07] 2025-06-04 04:29:47,892 | INFO | mean y: 2171265.749253731
[2025-06-04 00:30:07] 2025-06-04 04:29:47,892 | INFO | -- intersect: -10223508139.204613
[2025-06-04 00:30:07] 2025-06-04 04:29:47,892 | INFO | intersect: -10223508139.204613
[2025-06-04 00:30:07] 2025-06-04 04:29:47,893 | INFO | chi2: 4.071371221160473
[2025-06-04 00:30:07] 2025-06-04 04:29:47,893 | INFO | sum of square deviations: 11143634569.951529
[2025-06-04 00:30:07] 2025-06-04 04:29:47,901 | INFO | sum of deviations: 89683656379.06668
[2025-06-04 00:30:07] 2025-06-04 04:29:47,901 | INFO | mean x: 1749000980.9212122
[2025-06-04 00:30:07] 2025-06-04 04:29:47,906 | INFO | mean y: 2177578.2333333334
[2025-06-04 00:30:07] 2025-06-04 04:29:47,906 | INFO | -- intersect: -14073732933.275019
[2025-06-04 00:30:07] 2025-06-04 04:29:47,906 | INFO | intersect: -14073732933.275019
[2025-06-04 00:30:07] 2025-06-04 04:29:47,907 | INFO | chi2: 3.264793685697676
[2025-06-04 00:30:07] 2025-06-04 04:29:47,907 | INFO | current chi2=3.264793685697676 (change=19.810955367339268 %)
[2025-06-04 00:30:07] 2025-06-04 04:29:47,907 | INFO | right removable region: 329
[2025-06-04 00:30:07] 2025-06-04 04:29:47,908 | INFO | sum of square deviations: 11143608769.397043
[2025-06-04 00:30:07] 2025-06-04 04:29:47,911 | INFO | sum of deviations: -192627190.18180466
[2025-06-04 00:30:07] 2025-06-04 04:29:47,916 | INFO | mean x: 1749001285.930303
[2025-06-04 00:30:07] 2025-06-04 04:29:47,916 | INFO | mean y: 2191485.8181818184
[2025-06-04 00:30:07] 2025-06-04 04:29:47,916 | INFO | -- intersect: 32424528.839069083
[2025-06-04 00:30:07] 2025-06-04 04:29:47,916 | INFO | intersect: 32424528.839069083
[2025-06-04 00:30:07] 2025-06-04 04:29:47,917 | INFO | chi2: 1.874893945207683
[2025-06-04 00:30:07] 2025-06-04 04:29:47,917 | INFO | current chi2=1.874893945207683 (change=53.94932460437059 %)
[2025-06-04 00:30:07] 2025-06-04 04:29:47,918 | INFO | sum of square deviations: 10644681685.956907
[2025-06-04 00:30:07] 2025-06-04 04:29:47,923 | INFO | sum of deviations: -37448967871.57843
[2025-06-04 00:30:07] 2025-06-04 04:29:47,924 | INFO | mean x: 1749001438.436923
[2025-06-04 00:30:07] 2025-06-04 04:29:47,924 | INFO | mean y: 2202858.5815384616
[2025-06-04 00:30:07] 2025-06-04 04:29:47,924 | INFO | -- intersect: 6155350562.545106
[2025-06-04 00:30:07] 2025-06-04 04:29:47,924 | INFO | intersect: 6155350562.545106
[2025-06-04 00:30:07] 2025-06-04 04:29:47,925 | INFO | chi2: 1.2502756807536066
[2025-06-04 00:30:07] 2025-06-04 04:29:47,925 | INFO | current chi2=1.2502756807536066 (change=33.314858477762435 %)
[2025-06-04 00:30:07] 2025-06-04 04:29:47,926 | INFO | sum of square deviations: 10160871164.987555
[2025-06-04 00:30:07] 2025-06-04 04:29:47,934 | INFO | sum of deviations: -46936998759.08747
[2025-06-04 00:30:07] 2025-06-04 04:29:47,934 | INFO | mean x: 1749001590.94375
[2025-06-04 00:30:07] 2025-06-04 04:29:47,934 | INFO | mean y: 2205835.10625
[2025-06-04 00:30:07] 2025-06-04 04:29:47,939 | INFO | -- intersect: 8081521493.260189
[2025-06-04 00:30:07] 2025-06-04 04:29:47,939 | INFO | intersect: 8081521493.260189
[2025-06-04 00:30:07] 2025-06-04 04:29:47,940 | INFO | chi2: 1.181978267434505
[2025-06-04 00:30:07] 2025-06-04 04:29:47,940 | INFO | current chi2=1.181978267434505 (change=5.462588321156118 %)
[2025-06-04 00:30:07] 2025-06-04 04:29:47,940 | INFO | left removable region: 30
[2025-06-04 00:30:07] 2025-06-04 04:29:47,941 | INFO | sum of square deviations: 8288739922.227432
[2025-06-04 00:30:07] 2025-06-04 04:29:47,952 | INFO | sum of deviations: 12168781932.953182
[2025-06-04 00:30:07] 2025-06-04 04:29:47,952 | INFO | mean x: 1749001865.458194
[2025-06-04 00:30:07] 2025-06-04 04:29:47,953 | INFO | mean y: 2200761.8762541804
[2025-06-04 00:30:07] 2025-06-04 04:29:47,953 | INFO | -- intersect: -2565526359.5906777
[2025-06-04 00:30:07] 2025-06-04 04:29:47,953 | INFO | intersect: -2565526359.5906777
[2025-06-04 00:30:07] 2025-06-04 04:29:47,954 | INFO | chi2: 0.11273703192084415
[2025-06-04 00:30:07] 2025-06-04 04:29:47,954 | INFO | -- intersect: -2565526359.5906777
[2025-06-04 00:30:07] 2025-06-04 04:29:47,954 | INFO | current memory leak: 1.47 B/s (using 299 data points, chi2=0.11)
[2025-06-04 00:30:07] 2025-06-04 04:29:47,959 | INFO | ..............................
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . Timing measurements:
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . get job = 0 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . initial setup = 1 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . payload setup = 14 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . stage-in = 0 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . payload execution = 20420 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,960 | INFO | . stage-out = 8 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,961 | INFO | . log creation = 0 s
[2025-06-04 00:30:07] 2025-06-04 04:29:47,961 | INFO | ..............................
[2025-06-04 00:30:07] 2025-06-04 04:29:48,484 | INFO |
[2025-06-04 00:30:07] 2025-06-04 04:29:48,485 | INFO | job summary report
[2025-06-04 00:30:07] 2025-06-04 04:29:48,485 | INFO | --------------------------------------------------
[2025-06-04 00:30:07] 2025-06-04 04:29:48,485 | INFO | PanDA job id: 6677675632
[2025-06-04 00:30:07] 2025-06-04 04:29:48,485 | INFO | task id: 45006595
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | errors: (none)
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | status: LOG_TRANSFER = DONE
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | pilot state: finished
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | transexitcode: 0
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | exeerrorcode: 0
[2025-06-04 00:30:07] 2025-06-04 04:29:48,486 | INFO | exeerrordiag:
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | exitcode: 0
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | exitmsg: OK
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | cpuconsumptiontime: 72365 s
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | nevents: 400
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | neventsw: 0
[2025-06-04 00:30:07] 2025-06-04 04:29:48,487 | INFO | pid: 291626
[2025-06-04 00:30:07] 2025-06-04 04:29:48,488 | INFO | pgrp: 291626
[2025-06-04 00:30:07] 2025-06-04 04:29:48,488 | INFO | corecount: 9
[2025-06-04 00:30:07] 2025-06-04 04:29:48,488 | INFO | event service: False
[2025-06-04 00:30:07] 2025-06-04 04:29:48,488 | INFO | sizes: {0: 2404356, 1: 2405041, 2: 2405240, 12: 2405446, 13: 2405474, 20439: 2437464, 20440: 2437591, 20448: 2446616, 20452: 2446672, 20472: 2446842}
[2025-06-04 00:30:07] 2025-06-04 04:29:48,495 | INFO | --------------------------------------------------
[2025-06-04 00:30:07] 2025-06-04 04:29:48,495 | INFO |
[2025-06-04 00:30:07] 2025-06-04 04:29:48,496 | INFO | executing command: ls -lF /tmp/boinchome/slots/0
[2025-06-04 00:30:07] 2025-06-04 04:29:48,619 | INFO | queue jobs had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,620 | INFO | queue payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,620 | INFO | queue data_in had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,620 | INFO | queue data_out had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,623 | INFO | queue current_data_in had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,623 | INFO | queue validated_jobs had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,623 | INFO | queue validated_payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,623 | INFO | queue monitored_payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue finished_jobs had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue finished_payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue finished_data_in had 1 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue finished_data_out had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue failed_jobs had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,624 | INFO | queue failed_payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue failed_data_in had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue failed_data_out had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue completed_jobs had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue completed_jobids has 1 job(s)
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue realtimelog_payloads had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,625 | INFO | queue messages had 0 job(s) [purged]
[2025-06-04 00:30:07] 2025-06-04 04:29:48,626 | INFO | job 6677675632 has completed (purged errors)
[2025-06-04 00:30:07] 2025-06-04 04:29:48,634 | INFO | overall cleanup function is called
[2025-06-04 00:30:07] 2025-06-04 04:29:49,649 | INFO | --- collectZombieJob: --- 10, [291626]
[2025-06-04 00:30:07] 2025-06-04 04:29:49,650 | INFO | zombie collector waiting for pid 291626
[2025-06-04 00:30:07] 2025-06-04 04:29:49,650 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-06-04 00:30:07] 2025-06-04 04:29:49,650 | INFO | collected zombie processes
[2025-06-04 00:30:07] 2025-06-04 04:29:49,650 | INFO | will attempt to kill all subprocesses of pid=291626
[2025-06-04 00:30:07] 2025-06-04 04:29:54,983 | INFO | process IDs to be killed: [291626] (in reverse order)
[2025-06-04 00:30:07] 2025-06-04 04:29:55,476 | WARNING | found no corresponding commands to process id(s)
[2025-06-04 00:30:07] 2025-06-04 04:29:55,477 | INFO | Do not look for orphan processes in BOINC jobs
[2025-06-04 00:30:07] 2025-06-04 04:29:55,773 | INFO | did not find any defunct processes belonging to 291626
[2025-06-04 00:30:07] 2025-06-04 04:29:56,016 | INFO | did not find any defunct processes belonging to 291626
[2025-06-04 00:30:07] 2025-06-04 04:29:56,016 | INFO | ready for new job
[2025-06-04 00:30:07] 2025-06-04 04:29:56,017 | INFO | pilot has finished with previous job - re-establishing logging
[2025-06-04 00:30:07] 2025-06-04 04:29:56,019 | INFO | **************************************
[2025-06-04 00:30:07] 2025-06-04 04:29:56,019 | INFO | *** PanDA Pilot version 3.10.2.2 ***
[2025-06-04 00:30:07] 2025-06-04 04:29:56,020 | INFO | **************************************
[2025-06-04 00:30:07] 2025-06-04 04:29:56,020 | INFO |
[2025-06-04 00:30:07] 2025-06-04 04:29:56,035 | INFO | architecture information:
[2025-06-04 00:30:07] 2025-06-04 04:29:56,045 | INFO | executing command: cat /etc/os-release
[2025-06-04 00:30:07] 2025-06-04 04:29:56,092 | INFO | cat /etc/os-release:
[2025-06-04 00:30:07] NAME="CentOS Linux"
[2025-06-04 00:30:07] VERSION="7 (Core)"
[2025-06-04 00:30:07] ID="centos"
[2025-06-04 00:30:07] ID_LIKE="rhel fedora"
[2025-06-04 00:30:07] VERSION_ID="7"
[2025-06-04 00:30:07] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-06-04 00:30:07] ANSI_COLOR="0;31"
[2025-06-04 00:30:07] CPE_NAME="cpe:/o:centos:centos:7"
[2025-06-04 00:30:07] HOME_URL="https://www.centos.org/"
[2025-06-04 00:30:07] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-06-04 00:30:07]
[2025-06-04 00:30:07] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-06-04 00:30:07] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-06-04 00:30:07] REDHAT_SUPPORT_PRODUCT="centos"
[2025-06-04 00:30:07] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-06-04 00:30:07]
[2025-06-04 00:30:07] 2025-06-04 04:29:56,092 | INFO | **************************************
[2025-06-04 00:30:07] 2025-06-04 04:29:56,597 | INFO | executing command: df -mP /tmp/boinchome/slots/0
[2025-06-04 00:30:07] 2025-06-04 04:29:56,670 | INFO | sufficient remaining disk space (51768197120 B)
[2025-06-04 00:30:07] 2025-06-04 04:29:56,671 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job
[2025-06-04 00:30:07] 2025-06-04 04:29:56,671 | INFO | current server update state: UPDATING_FINAL
[2025-06-04 00:30:07] 2025-06-04 04:29:56,671 | INFO | update_server=False
[2025-06-04 00:30:07] 2025-06-04 04:29:56,671 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-06-04 00:30:07] 2025-06-04 04:29:56,672 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-06-04 00:30:07] 2025-06-04 04:29:56,682 | INFO | all payload control threads have been joined
[2025-06-04 00:30:07] 2025-06-04 04:29:56,767 | INFO | all job control threads have been joined
[2025-06-04 00:30:07] 2025-06-04 04:29:56,864 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2025-06-04 00:30:07] 2025-06-04 04:29:56,865 | INFO | aborting loop
[2025-06-04 00:30:07] 2025-06-04 04:29:57,164 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2025-06-04 00:30:07] 2025-06-04 04:29:57,230 | INFO | all data control threads have been joined
[2025-06-04 00:30:07] 2025-06-04 04:29:57,350 | INFO | PID=284565 has CPU usage=19.3% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i P
[2025-06-04 00:30:07] 2025-06-04 04:29:57,350 | INFO | .. there are 30 such processes running
[2025-06-04 00:30:07] 2025-06-04 04:29:57,351 | INFO | found 0 job(s) in 20 queues
[2025-06-04 00:30:07] 2025-06-04 04:29:57,351 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2025-06-04 00:30:07] 2025-06-04 04:29:57,351 | WARNING | will wait for a maximum of 300 s for threads to finish
[2025-06-04 00:30:07] 2025-06-04 04:29:57,531 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2025-06-04 00:30:07] 2025-06-04 04:29:57,677 | INFO | [job] retrieve thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:57,688 | INFO | [payload] control thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:57,775 | INFO | [job] control thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:57,872 | INFO | [job] job monitor thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,067 | INFO | [payload] failed_post thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,164 | INFO | [job] validate thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,170 | INFO | [job] queue monitor thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,249 | INFO | [data] control thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,453 | INFO | [payload] run_realtimelog thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,586 | INFO | [payload] validate_pre thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,598 | INFO | [data] copytool_in thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,778 | INFO | [job] create_data_payload thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,789 | INFO | [payload] validate_post thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:58,902 | INFO | [payload] execute_payloads thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:29:59,537 | INFO | [data] copytool_out thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:30:00,679 | INFO | [data] queue_monitor thread has finished
[2025-06-04 00:30:07] 2025-06-04 04:30:01,466 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139641967941440)>', '<ExcThread(monitor, started 139641256666880)>']
[2025-06-04 00:30:07] 2025-06-04 04:30:02,376 | WARNING | job_aborted has been set - aborting pilot monitoring
[2025-06-04 00:30:07] 2025-06-04 04:30:02,377 | INFO | [monitor] control thread has ended
[2025-06-04 00:30:07] 2025-06-04 04:30:06,492 | INFO | all workflow threads have been joined
[2025-06-04 00:30:07] 2025-06-04 04:30:06,493 | INFO | end of generic workflow (traces error code: 0)
[2025-06-04 00:30:07] 2025-06-04 04:30:06,493 | INFO | traces error code: 0
[2025-06-04 00:30:07] 2025-06-04 04:30:06,493 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2025-06-04 00:30:07] 2025-06-04 04:30:06,758 [wrapper] ==== pilot stdout END ====
[2025-06-04 00:30:07] 2025-06-04 04:30:06,761 [wrapper] ==== wrapper stdout RESUME ====
[2025-06-04 00:30:07] 2025-06-04 04:30:06,764 [wrapper] pilotpid: 284565
[2025-06-04 00:30:07] 2025-06-04 04:30:06,767 [wrapper] Pilot exit status: 0
[2025-06-04 00:30:07] 2025-06-04 04:30:06,853 [wrapper] pandaids: 6677675632 6677675632 6677675632
[2025-06-04 00:30:07] 2025-06-04 04:30:07,357 [wrapper] cleanup supervisor_pilot 1818617 284566
[2025-06-04 00:30:07] 2025-06-04 04:30:07,382 [wrapper] Test setup, not cleaning
[2025-06-04 00:30:07] 2025-06-04 04:30:07,388 [wrapper] apfmon messages muted
[2025-06-04 00:30:07] 2025-06-04 04:30:07,420 [wrapper] ==== wrapper stdout END ====
[2025-06-04 00:30:07] 2025-06-04 04:30:07,467 [wrapper] ==== wrapper stderr END ====
[2025-06-04 00:30:07] *** Error codes and diagnostics ***
[2025-06-04 00:30:07] "exeErrorCode": 0,
[2025-06-04 00:30:07] "exeErrorDiag": "",
[2025-06-04 00:30:07] "pilotErrorCode": 0,
[2025-06-04 00:30:07] "pilotErrorDiag": "",
[2025-06-04 00:30:07] *** Listing of results directory ***
[2025-06-04 00:30:08] total 600276
[2025-06-04 00:30:08] drwx------. 4 boincer umatlas 4096 Apr 3 04:00 pilot3
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 495897 Jun 3 10:47 pilot3.tar.gz
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 5111 Jun 3 10:51 queuedata.json
[2025-06-04 00:30:08] -rwx------. 1 boincer umatlas 37140 Jun 3 10:51 runpilot2-wrapper.sh
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 100 Jun 3 13:24 wrapper_26015_x86_64-pc-linux-gnu
[2025-06-04 00:30:08] -rwxr-xr-x. 1 boincer umatlas 7986 Jun 3 13:24 run_atlas
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 105 Jun 3 13:24 job.xml
[2025-06-04 00:30:08] -rw-r--r--. 3 boincer umatlas 216096826 Jun 3 13:24 EVNT.45006593._001444.pool.root.1
[2025-06-04 00:30:08] -rw-r--r--. 3 boincer umatlas 216096826 Jun 3 13:24 ATLAS.root_0
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 13:24 start_atlas.sh
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 508879 Jun 3 13:24 input.tar.gz
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 0 Jun 3 13:24 boinc_lockfile
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 0 Jun 3 18:28 wrapper_sigint_172763
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 0 Jun 3 18:31 wrapper_sigkill_172763
[2025-06-04 00:30:08] drwxrwx--x. 2 boincer umatlas 4096 Jun 3 18:31 shared
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 2525 Jun 3 18:47 pandaJob.out
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 986861 Jun 3 18:48 agis_schedconf.cvmfs.json
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 6523 Jun 4 00:22 init_data.xml
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 175417479 Jun 4 00:28 HITS.45006595._035932.pool.root.1
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 532 Jun 4 00:28 boinc_task_state.xml
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 1033 Jun 4 00:29 memory_monitor_summary.json
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 97 Jun 4 00:29 pilot_heartbeat.json
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 1603667 Jun 4 00:29 agis_ddmendpoints.agis.ALL.json
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 419349 Jun 4 00:29 log.45006595._035932.job.log.tgz.1
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 8192 Jun 4 00:29 boinc_mmap_file
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 29 Jun 4 00:29 wrapper_checkpoint.txt
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 7702 Jun 4 00:29 heartbeat.json
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 4748 Jun 4 00:30 pilotlog.txt
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 1186141 Jun 4 00:30 log.45006595._035932.job.log.1
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 357 Jun 4 00:30 output.list
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 620 Jun 4 00:30 runtime_log
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 1628160 Jun 4 00:30 result.tar.gz
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 8740 Jun 4 00:30 runtime_log.err
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 1388 Jun 4 00:30 HmgMDmHAig7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmudkKDmbmziun.diag
[2025-06-04 00:30:08] -rw-r--r--. 1 boincer umatlas 38206 Jun 4 00:30 stderr.txt
[2025-06-04 00:30:08] HITS file was successfully produced:
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 175417479 Jun 4 00:28 shared/HITS.pool.root.1
[2025-06-04 00:30:08] *** Contents of shared directory: ***
[2025-06-04 00:30:08] total 384456
[2025-06-04 00:30:08] -rw-r--r--. 3 boincer umatlas 216096826 Jun 3 13:24 ATLAS.root_0
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 15093 Jun 3 13:24 start_atlas.sh
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 508879 Jun 3 13:24 input.tar.gz
[2025-06-04 00:30:08] -rw-------. 1 boincer umatlas 175417479 Jun 4 00:28 HITS.pool.root.1
[2025-06-04 00:30:08] -rw-r--r--. 2 boincer umatlas 1628160 Jun 4 00:30 result.tar.gz
00:30:09 (280784): run_atlas exited; CPU time 74928.403508
00:30:09 (280784): called boinc_finish(0)
</stderr_txt>
]]>
©2025 CERN