| Name | AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn_1 |
| Workunit | 232133636 |
| Created | 8 May 2025, 12:25:30 UTC |
| Sent | 8 May 2025, 15:04:18 UTC |
| Report deadline | 16 May 2025, 15:04:18 UTC |
| Received | 10 May 2025, 2:40:16 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10830557 |
| Run time | 1 days 10 hours 43 min 27 sec |
| CPU time | 1 days 18 hours 10 min 57 sec |
| Validate state | Valid |
| Credit | 4,356.03 |
| Device peak FLOPS | 12.00 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 2.51 GB |
| Peak swap size | 31.65 GB |
| Peak disk usage | 6.31 GB |
Stderr output
<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
11:04:48 (40055): wrapper (7.7.26015): starting
11:04:48 (40055): wrapper: running run_atlas (--nthreads 8)
[2025-05-08 11:04:48] Arguments: --nthreads 8
[2025-05-08 11:04:48] Threads: 8
[2025-05-08 11:04:48] Checking for CVMFS
[2025-05-08 11:04:49] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-08 11:04:49] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-08 11:04:49] Running cvmfs_config stat atlas.cern.ch
[2025-05-08 11:04:49] 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-05-08 11:04:49] 2.11.2.0 56398 1252 174384 145760 0 676 11835204 18432001 24481 130560 0 19414185 98.962 41337105 52418 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-08 11:04:49] CVMFS is ok
[2025-05-08 11:04:49] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-08 11:04:49] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-08 11:04:49] Further information can be found at the LHC@home message board.
[2025-05-08 11:04:49] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-08 11:04:49] Checking for apptainer binary...
[2025-05-08 11:04:49] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-08 11:04:49] Running /usr/bin/apptainer --version
[2025-05-08 11:04:49] apptainer version 1.3.2-1.el7
[2025-05-08 11:04:49] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-08 11:04:49] c-212-18.aglt2.org
[2025-05-08 11:04:49] apptainer works
[2025-05-08 11:04:49] Set ATHENA_PROC_NUMBER=8
[2025-05-08 11:04:49] Set ATHENA_CORE_NUMBER=8
[2025-05-08 11:04:49] Starting ATLAS job with PandaID=6636762574
[2025-05-08 11:04:49] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
18:14:56 (40055): BOINC client no longer exists - exiting
18:14:56 (40055): timer handler: client dead, exiting
18:29:39 (50678): wrapper (7.7.26015): starting
18:29:39 (50678): wrapper: running run_atlas (--nthreads 8)
[2025-05-09 18:29:39] Arguments: --nthreads 8
[2025-05-09 18:29:39] Threads: 8
[2025-05-09 18:29:39] This job has been restarted, cleaning up previous attempt
[2025-05-09 18:29:39] Checking for CVMFS
[2025-05-09 18:29:39] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-09 18:29:40] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-09 18:29:40] Running cvmfs_config stat atlas.cern.ch
[2025-05-09 18:29:40] 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-05-09 18:29:40] 2.11.2.0 28926 1772 163152 145812 1 178 13360100 18432001 22955 130560 0 62324690 99.700 46744322 73756 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-09 18:29:40] CVMFS is ok
[2025-05-09 18:29:40] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-09 18:29:40] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-09 18:29:40] Further information can be found at the LHC@home message board.
[2025-05-09 18:29:40] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-09 18:29:40] Checking for apptainer binary...
[2025-05-09 18:29:40] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-09 18:29:40] Running /usr/bin/apptainer --version
[2025-05-09 18:29:40] apptainer version 1.3.2-1.el7
[2025-05-09 18:29:40] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-09 18:29:43] c-212-18.aglt2.org
[2025-05-09 18:29:43] apptainer works
[2025-05-09 18:29:43] Set ATHENA_PROC_NUMBER=8
[2025-05-09 18:29:43] Set ATHENA_CORE_NUMBER=8
[2025-05-09 18:29:43] Starting ATLAS job with PandaID=6636762574
[2025-05-09 18:29:43] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-05-09 18:32:54] Job failed
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/5/
[2025-05-09 18:32:54] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/5/
[2025-05-09 18:32:54] + mv ATLAS.root_0 EVNT.44506061._001594.pool.root.1
[2025-05-09 18:32:54] mv: ‘ATLAS.root_0’ and ‘EVNT.44506061._001594.pool.root.1’ are the same file
[2025-05-09 18:32:54] + tar --strip-components=5 -xvf input.tar.gz
[2025-05-09 18:32:54] + umask 077
[2025-05-09 18:32:54] ++ date +%s
[2025-05-09 18:32:54] + ACCOUNTING_STARTTIME=1746829784
[2025-05-09 18:32:54] + echo 'Detecting resource accounting method available for the job.'
[2025-05-09 18:32:54] Detecting resource accounting method available for the job.
[2025-05-09 18:32:54] + JOB_ACCOUNTING=
[2025-05-09 18:32:54] + command -v arc-job-cgroup
[2025-05-09 18:32:54] + '[' -z '' ']'
[2025-05-09 18:32:54] + GNU_TIME=/usr/bin/time
[2025-05-09 18:32:54] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2025-05-09 18:32:54] Looking for /usr/bin/time tool for accounting measurements
[2025-05-09 18:32:54] + '[' '!' -z /usr/bin/time ']'
[2025-05-09 18:32:54] + /usr/bin/time --version
[2025-05-09 18:32:54] + echo 'GNU time found and will be used for job accounting.'
[2025-05-09 18:32:54] GNU time found and will be used for job accounting.
[2025-05-09 18:32:54] + JOB_ACCOUNTING=gnutime
[2025-05-09 18:32:54] + '[' -z gnutime ']'
[2025-05-09 18:32:54] + export PANDA_JSID=harvester-CERN_central_ACTA
[2025-05-09 18:32:54] + PANDA_JSID=harvester-CERN_central_ACTA
[2025-05-09 18:32:54] + export GTAG=http://aipanda404.cern.ch/data/jobs/2025-05-07/BOINC_MCORE/6636762574.out
[2025-05-09 18:32:54] + GTAG=http://aipanda404.cern.ch/data/jobs/2025-05-07/BOINC_MCORE/6636762574.out
[2025-05-09 18:32:54] + export PILOT_NOKILL=YES
[2025-05-09 18:32:54] + PILOT_NOKILL=YES
[2025-05-09 18:32:54] + export GRID_GLOBAL_JOBID=AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn
[2025-05-09 18:32:54] + GRID_GLOBAL_JOBID=AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn
[2025-05-09 18:32:54] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn
[2025-05-09 18:32:54] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn
[2025-05-09 18:32:54] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-05-09 18:32:54] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-05-09 18:32:54] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-05-09 18:32:54] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/5
[2025-05-09 18:32:54] + RUNTIME_JOB_STDIN=/dev/null
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/5/log.44506063._040563.job.log.1
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/5/log.44506063._040563.job.log.1
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/5.diag
[2025-05-09 18:32:54] + '[' '!' -z '' ']'
[2025-05-09 18:32:54] + RUNTIME_LOCAL_SCRATCH_DIR=
[2025-05-09 18:32:54] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2025-05-09 18:32:54] + RUNTIME_FRONTEND_SEES_NODE=
[2025-05-09 18:32:54] + RUNTIME_NODE_SEES_FRONTEND=yes
[2025-05-09 18:32:54] + '[' '!' -z '' ']'
[2025-05-09 18:32:54] + '[' -z yes ']'
[2025-05-09 18:32:54] ++ pwd
[2025-05-09 18:32:54] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/5/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.diag
[2025-05-09 18:32:54] + runtimeenvironments=
[2025-05-09 18:32:54] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-05-09 18:32:54] + RTE_function_0 1
[2025-05-09 18:32:54] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-05-09 18:32:54] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-05-09 18:32:54] + export BOINC_APP=ATLAS
[2025-05-09 18:32:54] + BOINC_APP=ATLAS
[2025-05-09 18:32:54] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-05-09 18:32:54] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-05-09 18:32:54] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-05-09 18:32:54] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-05-09 18:32:54] + '[' -z 1 ']'
[2025-05-09 18:32:54] + '[' 1 == 1 ']'
[2025-05-09 18:32:54] + shift
[2025-05-09 18:32:54] + FRONTIER_SQUID_NDGF='(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)'
[2025-05-09 18:32:54] + FRONTIER_BACKUP='(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2025-05-09 18:32:54] + FRONTIER_WPAD='(proxyconfigurl=http://grid-wpad/wpad.dat)'
[2025-05-09 18:32:54] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/5/
[2025-05-09 18:32:54] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/5/
[2025-05-09 18:32:54] + '[' -e /tmp/boinchome/slots/5/init_data.xml ']'
[2025-05-09 18:32:54] + grep '<use_http_proxy/>' /tmp/boinchome/slots/5/init_data.xml
[2025-05-09 18:32:54] + '[' -e /tmp/boinchome/slots/5/init_data.xml ']'
[2025-05-09 18:32:54] + grep '.cern.ch</domain_name>' /tmp/boinchome/slots/5/init_data.xml
[2025-05-09 18:32:54] + FRONTIER_SERVER_URLS='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)'
[2025-05-09 18:32:54] + FRONTIER_PROXY_URLS='(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2025-05-09 18:32:54] + echo 'export FRONTIER_SERVER="(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)"'
[2025-05-09 18:32:54] + export 'FRONTIER_SERVER=(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2025-05-09 18:32:54] + FRONTIER_SERVER='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2025-05-09 18:32:54] + '[' 0 -ne 0 ']'
[2025-05-09 18:32:54] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2025-05-09 18:32:54] + '[' -f /etc/os-release ']'
[2025-05-09 18:32:54] +++ cat /etc/os-release
[2025-05-09 18:32:54] ++ 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-05-09 18:32:54] +++ NAME='CentOS Linux'
[2025-05-09 18:32:54] +++ VERSION='7 (Core)'
[2025-05-09 18:32:54] +++ ID=centos
[2025-05-09 18:32:54] +++ ID_LIKE='rhel fedora'
[2025-05-09 18:32:54] +++ VERSION_ID=7
[2025-05-09 18:32:54] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2025-05-09 18:32:54] +++ ANSI_COLOR='0;31'
[2025-05-09 18:32:54] +++ CPE_NAME=cpe:/o:centos:centos:7
[2025-05-09 18:32:54] +++ HOME_URL=https://www.centos.org/
[2025-05-09 18:32:54] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2025-05-09 18:32:54] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2025-05-09 18:32:54] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2025-05-09 18:32:54] +++ REDHAT_SUPPORT_PRODUCT=centos
[2025-05-09 18:32:54] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2025-05-09 18:32:54] ++ echo 'CentOS Linux 7 (Core)'
[2025-05-09 18:32:54] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2025-05-09 18:32:54] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2025-05-09 18:32:54] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2025-05-09 18:32:54] + HOME=/tmp/boinchome/slots/5
[2025-05-09 18:32:54] + export HOME
[2025-05-09 18:32:54] + cd /tmp/boinchome/slots/5
[2025-05-09 18:32:54] + '[' '!' -z '' ']'
[2025-05-09 18:32:54] + '[' -z '' ']'
[2025-05-09 18:32:54] ++ /bin/hostname -f
[2025-05-09 18:32:54] + nodename=c-212-18.aglt2.org
[2025-05-09 18:32:54] + echo nodename=c-212-18.aglt2.org
[2025-05-09 18:32:54] + echo Processors=2
[2025-05-09 18:32:54] + echo Nodecount=1
[2025-05-09 18:32:54] + echo Benchmark=HEPSPEC:1.0
[2025-05-09 18:32:54] + executable=./runpilot2-wrapper.sh
[2025-05-09 18:32:54] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2025-05-09 18:32:54] ++ dd if=./runpilot2-wrapper.sh count=1
[2025-05-09 18:32:54] ++ head -n 1
[2025-05-09 18:32:54] ++ tr -d '\0'
[2025-05-09 18:32:54] + line1='#!/bin/bash'
[2025-05-09 18:32:54] ++ echo '#!/bin/bash'
[2025-05-09 18:32:54] ++ sed -n 's/^#! *//p'
[2025-05-09 18:32:54] + shebang=/bin/bash
[2025-05-09 18:32:54] ++ echo /bin/bash
[2025-05-09 18:32:54] ++ awk '{print $1}'
[2025-05-09 18:32:54] + interpreter=/bin/bash
[2025-05-09 18:32:54] + '[' /bin/bash = /usr/bin/env ']'
[2025-05-09 18:32:54] + '[' x/bin/bash = x ']'
[2025-05-09 18:32:54] + type /bin/bash
[2025-05-09 18:32:54] + '[' xgnutime = xgnutime ']'
[2025-05-09 18:32:54] + /usr/bin/time -o /tmp/boinchome/slots/5/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.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-05-09 18:32:54] + RESULT=2
[2025-05-09 18:32:54] + sed -i -e /nodename=/d /tmp/boinchome/slots/5/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.diag
[2025-05-09 18:32:54] ++ grep domain_name init_data.xml
[2025-05-09 18:32:54] ++ awk -F '>' '{print $2}'
[2025-05-09 18:32:54] ++ awk -F '<' '{print $1}'
[2025-05-09 18:32:54] ++ sed -e 's# #_#g'
[2025-05-09 18:32:54] + hostname=c-212-18.aglt2.org
[2025-05-09 18:32:54] ++ grep user_name init_data.xml
[2025-05-09 18:32:54] ++ sed -e 's# #_#g'
[2025-05-09 18:32:54] ++ awk -F '<' '{print $1}'
[2025-05-09 18:32:54] ++ awk -F '>' '{print $2}'
[2025-05-09 18:32:54] + username=AGLT2
[2025-05-09 18:32:54] + nodename=AGLT2@c-212-18.aglt2.org
[2025-05-09 18:32:54] + echo nodename=AGLT2@c-212-18.aglt2.org
[2025-05-09 18:32:54] + '[' -n 8 ']'
[2025-05-09 18:32:54] + sed -i -e s/Processors=1/Processors=8/ /tmp/boinchome/slots/5/AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.diag
[2025-05-09 18:32:54] + echo exitcode=2
[2025-05-09 18:32:54] + runtimeenvironments=
[2025-05-09 18:32:54] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-05-09 18:32:54] + RTE_function_0 2
[2025-05-09 18:32:54] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-05-09 18:32:54] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-05-09 18:32:54] + export BOINC_APP=ATLAS
[2025-05-09 18:32:54] + BOINC_APP=ATLAS
[2025-05-09 18:32:54] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-05-09 18:32:54] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-05-09 18:32:54] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-05-09 18:32:54] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-05-09 18:32:54] + '[' -z 2 ']'
[2025-05-09 18:32:54] + '[' 2 == 1 ']'
[2025-05-09 18:32:54] + '[' 0 -ne 0 ']'
[2025-05-09 18:32:54] + echo 'zip all output files'
[2025-05-09 18:32:54] + flist='*.diag '
[2025-05-09 18:32:54] + for f in ./heartbeat.json ./output.list ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1 ./gmlog/
[2025-05-09 18:32:54] + '[' -e ./heartbeat.json ']'
[2025-05-09 18:32:54] + flist='*.diag ./heartbeat.json'
[2025-05-09 18:32:54] + for f in ./heartbeat.json ./output.list ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1 ./gmlog/
[2025-05-09 18:32:54] + '[' -e ./output.list ']'
[2025-05-09 18:32:54] + for f in ./heartbeat.json ./output.list ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1 ./gmlog/
[2025-05-09 18:32:54] + '[' -e ./log.44506063._040563.job.log.1 ']'
[2025-05-09 18:32:54] + flist='*.diag ./heartbeat.json ./log.44506063._040563.job.log.1'
[2025-05-09 18:32:54] + for f in ./heartbeat.json ./output.list ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1 ./gmlog/
[2025-05-09 18:32:54] + '[' -e ./log.44506063._040563.job.log.1 ']'
[2025-05-09 18:32:54] + flist='*.diag ./heartbeat.json ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1'
[2025-05-09 18:32:54] + for f in ./heartbeat.json ./output.list ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1 ./gmlog/
[2025-05-09 18:32:54] + '[' -e ./gmlog/ ']'
[2025-05-09 18:32:54] + '[' -f output.list ']'
[2025-05-09 18:32:54] + tar cvf result.tar.gz AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.diag ./heartbeat.json ./log.44506063._040563.job.log.1 ./log.44506063._040563.job.log.1
[2025-05-09 18:32:54] + '[' xgnutime = xcgroup ']'
[2025-05-09 18:32:54] + '[' -n '' ']'
[2025-05-09 18:32:54] + '[' -n '' ']'
[2025-05-09 18:32:54] ++ date +%s
[2025-05-09 18:32:54] + ACCOUNTING_ENDTIME=1746829973
[2025-05-09 18:32:54] ++ date -d '1970-01-01 UTC 1746829784 seconds' +%Y%m%d%H%M%SZ
[2025-05-09 18:32:54] + echo LRMSStartTime=20250509182944Z
[2025-05-09 18:32:54] ++ date -d '1970-01-01 UTC 1746829973 seconds' +%Y%m%d%H%M%SZ
[2025-05-09 18:32:54] + echo LRMSEndTime=20250509183253Z
[2025-05-09 18:32:54] + echo walltime=189
[2025-05-09 18:32:54] + echo exitcode=2
[2025-05-09 18:32:54] + exit 2
[2025-05-09 18:32:54] INFO: Terminating fuse-overlayfs after timeout
[2025-05-09 18:32:54] INFO: Timeouts can be caused by a running background process
[2025-05-09 18:32:54] ./pilot3/pilot/util/lokirealtimelogger.py
[2025-05-09 18:32:54] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2025-05-09 18:32:54] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2025-05-09 18:32:54] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2025-05-09 18:32:54] ./pilot3/pilot/util/realtimelogger.py
[2025-05-09 18:32:54] ./pilot3/pilot/util/loggingsupport.py
[2025-05-09 18:32:54] ./runtime_log.err
[2025-05-09 18:32:54] ./log.44506063._040563.job.log.1
[2025-05-09 18:32:54] ./runtime_log
[2025-05-09 18:32:54] ./pilotlog.txt
[2025-05-09 18:32:54] ./PanDA_Pilot-6636762574/log.EVNTtoHITS
[2025-05-09 18:32:54] ./PanDA_Pilot-6636762574/prmon.log
[2025-05-09 18:32:54] ./PanDA_Pilot-6636762574/pilotlog.txt
[2025-05-09 18:32:54] ./PanDA_Pilot-6636762574/PoolFileCatalog.xml
18:47:56 (67222): wrapper (7.7.26015): starting
18:47:56 (67222): wrapper: running run_atlas (--nthreads 8)
[2025-05-09 18:47:56] Arguments: --nthreads 8
[2025-05-09 18:47:56] Threads: 8
[2025-05-09 18:47:56] This job has been restarted, cleaning up previous attempt
[2025-05-09 18:47:56] Checking for CVMFS
[2025-05-09 18:47:56] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-09 18:47:57] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-09 18:47:57] Running cvmfs_config stat atlas.cern.ch
[2025-05-09 18:47:57] 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-05-09 18:47:57] 2.11.2.0 28926 1790 174448 145812 3 369 14421502 18432000 21682 130560 0 62851285 99.695 47169705 73479 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-09 18:47:57] CVMFS is ok
[2025-05-09 18:47:57] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-09 18:47:57] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-09 18:47:57] Further information can be found at the LHC@home message board.
[2025-05-09 18:47:57] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-09 18:47:57] Checking for apptainer binary...
[2025-05-09 18:47:57] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-09 18:47:57] Running /usr/bin/apptainer --version
[2025-05-09 18:47:57] apptainer version 1.3.2-1.el7
[2025-05-09 18:47:57] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-09 18:47:58] c-212-18.aglt2.org
[2025-05-09 18:47:58] apptainer works
[2025-05-09 18:47:58] Set ATHENA_PROC_NUMBER=8
[2025-05-09 18:47:58] Set ATHENA_CORE_NUMBER=8
[2025-05-09 18:47:58] Starting ATLAS job with PandaID=6636762574
[2025-05-09 18:47:58] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
20:00:10 (67222): BOINC client no longer exists - exiting
20:00:10 (67222): timer handler: client dead, exiting
20:12:04 (79157): wrapper (7.7.26015): starting
20:12:04 (79157): wrapper: running run_atlas (--nthreads 8)
[2025-05-09 20:12:04] Arguments: --nthreads 8
[2025-05-09 20:12:04] Threads: 8
[2025-05-09 20:12:04] This job has been restarted, cleaning up previous attempt
[2025-05-09 20:12:04] Checking for CVMFS
[2025-05-09 20:12:04] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-09 20:12:04] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-09 20:12:04] Running cvmfs_config stat atlas.cern.ch
[2025-05-09 20:12:04] 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-05-09 20:12:04] 2.11.2.0 28926 1874 185040 145813 3 308 17479592 18432000 18228 130560 0 63701394 99.688 48166940 73437 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-09 20:12:04] CVMFS is ok
[2025-05-09 20:12:04] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-09 20:12:04] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-09 20:12:04] Further information can be found at the LHC@home message board.
[2025-05-09 20:12:04] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-09 20:12:04] Checking for apptainer binary...
[2025-05-09 20:12:04] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-09 20:12:04] Running /usr/bin/apptainer --version
[2025-05-09 20:12:04] apptainer version 1.3.2-1.el7
[2025-05-09 20:12:04] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-09 20:12:06] c-212-18.aglt2.org
[2025-05-09 20:12:06] apptainer works
[2025-05-09 20:12:06] Set ATHENA_PROC_NUMBER=8
[2025-05-09 20:12:06] Set ATHENA_CORE_NUMBER=8
[2025-05-09 20:12:06] Starting ATLAS job with PandaID=6636762574
[2025-05-09 20:12:06] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-05-09 22:30:07] *** The last 200 lines of the pilot log: ***
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | sum of square deviations: 681207772.4692303
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | sum of deviations: 42115895283.215385
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | mean x: 1746840200.5153847
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | mean y: 2410077.892307692
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | -- intersect: -107996561652.48384
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | intersect: -107996561652.48384
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | chi2: 2.309691175495537
[2025-05-09 22:30:07] 2025-05-10 02:29:51,495 | INFO | current chi2=2.309691175495537 (change=55.32602743567543 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | sum of square deviations: 605587139.9680004
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | sum of deviations: 13768129667.624002
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | mean x: 1746840353.016
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | mean y: 2467268.688
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | -- intersect: -39712254035.05901
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | intersect: -39712254035.05901
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | chi2: 0.5057383327158897
[2025-05-09 22:30:07] 2025-05-10 02:29:51,496 | INFO | current chi2=0.5057383327158897 (change=78.10363835297656 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | sum of square deviations: 535780569.96666616
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | sum of deviations: 1689781305.5500004
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | mean x: 1746840505.5166667
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | mean y: 2493234.975
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | -- intersect: -5506811498.086189
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | intersect: -5506811498.086189
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | chi2: 0.0011339141927116485
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | current chi2=0.0011339141927116485 (change=99.77579034070398 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,497 | INFO | sum of square deviations: 471555499.96521753
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | sum of deviations: 975973233.9391305
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | mean x: 1746840658.0173912
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | mean y: 2494917.5304347826
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | -- intersect: -3612921987.3881702
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | intersect: -3612921987.3881702
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | chi2: 0.0002489333258621602
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | current chi2=0.0002489333258621602 (change=78.0465464263341 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,498 | INFO | sum of square deviations: 412679367.46363544
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | sum of deviations: 711461046.4363635
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | mean x: 1746840810.5181818
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | mean y: 2495599.7818181817
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | -- intersect: -3009065648.475947
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | intersect: -3009065648.475947
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | chi2: 0.00017535866549204157
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | current chi2=0.00017535866549204157 (change=29.555970505475234 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | sum of square deviations: 358919609.9619045
[2025-05-09 22:30:07] 2025-05-10 02:29:51,499 | INFO | sum of deviations: 508345449.2285714
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | mean x: 1746840963.0190477
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | mean y: 2496175.8857142855
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | -- intersect: -2471591696.245429
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | intersect: -2471591696.245429
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | chi2: 0.00013315066124325732
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | current chi2=0.00013315066124325732 (change=24.069528660218854 %)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | left removable region: 60
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | sum of square deviations: 101843770.0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | sum of deviations: 246717854.99999997
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | mean x: 1746841695.0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | mean y: 2496228.579710145
[2025-05-09 22:30:07] 2025-05-10 02:29:51,500 | INFO | -- intersect: -4229250455.728659
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | intersect: -4229250455.728659
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | chi2: 5.5540149800865824e-05
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | -- intersect: -4229250455.728659
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | current memory leak: 2.42 B/s (using 69 data points, chi2=0.00)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | ..............................
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . Timing measurements:
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . get job = 0 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . initial setup = 0 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . payload setup = 5 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . stage-in = 0 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . payload execution = 8224 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . stage-out = 1 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,501 | INFO | . log creation = 0 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,502 | INFO | ..............................
[2025-05-09 22:30:07] 2025-05-10 02:29:51,560 | INFO |
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | job summary report
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | --------------------------------------------------
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | PanDA job id: 6636762574
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | task id: 44506063
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | errors: (none)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | status: LOG_TRANSFER = DONE
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | pilot state: finished
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | transexitcode: 0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | exeerrorcode: 0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | exeerrordiag:
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | exitcode: 0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | exitmsg: OK
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | cpuconsumptiontime: 36147 s
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | nevents: 400
[2025-05-09 22:30:07] 2025-05-10 02:29:51,561 | INFO | neventsw: 0
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | pid: 51833
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | pgrp: 51833
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | corecount: 8
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | event service: False
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | sizes: {0: 2393688, 4: 2393894, 11: 2393922, 8233: 2421554, 8236: 2430551, 8242: 2430665}
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | --------------------------------------------------
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO |
[2025-05-09 22:30:07] 2025-05-10 02:29:51,562 | INFO | executing command: ls -lF /tmp/boinchome/slots/5
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue jobs had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue data_in had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue data_out had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue current_data_in had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue validated_jobs had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue validated_payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue monitored_payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue finished_jobs had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue finished_payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue finished_data_in had 1 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,579 | INFO | queue finished_data_out had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue failed_jobs had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue failed_payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue failed_data_in had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue failed_data_out had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue completed_jobs had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue completed_jobids has 1 job(s)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue realtimelog_payloads had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | queue messages had 0 job(s) [purged]
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | job 6636762574 has completed (purged errors)
[2025-05-09 22:30:07] 2025-05-10 02:29:51,580 | INFO | overall cleanup function is called
[2025-05-09 22:30:07] 2025-05-10 02:29:52,589 | INFO | --- collectZombieJob: --- 10, [51833]
[2025-05-09 22:30:07] 2025-05-10 02:29:52,589 | INFO | zombie collector waiting for pid 51833
[2025-05-09 22:30:07] 2025-05-10 02:29:52,589 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-05-09 22:30:07] 2025-05-10 02:29:52,589 | INFO | collected zombie processes
[2025-05-09 22:30:07] 2025-05-10 02:29:52,589 | INFO | will attempt to kill all subprocesses of pid=51833
[2025-05-09 22:30:07] 2025-05-10 02:29:52,834 | INFO | process IDs to be killed: [51833] (in reverse order)
[2025-05-09 22:30:07] 2025-05-10 02:29:52,942 | WARNING | found no corresponding commands to process id(s)
[2025-05-09 22:30:07] 2025-05-10 02:29:52,942 | INFO | Do not look for orphan processes in BOINC jobs
[2025-05-09 22:30:07] 2025-05-10 02:29:52,955 | INFO | did not find any defunct processes belonging to 51833
[2025-05-09 22:30:07] 2025-05-10 02:29:52,965 | INFO | did not find any defunct processes belonging to 51833
[2025-05-09 22:30:07] 2025-05-10 02:29:52,965 | INFO | ready for new job
[2025-05-09 22:30:07] 2025-05-10 02:29:52,965 | INFO | pilot has finished with previous job - re-establishing logging
[2025-05-09 22:30:07] 2025-05-10 02:29:52,987 | INFO | **************************************
[2025-05-09 22:30:07] 2025-05-10 02:29:52,987 | INFO | *** PanDA Pilot version 3.10.2.2 ***
[2025-05-09 22:30:07] 2025-05-10 02:29:52,987 | INFO | **************************************
[2025-05-09 22:30:07] 2025-05-10 02:29:52,988 | INFO |
[2025-05-09 22:30:07] 2025-05-10 02:29:52,992 | INFO | architecture information:
[2025-05-09 22:30:07] 2025-05-10 02:29:52,993 | INFO | executing command: cat /etc/os-release
[2025-05-09 22:30:07] 2025-05-10 02:29:53,035 | INFO | cat /etc/os-release:
[2025-05-09 22:30:07] NAME="CentOS Linux"
[2025-05-09 22:30:07] VERSION="7 (Core)"
[2025-05-09 22:30:07] ID="centos"
[2025-05-09 22:30:07] ID_LIKE="rhel fedora"
[2025-05-09 22:30:07] VERSION_ID="7"
[2025-05-09 22:30:07] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-05-09 22:30:07] ANSI_COLOR="0;31"
[2025-05-09 22:30:07] CPE_NAME="cpe:/o:centos:centos:7"
[2025-05-09 22:30:07] HOME_URL="https://www.centos.org/"
[2025-05-09 22:30:07] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-05-09 22:30:07]
[2025-05-09 22:30:07] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-05-09 22:30:07] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-05-09 22:30:07] REDHAT_SUPPORT_PRODUCT="centos"
[2025-05-09 22:30:07] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-05-09 22:30:07]
[2025-05-09 22:30:07] 2025-05-10 02:29:53,036 | INFO | **************************************
[2025-05-09 22:30:07] 2025-05-10 02:29:53,539 | INFO | executing command: df -mP /tmp/boinchome/slots/5
[2025-05-09 22:30:07] 2025-05-10 02:29:53,552 | INFO | sufficient remaining disk space (104809365504 B)
[2025-05-09 22:30:07] 2025-05-10 02:29:53,553 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job
[2025-05-09 22:30:07] 2025-05-10 02:29:53,553 | INFO | current server update state: UPDATING_FINAL
[2025-05-09 22:30:07] 2025-05-10 02:29:53,553 | INFO | update_server=False
[2025-05-09 22:30:07] 2025-05-10 02:29:53,553 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-05-09 22:30:07] 2025-05-10 02:29:53,553 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2025-05-09 22:30:07] 2025-05-10 02:29:53,773 | INFO | all data control threads have been joined
[2025-05-09 22:30:07] 2025-05-10 02:29:53,834 | INFO | found 0 job(s) in 20 queues
[2025-05-09 22:30:07] 2025-05-10 02:29:53,834 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2025-05-09 22:30:07] 2025-05-10 02:29:53,834 | WARNING | will wait for a maximum of 300 s for threads to finish
[2025-05-09 22:30:07] 2025-05-10 02:29:54,139 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2025-05-09 22:30:07] 2025-05-10 02:29:54,389 | INFO | all payload control threads have been joined
[2025-05-09 22:30:07] 2025-05-10 02:29:54,460 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2025-05-09 22:30:07] 2025-05-10 02:29:54,460 | INFO | aborting loop
[2025-05-09 22:30:07] 2025-05-10 02:29:54,558 | INFO | [job] retrieve thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:54,558 | INFO | [job] queue monitor thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:54,564 | INFO | [payload] run_realtimelog thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:54,779 | INFO | [data] control thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:54,960 | INFO | [payload] validate_pre thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:54,968 | INFO | [job] create_data_payload thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,036 | INFO | [payload] failed_post thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,228 | INFO | all job control threads have been joined
[2025-05-09 22:30:07] 2025-05-10 02:29:55,394 | INFO | [payload] control thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,424 | INFO | [payload] validate_post thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,465 | INFO | [job] job monitor thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,703 | INFO | [data] copytool_in thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,802 | INFO | [job] validate thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:55,994 | INFO | [payload] execute_payloads thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:56,145 | INFO | [data] copytool_out thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:56,233 | INFO | [job] control thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:29:56,683 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-05-09 22:30:07] 2025-05-10 02:30:00,689 | INFO | [data] queue_monitor thread has finished
[2025-05-09 22:30:07] 2025-05-10 02:30:02,233 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140461368469312)>', '<ExcThread(monitor, started 140460664289024)>']
[2025-05-09 22:30:07] 2025-05-10 02:30:02,881 | WARNING | job_aborted has been set - aborting pilot monitoring
[2025-05-09 22:30:07] 2025-05-10 02:30:02,881 | INFO | [monitor] control thread has ended
[2025-05-09 22:30:07] 2025-05-10 02:30:07,234 | INFO | all workflow threads have been joined
[2025-05-09 22:30:07] 2025-05-10 02:30:07,234 | INFO | end of generic workflow (traces error code: 0)
[2025-05-09 22:30:07] 2025-05-10 02:30:07,234 | INFO | traces error code: 0
[2025-05-09 22:30:07] 2025-05-10 02:30:07,234 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2025-05-09 22:30:07] 2025-05-10 02:30:07,301 [wrapper] ==== pilot stdout END ====
[2025-05-09 22:30:07] 2025-05-10 02:30:07,321 [wrapper] ==== wrapper stdout RESUME ====
[2025-05-09 22:30:07] 2025-05-10 02:30:07,324 [wrapper] pilotpid: 4424
[2025-05-09 22:30:07] 2025-05-10 02:30:07,327 [wrapper] Pilot exit status: 0
[2025-05-09 22:30:07] 2025-05-10 02:30:07,336 [wrapper] pandaids: 6636762574 6636762574 6636762574 6636762574
[2025-05-09 22:30:07] 2025-05-10 02:30:07,394 [wrapper] cleanup supervisor_pilot 92487 4425
[2025-05-09 22:30:07] 2025-05-10 02:30:07,402 [wrapper] Test setup, not cleaning
[2025-05-09 22:30:07] 2025-05-10 02:30:07,404 [wrapper] apfmon messages muted
[2025-05-09 22:30:07] 2025-05-10 02:30:07,433 [wrapper] ==== wrapper stdout END ====
[2025-05-09 22:30:07] 2025-05-10 02:30:07,463 [wrapper] ==== wrapper stderr END ====
[2025-05-09 22:30:07] *** Error codes and diagnostics ***
[2025-05-09 22:30:07] "exeErrorCode": 0,
[2025-05-09 22:30:07] "exeErrorDiag": "",
[2025-05-09 22:30:07] "pilotErrorCode": 0,
[2025-05-09 22:30:07] "pilotErrorDiag": "",
[2025-05-09 22:30:07] *** Listing of results directory ***
[2025-05-09 22:30:07] total 631068
[2025-05-09 22:30:07] drwx------ 4 boincer umatlas 4096 Apr 3 04:00 pilot3
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 495897 May 7 11:05 pilot3.tar.gz
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 5111 May 7 11:25 queuedata.json
[2025-05-09 22:30:07] -rwx------ 1 boincer umatlas 37140 May 7 11:28 runpilot2-wrapper.sh
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 100 May 8 11:04 wrapper_26015_x86_64-pc-linux-gnu
[2025-05-09 22:30:07] -rwxr-xr-x 1 boincer umatlas 7986 May 8 11:04 run_atlas
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 105 May 8 11:04 job.xml
[2025-05-09 22:30:07] -rw-r--r-- 3 boincer umatlas 220978174 May 8 11:04 EVNT.44506061._001594.pool.root.1
[2025-05-09 22:30:07] -rw-r--r-- 3 boincer umatlas 220978174 May 8 11:04 ATLAS.root_0
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 17569 May 8 11:04 start_atlas.sh
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 508879 May 8 11:04 input.tar.gz
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 0 May 8 11:04 boinc_lockfile
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 0 May 9 18:29 wrapper_sigint_72681
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 0 May 9 18:32 wrapper_sigkill_72681
[2025-05-09 22:30:07] drwxrwx--x 2 boincer umatlas 4096 May 9 18:32 shared
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 2557 May 9 20:12 pandaJob.out
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 424 May 9 20:12 setup.sh.local
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 996336 May 9 20:12 agis_schedconf.cvmfs.json
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 6304 May 9 22:28 init_data.xml
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 198189101 May 9 22:29 HITS.44506063._040563.pool.root.1
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 99 May 9 22:29 pilot_heartbeat.json
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 534 May 9 22:29 boinc_task_state.xml
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 1074 May 9 22:29 memory_monitor_summary.json
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 1596741 May 9 22:29 agis_ddmendpoints.agis.ALL.json
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 336665 May 9 22:29 log.44506063._040563.job.log.tgz.1
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 7736 May 9 22:29 heartbeat.json
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 8192 May 9 22:30 boinc_mmap_file
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 30 May 9 22:30 wrapper_checkpoint.txt
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 4354 May 9 22:30 pilotlog.txt
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 761953 May 9 22:30 log.44506063._040563.job.log.1
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 357 May 9 22:30 output.list
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 620 May 9 22:30 runtime_log
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 1116160 May 9 22:30 result.tar.gz
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 11098 May 9 22:30 runtime_log.err
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 1517 May 9 22:30 AIXKDm3rvW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmN36LDmIoxAbn.diag
[2025-05-09 22:30:07] -rw-r--r-- 1 boincer umatlas 43218 May 9 22:30 stderr.txt
[2025-05-09 22:30:07] HITS file was successfully produced:
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 198189101 May 9 22:29 shared/HITS.pool.root.1
[2025-05-09 22:30:07] *** Contents of shared directory: ***
[2025-05-09 22:30:07] total 410964
[2025-05-09 22:30:07] -rw-r--r-- 3 boincer umatlas 220978174 May 8 11:04 ATLAS.root_0
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 17569 May 8 11:04 start_atlas.sh
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 508879 May 8 11:04 input.tar.gz
[2025-05-09 22:30:07] -rw------- 1 boincer umatlas 198189101 May 9 22:29 HITS.pool.root.1
[2025-05-09 22:30:07] -rw-r--r-- 2 boincer umatlas 1116160 May 9 22:30 result.tar.gz
22:30:09 (79157): run_atlas exited; CPU time 35776.458157
22:30:09 (79157): called boinc_finish(0)
</stderr_txt>
]]>
©2025 CERN