Name 3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm_0
Workunit 231733060
Created 19 Apr 2025, 14:58:24 UTC
Sent 19 Apr 2025, 17:51:39 UTC
Report deadline 27 Apr 2025, 17:51:39 UTC
Received 19 Apr 2025, 23:07:03 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10696208
Run time 1 hours 29 min 18 sec
CPU time 4 hours 32 min 45 sec
Validate state Valid
Credit 602.81
Device peak FLOPS 34.73 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 2.45 GB
Peak swap size 10.23 GB
Peak disk usage 824.45 MB

Stderr output

<core_client_version>8.0.4</core_client_version>
<![CDATA[
<stderr_txt>
21:59:14 (428693): wrapper (7.7.26015): starting
21:59:14 (428693): wrapper: running run_atlas (--nthreads 4)
[2025-04-19 21:59:14] Arguments: --nthreads 4
[2025-04-19 21:59:14] Threads: 4
[2025-04-19 21:59:14] Checking for CVMFS
[2025-04-19 21:59:14] Probing /cvmfs/atlas.cern.ch... OK
[2025-04-19 21:59:14] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-04-19 21:59:14] Running cvmfs_config stat atlas.cern.ch
[2025-04-19 21:59:14] 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-04-19 21:59:14] 2.9.2.0 3016 751 85256 145049 2 187 36123805 36864001 0 130560 0 1106942 99.996 161969 27153 http://cvmfs-stratum-one.cern.ch:8000/cvmfs/atlas.cern.ch http://130.183.36.13:3128 1
[2025-04-19 21:59:14] CVMFS is ok
[2025-04-19 21:59:14] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-04-19 21:59:14] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-04-19 21:59:14] Further information can be found at the LHC@home message board.
[2025-04-19 21:59:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-04-19 21:59:14] Checking for apptainer binary...
[2025-04-19 21:59:14] Using apptainer found in PATH at /usr/bin/apptainer
[2025-04-19 21:59:14] Running /usr/bin/apptainer --version
[2025-04-19 21:59:14] apptainer version 1.3.6-6.1
[2025-04-19 21:59:14] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-04-19 21:59:14] belleA253b
[2025-04-19 21:59:14] apptainer works
[2025-04-19 21:59:14] Set ATHENA_PROC_NUMBER=4
[2025-04-19 21:59:14] Set ATHENA_CORE_NUMBER=4
[2025-04-19 21:59:14] Starting ATLAS job with PandaID=6607871717
[2025-04-19 21:59:14] Running command: /usr/bin/apptainer exec -B /cvmfs,/local/data/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
22:17:31 (2789): wrapper (7.7.26015): starting
22:17:31 (2789): wrapper: running run_atlas (--nthreads 4)
[2025-04-19 22:17:31] Arguments: --nthreads 4
[2025-04-19 22:17:31] Threads: 4
[2025-04-19 22:17:31] This job has been restarted, cleaning up previous attempt
[2025-04-19 22:17:31] Checking for CVMFS
[2025-04-19 22:17:33] Probing /cvmfs/atlas.cern.ch... OK
[2025-04-19 22:17:34] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-04-19 22:17:34] Running cvmfs_config stat atlas.cern.ch
[2025-04-19 22:17: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-04-19 22:17:34] 2.9.2.0 2986 0 28916 145050 3 1 36126429 36864001 0 130560 0 0 0.000 1170 27209 http://cvmfs-stratum-one.cern.ch:8000/cvmfs/atlas.cern.ch http://130.183.36.13:3128 1
[2025-04-19 22:17:34] CVMFS is ok
[2025-04-19 22:17:34] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-04-19 22:17:34] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-04-19 22:17:34] Further information can be found at the LHC@home message board.
[2025-04-19 22:17:34] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-04-19 22:17:34] Checking for apptainer binary...
[2025-04-19 22:17:34] Using apptainer found in PATH at /usr/bin/apptainer
[2025-04-19 22:17:34] Running /usr/bin/apptainer --version
[2025-04-19 22:17:34] apptainer version 1.3.6-6.1
[2025-04-19 22:17:34] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-04-19 22:17:34] belleA253b
[2025-04-19 22:17:34] apptainer works
[2025-04-19 22:17:34] Set ATHENA_PROC_NUMBER=4
[2025-04-19 22:17:34] Set ATHENA_CORE_NUMBER=4
[2025-04-19 22:17:34] Starting ATLAS job with PandaID=6607871717
[2025-04-19 22:17:34] Running command: /usr/bin/apptainer exec -B /cvmfs,/local/data/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-04-19 22:24:35] Job failed
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + export RUNTIME_CONFIG_DIR=/local/data/boinc/slots/0/
[2025-04-19 22:24:35] + RUNTIME_CONFIG_DIR=/local/data/boinc/slots/0/
[2025-04-19 22:24:35] + mv ATLAS.root_0 EVNT.44075481._003269.pool.root.1
[2025-04-19 22:24:35] mv: &#226;&#128;&#152;ATLAS.root_0&#226;&#128;&#153; and &#226;&#128;&#152;EVNT.44075481._003269.pool.root.1&#226;&#128;&#153; are the same file
[2025-04-19 22:24:35] + tar --strip-components=5 -xvf input.tar.gz
[2025-04-19 22:24:35] + umask 077
[2025-04-19 22:24:35] ++ date +%s
[2025-04-19 22:24:35] + ACCOUNTING_STARTTIME=1745093854
[2025-04-19 22:24:35] + echo 'Detecting resource accounting method available for the job.'
[2025-04-19 22:24:35] Detecting resource accounting method available for the job.
[2025-04-19 22:24:35] + JOB_ACCOUNTING=
[2025-04-19 22:24:35] + command -v arc-job-cgroup
[2025-04-19 22:24:35] + '[' -z '' ']'
[2025-04-19 22:24:35] + GNU_TIME=/usr/bin/time
[2025-04-19 22:24:35] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2025-04-19 22:24:35] Looking for /usr/bin/time tool for accounting measurements
[2025-04-19 22:24:35] + '[' '!' -z /usr/bin/time ']'
[2025-04-19 22:24:35] + /usr/bin/time --version
[2025-04-19 22:24:35] + echo 'GNU time found and will be used for job accounting.'
[2025-04-19 22:24:35] GNU time found and will be used for job accounting.
[2025-04-19 22:24:35] + JOB_ACCOUNTING=gnutime
[2025-04-19 22:24:35] + '[' -z gnutime ']'
[2025-04-19 22:24:35] + export PANDA_JSID=harvester-CERN_central_ACTA
[2025-04-19 22:24:35] + PANDA_JSID=harvester-CERN_central_ACTA
[2025-04-19 22:24:35] + export GTAG=http://aipanda403.cern.ch/data/jobs/2025-04-19/BOINC_MCORE/6607871717.out
[2025-04-19 22:24:35] + GTAG=http://aipanda403.cern.ch/data/jobs/2025-04-19/BOINC_MCORE/6607871717.out
[2025-04-19 22:24:35] + export PILOT_NOKILL=YES
[2025-04-19 22:24:35] + PILOT_NOKILL=YES
[2025-04-19 22:24:35] + export GRID_GLOBAL_JOBID=3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm
[2025-04-19 22:24:35] + GRID_GLOBAL_JOBID=3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm
[2025-04-19 22:24:35] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm
[2025-04-19 22:24:35] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm
[2025-04-19 22:24:35] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-04-19 22:24:35] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2025-04-19 22:24:35] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-04-19 22:24:35] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + RUNTIME_JOB_DIR=/local/data/boinc/slots/0
[2025-04-19 22:24:35] + RUNTIME_JOB_STDIN=/dev/null
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + RUNTIME_JOB_STDOUT=/local/data/boinc/slots/0/log.44075483._084342.job.log.1
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + RUNTIME_JOB_STDERR=/local/data/boinc/slots/0/log.44075483._084342.job.log.1
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + RUNTIME_JOB_DIAG=/local/data/boinc/slots/0.diag
[2025-04-19 22:24:35] + '[' '!' -z '' ']'
[2025-04-19 22:24:35] + RUNTIME_LOCAL_SCRATCH_DIR=
[2025-04-19 22:24:35] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2025-04-19 22:24:35] + RUNTIME_FRONTEND_SEES_NODE=
[2025-04-19 22:24:35] + RUNTIME_NODE_SEES_FRONTEND=yes
[2025-04-19 22:24:35] + '[' '!' -z '' ']'
[2025-04-19 22:24:35] + '[' -z yes ']'
[2025-04-19 22:24:35] ++ pwd
[2025-04-19 22:24:35] + RUNTIME_JOB_DIAG=/local/data/boinc/slots/0/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.diag
[2025-04-19 22:24:35] + runtimeenvironments=
[2025-04-19 22:24:35] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-04-19 22:24:35] + RTE_function_0 1
[2025-04-19 22:24:35] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-04-19 22:24:35] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-04-19 22:24:35] + export BOINC_APP=ATLAS
[2025-04-19 22:24:35] + BOINC_APP=ATLAS
[2025-04-19 22:24:35] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-04-19 22:24:35] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-04-19 22:24:35] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-04-19 22:24:35] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-04-19 22:24:35] + '[' -z 1 ']'
[2025-04-19 22:24:35] + '[' 1 == 1 ']'
[2025-04-19 22:24:35] + shift
[2025-04-19 22:24:35] + 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-04-19 22:24:35] + FRONTIER_BACKUP='(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2025-04-19 22:24:35] + FRONTIER_WPAD='(proxyconfigurl=http://grid-wpad/wpad.dat)'
[2025-04-19 22:24:35] + export ATLAS_LOCAL_AREA=/local/data/boinc/slots/0/
[2025-04-19 22:24:35] + ATLAS_LOCAL_AREA=/local/data/boinc/slots/0/
[2025-04-19 22:24:35] + '[' -e /local/data/boinc/slots/0/init_data.xml ']'
[2025-04-19 22:24:35] + grep '<use_http_proxy/>' /local/data/boinc/slots/0/init_data.xml
[2025-04-19 22:24:35] + '[' -e /local/data/boinc/slots/0/init_data.xml ']'
[2025-04-19 22:24:35] + grep '.cern.ch</domain_name>' /local/data/boinc/slots/0/init_data.xml
[2025-04-19 22:24:35] + FRONTIER_SERVER_URLS='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)'
[2025-04-19 22:24:35] + 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-04-19 22:24:35] + 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-04-19 22:24:35] + 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-04-19 22:24:35] + 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-04-19 22:24:35] + '[' 0 -ne 0 ']'
[2025-04-19 22:24:35] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2025-04-19 22:24:35] + '[' -f /etc/os-release ']'
[2025-04-19 22:24:35] +++ cat /etc/os-release
[2025-04-19 22:24: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-04-19 22:24:35] +++ NAME='CentOS Linux'
[2025-04-19 22:24:35] +++ VERSION='7 (Core)'
[2025-04-19 22:24:35] +++ ID=centos
[2025-04-19 22:24:35] +++ ID_LIKE='rhel fedora'
[2025-04-19 22:24:35] +++ VERSION_ID=7
[2025-04-19 22:24:35] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2025-04-19 22:24:35] +++ ANSI_COLOR='0;31'
[2025-04-19 22:24:35] +++ CPE_NAME=cpe:/o:centos:centos:7
[2025-04-19 22:24:35] +++ HOME_URL=https://www.centos.org/
[2025-04-19 22:24:35] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2025-04-19 22:24:35] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2025-04-19 22:24:35] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2025-04-19 22:24:35] +++ REDHAT_SUPPORT_PRODUCT=centos
[2025-04-19 22:24:35] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2025-04-19 22:24:35] ++ echo 'CentOS Linux 7 (Core)'
[2025-04-19 22:24:35] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2025-04-19 22:24:35] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2025-04-19 22:24:35] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2025-04-19 22:24:35] + HOME=/local/data/boinc/slots/0
[2025-04-19 22:24:35] + export HOME
[2025-04-19 22:24:35] + cd /local/data/boinc/slots/0
[2025-04-19 22:24:35] + '[' '!' -z '' ']'
[2025-04-19 22:24:35] + '[' -z '' ']'
[2025-04-19 22:24:35] ++ /bin/hostname -f
[2025-04-19 22:24:35] + nodename=belleA253b.mppmu.mpg.de
[2025-04-19 22:24:35] + echo nodename=belleA253b.mppmu.mpg.de
[2025-04-19 22:24:35] + echo Processors=2
[2025-04-19 22:24:35] + echo Nodecount=1
[2025-04-19 22:24:35] + echo Benchmark=HEPSPEC:1.0
[2025-04-19 22:24:35] + executable=./runpilot2-wrapper.sh
[2025-04-19 22:24:35] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2025-04-19 22:24:35] ++ dd if=./runpilot2-wrapper.sh count=1
[2025-04-19 22:24:35] ++ head -n 1
[2025-04-19 22:24:35] ++ tr -d '\0'
[2025-04-19 22:24:35] + line1='#!/bin/bash'
[2025-04-19 22:24:35] ++ echo '#!/bin/bash'
[2025-04-19 22:24:35] ++ sed -n 's/^#! *//p'
[2025-04-19 22:24:35] + shebang=/bin/bash
[2025-04-19 22:24:35] ++ echo /bin/bash
[2025-04-19 22:24:35] ++ awk '{print $1}'
[2025-04-19 22:24:35] + interpreter=/bin/bash
[2025-04-19 22:24:35] + '[' /bin/bash = /usr/bin/env ']'
[2025-04-19 22:24:35] + '[' x/bin/bash = x ']'
[2025-04-19 22:24:35] + type /bin/bash
[2025-04-19 22:24:35] + '[' xgnutime = xgnutime ']'
[2025-04-19 22:24:35] + /usr/bin/time -o /local/data/boinc/slots/0/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.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-04-19 22:24:35] + RESULT=139
[2025-04-19 22:24:35] + sed -i -e /nodename=/d /local/data/boinc/slots/0/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.diag
[2025-04-19 22:24:35] ++ grep domain_name init_data.xml
[2025-04-19 22:24:35] ++ awk -F '>' '{print $2}'
[2025-04-19 22:24:35] ++ awk -F '<' '{print $1}'
[2025-04-19 22:24:35] ++ sed -e 's# #_#g'
[2025-04-19 22:24:35] + hostname=belleA253b
[2025-04-19 22:24:35] ++ grep user_name init_data.xml
[2025-04-19 22:24:35] ++ awk -F '>' '{print $2}'
[2025-04-19 22:24:35] ++ awk -F '<' '{print $1}'
[2025-04-19 22:24:35] ++ sed -e 's# #_#g'
[2025-04-19 22:24:35] + username='MPI_f&#195;&#188;r_Physik'
[2025-04-19 22:24:35] + nodename='MPI_f&#195;&#188;r_Physik@belleA253b'
[2025-04-19 22:24:35] + echo 'nodename=MPI_f&#195;&#188;r_Physik@belleA253b'
[2025-04-19 22:24:35] + '[' -n 4 ']'
[2025-04-19 22:24:35] + sed -i -e s/Processors=1/Processors=4/ /local/data/boinc/slots/0/3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.diag
[2025-04-19 22:24:35] + echo exitcode=139
[2025-04-19 22:24:35] + runtimeenvironments=
[2025-04-19 22:24:35] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2025-04-19 22:24:35] + RTE_function_0 2
[2025-04-19 22:24:35] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-04-19 22:24:35] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2025-04-19 22:24:35] + export BOINC_APP=ATLAS
[2025-04-19 22:24:35] + BOINC_APP=ATLAS
[2025-04-19 22:24:35] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-04-19 22:24:35] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2025-04-19 22:24:35] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-04-19 22:24:35] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2025-04-19 22:24:35] + '[' -z 2 ']'
[2025-04-19 22:24:35] + '[' 2 == 1 ']'
[2025-04-19 22:24:35] + '[' 0 -ne 0 ']'
[2025-04-19 22:24:35] + echo 'zip all output files'
[2025-04-19 22:24:35] + flist='*.diag '
[2025-04-19 22:24:35] + for f in ./heartbeat.json ./output.list ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1 ./gmlog/
[2025-04-19 22:24:35] + '[' -e ./heartbeat.json ']'
[2025-04-19 22:24:35] + flist='*.diag  ./heartbeat.json'
[2025-04-19 22:24:35] + for f in ./heartbeat.json ./output.list ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1 ./gmlog/
[2025-04-19 22:24:35] + '[' -e ./output.list ']'
[2025-04-19 22:24:35] + for f in ./heartbeat.json ./output.list ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1 ./gmlog/
[2025-04-19 22:24:35] + '[' -e ./log.44075483._084342.job.log.1 ']'
[2025-04-19 22:24:35] + flist='*.diag  ./heartbeat.json ./log.44075483._084342.job.log.1'
[2025-04-19 22:24:35] + for f in ./heartbeat.json ./output.list ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1 ./gmlog/
[2025-04-19 22:24:35] + '[' -e ./log.44075483._084342.job.log.1 ']'
[2025-04-19 22:24:35] + flist='*.diag  ./heartbeat.json ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1'
[2025-04-19 22:24:35] + for f in ./heartbeat.json ./output.list ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1 ./gmlog/
[2025-04-19 22:24:35] + '[' -e ./gmlog/ ']'
[2025-04-19 22:24:35] + '[' -f output.list ']'
[2025-04-19 22:24:35] + tar cvf result.tar.gz 3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.diag ./heartbeat.json ./log.44075483._084342.job.log.1 ./log.44075483._084342.job.log.1
[2025-04-19 22:24:35] + '[' xgnutime = xcgroup ']'
[2025-04-19 22:24:35] + '[' -n '' ']'
[2025-04-19 22:24:35] + '[' -n '' ']'
[2025-04-19 22:24:35] ++ date +%s
[2025-04-19 22:24:35] + ACCOUNTING_ENDTIME=1745094275
[2025-04-19 22:24:35] ++ date -d '1970-01-01 UTC 1745093854 seconds' +%Y%m%d%H%M%SZ
[2025-04-19 22:24:35] + echo LRMSStartTime=20250419221734Z
[2025-04-19 22:24:35] ++ date -d '1970-01-01 UTC 1745094275 seconds' +%Y%m%d%H%M%SZ
[2025-04-19 22:24:35] + echo LRMSEndTime=20250419222435Z
[2025-04-19 22:24:35] + echo walltime=421
[2025-04-19 22:24:35] + echo exitcode=139
[2025-04-19 22:24:35] + exit 139
[2025-04-19 22:24:35] ./runtime_log.err
[2025-04-19 22:24:35] ./PanDA_Pilot-6607871717/prmon.log
[2025-04-19 22:24:35] ./PanDA_Pilot-6607871717/PoolFileCatalog.xml
[2025-04-19 22:24:35] ./PanDA_Pilot-6607871717/pilotlog.txt
[2025-04-19 22:24:35] ./PanDA_Pilot-6607871717/log.EVNTtoHITS
[2025-04-19 22:24:35] ./log.44075483._084342.job.log.1
[2025-04-19 22:24:35] ./runtime_log
[2025-04-19 22:24:35] ./pilot3/pilot/util/loggingsupport.py
[2025-04-19 22:24:35] ./pilot3/pilot/util/lokirealtimelogger.py
[2025-04-19 22:24:35] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2025-04-19 22:24:35] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2025-04-19 22:24:35] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2025-04-19 22:24:35] ./pilot3/pilot/util/realtimelogger.py
[2025-04-19 22:24:35] ./pilotlog.txt
22:44:40 (2799): wrapper (7.7.26015): starting
22:44:40 (2799): wrapper: running run_atlas (--nthreads 4)
[2025-04-19 22:44:40] Arguments: --nthreads 4
[2025-04-19 22:44:40] Threads: 4
[2025-04-19 22:44:40] This job has been restarted, cleaning up previous attempt
[2025-04-19 22:44:40] Checking for CVMFS
[2025-04-19 22:44:43] Probing /cvmfs/atlas.cern.ch... OK
[2025-04-19 22:44:43] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-04-19 22:44:43] Running cvmfs_config stat atlas.cern.ch
[2025-04-19 22:44: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-04-19 22:44:43] 2.9.2.0 2997 0 28776 145050 4 1 36126429 36864001 0 130560 0 0 100.000 0 0 http://cvmfs-stratum-one.cern.ch:8000/cvmfs/atlas.cern.ch http://130.183.36.13:3128 1
[2025-04-19 22:44:43] CVMFS is ok
[2025-04-19 22:44:43] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-04-19 22:44:43] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-04-19 22:44:43] Further information can be found at the LHC@home message board.
[2025-04-19 22:44:43] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-04-19 22:44:43] Checking for apptainer binary...
[2025-04-19 22:44:43] Using apptainer found in PATH at /usr/bin/apptainer
[2025-04-19 22:44:43] Running /usr/bin/apptainer --version
[2025-04-19 22:44:43] apptainer version 1.3.6-6.1
[2025-04-19 22:44:43] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-04-19 22:44:43] belleA253b
[2025-04-19 22:44:43] apptainer works
[2025-04-19 22:44:43] Set ATHENA_PROC_NUMBER=4
[2025-04-19 22:44:43] Set ATHENA_CORE_NUMBER=4
[2025-04-19 22:44:43] Starting ATLAS job with PandaID=6607871717
[2025-04-19 22:44:43] Running command: /usr/bin/apptainer exec -B /cvmfs,/local/data/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-04-20 00:04:44]  *** The last 200 lines of the pilot log: ***
[2025-04-20 00:04:44]  lfn=log.44075483._084342.job.log.tgz.1
[2025-04-20 00:04:44]  mtime=0
[2025-04-20 00:04:44]  protocol_id=None
[2025-04-20 00:04:44]  protocols=[{'endpoint': 'davs://dav.ndgf.org:443', 'flavour': 'WEBDAV', 'id': 331, 'path': '/atlas/disk/atlasdatadisk/rucio/'}]
[2025-04-20 00:04:44]  replicas=None
[2025-04-20 00:04:44]  scope=mc23_13p6TeV
[2025-04-20 00:04:44]  status=None
[2025-04-20 00:04:44]  status_code=0
[2025-04-20 00:04:44]  storage_token=
[2025-04-20 00:04:44]  surl=/local/data/boinc/slots/0/PanDA_Pilot-6607871717/log.44075483._084342.job.log.tgz.1
[2025-04-20 00:04:44]  turl=davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/3d/18/log.44075483._084342.job.log.tgz.1
[2025-04-20 00:04:44]  workdir=None
[2025-04-20 00:04:44] ]
[2025-04-20 00:04:44] 2025-04-19 22:04:22,329 | INFO     | transferring file log.44075483._084342.job.log.tgz.1 from /local/data/boinc/slots/0/PanDA_Pilot-6607871717/log.44075483._084342.job.log.tgz.1 to /local/data/boinc/
[2025-04-20 00:04:44] 2025-04-19 22:04:22,329 | INFO     | executing command: /usr/bin/env mv /local/data/boinc/slots/0/PanDA_Pilot-6607871717/log.44075483._084342.job.log.tgz.1 /local/data/boinc/slots/0/log.44075483._0843
[2025-04-20 00:04:44] 2025-04-19 22:04:22,348 | INFO     | adding to output.list: log.44075483._084342.job.log.tgz.1 davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/3d/18/log.44075483._084342.job.log.tg
[2025-04-20 00:04:44] 2025-04-19 22:04:22,349 | INFO     | alt stage-out settings: ['pl', 'write_lan', 'w', 'default'], allow_altstageout=False, remain_files=0, has_altstorage=True
[2025-04-20 00:04:44] 2025-04-19 22:04:22,349 | INFO     | summary of transferred files:
[2025-04-20 00:04:44] 2025-04-19 22:04:22,349 | INFO     |  -- lfn=log.44075483._084342.job.log.tgz.1, status_code=0, status=transferred
[2025-04-20 00:04:44] 2025-04-19 22:04:22,349 | INFO     | stage-out finished correctly
[2025-04-20 00:04:44] 2025-04-19 22:04:23,863 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2025-04-20 00:04:44] 2025-04-19 22:04:25,443 | WARNING  | process 13658 can no longer be monitored (due to stat problems) - aborting
[2025-04-20 00:04:44] 2025-04-19 22:04:25,443 | INFO     | using path: /local/data/boinc/slots/0/PanDA_Pilot-6607871717/memory_monitor_summary.json (trf name=prmon)
[2025-04-20 00:04:44] 2025-04-19 22:04:25,485 | INFO     | number of running child processes to parent process 13658: 1
[2025-04-20 00:04:44] 2025-04-19 22:04:25,485 | INFO     | maximum number of monitored processes: 6
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | job 6607871717 has state=finished
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | preparing for final server update for job 6607871717 in state='finished'
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | this job has now completed (state=finished)
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | log transfer has been attempted: DONE
[2025-04-20 00:04:44] 2025-04-19 22:04:25,857 | INFO     | job 6607871717 has finished - writing final server update
[2025-04-20 00:04:44] 2025-04-19 22:04:25,858 | INFO     | total number of processed events: 400 (read)
[2025-04-20 00:04:44] 2025-04-19 22:04:25,859 | INFO     | executing command: lscpu
[2025-04-20 00:04:44] 2025-04-19 22:04:25,881 | INFO     | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup
[2025-04-20 00:04:44] 2025-04-19 22:04:27,988 | INFO     | monitor loop #367: job 0:6607871717 is in state 'finished'
[2025-04-20 00:04:44] 2025-04-19 22:04:27,989 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,492 | INFO     | monitor loop #368: job 0:6607871717 is in state 'finished'
[2025-04-20 00:04:44] 2025-04-19 22:04:30,492 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,665 | INFO     | PID=7085 has CPU usage=3.8% 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-04-20 00:04:44] 2025-04-19 22:04:30,817 | INFO     | CPU arch script returned: x86-64-v3
[2025-04-20 00:04:44] 2025-04-19 22:04:30,817 | INFO     | using path: /local/data/boinc/slots/0/PanDA_Pilot-6607871717/memory_monitor_summary.json (trf name=prmon)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,817 | INFO     | extracted standard info from prmon json
[2025-04-20 00:04:44] 2025-04-19 22:04:30,817 | INFO     | extracted standard memory fields from prmon json
[2025-04-20 00:04:44] 2025-04-19 22:04:30,817 | WARNING  | GPU info not found in prmon json: 'gpu'
[2025-04-20 00:04:44] 2025-04-19 22:04:30,818 | WARNING  | format EVNTtoHITS has no such key: dbData
[2025-04-20 00:04:44] 2025-04-19 22:04:30,818 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | fitting pss+swap vs Time
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | sum of square deviations: 110960220.0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | sum of deviations: 4292622398.9999986
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | mean x: 1745097956.0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | mean y: 2390398.5492957747
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | -- intersect: -67508710195.65208
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | intersect: -67508710195.65208
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | chi2: 0.9904673146242657
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | -- intersect: -67508710195.65208
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | current memory leak: 38.69 B/s (using 71 data points, chi2=0.99)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | ..............................
[2025-04-20 00:04:44] 2025-04-19 22:04:30,819 | INFO     | . Timing measurements:
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . get job = 0 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . initial setup = 0 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . payload setup = 4 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . stage-in = 0 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . payload execution = 4745 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . stage-out = 0 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | . log creation = 0 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,820 | INFO     | ..............................
[2025-04-20 00:04:44] 2025-04-19 22:04:30,861 | INFO     | 
[2025-04-20 00:04:44] 2025-04-19 22:04:30,861 | INFO     | job summary report
[2025-04-20 00:04:44] 2025-04-19 22:04:30,861 | INFO     | --------------------------------------------------
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | PanDA job id: 6607871717
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | task id: 44075483
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | errors: (none)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | status: LOG_TRANSFER = DONE 
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | pilot state: finished 
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | transexitcode: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | exeerrorcode: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | exeerrordiag: 
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | exitcode: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | exitmsg: OK
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | cpuconsumptiontime: 16294 s
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | nevents: 400
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | neventsw: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | pid: 13658
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | pgrp: 13658
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | corecount: 4
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | event service: False
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | sizes: {0: 2426826, 4: 2427032, 11: 2427060, 4753: 2453273, 4755: 2462220, 4757: 2462276, 4764: 2462574}
[2025-04-20 00:04:44] 2025-04-19 22:04:30,862 | INFO     | --------------------------------------------------
[2025-04-20 00:04:44] 2025-04-19 22:04:30,863 | INFO     | 
[2025-04-20 00:04:44] 2025-04-19 22:04:30,863 | INFO     | executing command: ls -lF /local/data/boinc/slots/0
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue jobs had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue data_in had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue data_out had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,881 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | queue completed_jobids has 1 job(s)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | queue messages had 0 job(s) [purged]
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | job 6607871717 has completed (purged errors)
[2025-04-20 00:04:44] 2025-04-19 22:04:30,882 | INFO     | overall cleanup function is called
[2025-04-20 00:04:44] 2025-04-19 22:04:31,888 | INFO     | --- collectZombieJob: --- 10, [13658]
[2025-04-20 00:04:44] 2025-04-19 22:04:31,888 | INFO     | zombie collector waiting for pid 13658
[2025-04-20 00:04:44] 2025-04-19 22:04:31,889 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-04-20 00:04:44] 2025-04-19 22:04:31,889 | INFO     | collected zombie processes
[2025-04-20 00:04:44] 2025-04-19 22:04:31,889 | INFO     | will attempt to kill all subprocesses of pid=13658
[2025-04-20 00:04:44] 2025-04-19 22:04:31,935 | INFO     | process IDs to be killed: [13658] (in reverse order)
[2025-04-20 00:04:44] 2025-04-19 22:04:31,968 | WARNING  | found no corresponding commands to process id(s)
[2025-04-20 00:04:44] 2025-04-19 22:04:31,968 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-04-20 00:04:44] 2025-04-19 22:04:31,970 | INFO     | did not find any defunct processes belonging to 13658
[2025-04-20 00:04:44] 2025-04-19 22:04:31,971 | INFO     | did not find any defunct processes belonging to 13658
[2025-04-20 00:04:44] 2025-04-19 22:04:31,971 | INFO     | ready for new job
[2025-04-20 00:04:44] 2025-04-19 22:04:31,971 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-04-20 00:04:44] 2025-04-19 22:04:31,972 | INFO     | **************************************
[2025-04-20 00:04:44] 2025-04-19 22:04:31,972 | INFO     | ***  PanDA Pilot version 3.10.2.2  ***
[2025-04-20 00:04:44] 2025-04-19 22:04:31,972 | INFO     | **************************************
[2025-04-20 00:04:44] 2025-04-19 22:04:31,972 | INFO     | 
[2025-04-20 00:04:44] 2025-04-19 22:04:31,973 | INFO     | architecture information:
[2025-04-20 00:04:44] 2025-04-19 22:04:31,973 | INFO     | executing command: cat /etc/os-release
[2025-04-20 00:04:44] 2025-04-19 22:04:31,986 | INFO     | cat /etc/os-release:
[2025-04-20 00:04:44] NAME="CentOS Linux"
[2025-04-20 00:04:44] VERSION="7 (Core)"
[2025-04-20 00:04:44] ID="centos"
[2025-04-20 00:04:44] ID_LIKE="rhel fedora"
[2025-04-20 00:04:44] VERSION_ID="7"
[2025-04-20 00:04:44] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-04-20 00:04:44] ANSI_COLOR="0;31"
[2025-04-20 00:04:44] CPE_NAME="cpe:/o:centos:centos:7"
[2025-04-20 00:04:44] HOME_URL="https://www.centos.org/"
[2025-04-20 00:04:44] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-04-20 00:04:44] 
[2025-04-20 00:04:44] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-04-20 00:04:44] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-04-20 00:04:44] REDHAT_SUPPORT_PRODUCT="centos"
[2025-04-20 00:04:44] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-04-20 00:04:44] 
[2025-04-20 00:04:44] 2025-04-19 22:04:31,986 | INFO     | **************************************
[2025-04-20 00:04:44] 2025-04-19 22:04:32,490 | INFO     | executing command: df -mP /local/data/boinc/slots/0
[2025-04-20 00:04:44] 2025-04-19 22:04:32,507 | INFO     | sufficient remaining disk space (319667830784 B)
[2025-04-20 00:04:44] 2025-04-19 22:04:32,507 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-04-20 00:04:44] 2025-04-19 22:04:32,507 | INFO     | current server update state: UPDATING_FINAL
[2025-04-20 00:04:44] 2025-04-19 22:04:32,507 | INFO     | update_server=False
[2025-04-20 00:04:44] 2025-04-19 22:04:32,507 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-04-20 00:04:44] 2025-04-19 22:04:32,508 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-04-20 00:04:44] 2025-04-19 22:04:32,671 | INFO     | found 0 job(s) in 20 queues
[2025-04-20 00:04:44] 2025-04-19 22:04:32,671 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-04-20 00:04:44] 2025-04-19 22:04:32,672 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-04-20 00:04:44] 2025-04-19 22:04:32,907 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-04-20 00:04:44] 2025-04-19 22:04:32,997 | WARNING  | job monitor detected an abort_job request (signal=args.signal)
[2025-04-20 00:04:44] 2025-04-19 22:04:32,997 | WARNING  | cannot recover job monitoring - aborting pilot
[2025-04-20 00:04:44] 2025-04-19 22:04:32,997 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-04-20 00:04:44] 2025-04-19 22:04:32,997 | INFO     | will abort loop
[2025-04-20 00:04:44] 2025-04-19 22:04:33,387 | INFO     | all data control threads have been joined
[2025-04-20 00:04:44] 2025-04-19 22:04:33,511 | INFO     | [job] queue monitor thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:33,513 | INFO     | [job] retrieve thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:33,609 | INFO     | [payload] execute_payloads thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:33,625 | INFO     | [payload] run_realtimelog thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:33,672 | INFO     | [data] copytool_in thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:33,940 | INFO     | all payload control threads have been joined
[2025-04-20 00:04:44] 2025-04-19 22:04:34,003 | INFO     | [job] job monitor thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,185 | INFO     | all job control threads have been joined
[2025-04-20 00:04:44] 2025-04-19 22:04:34,337 | INFO     | [job] validate thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,388 | INFO     | [job] create_data_payload thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,393 | INFO     | [data] control thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,415 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-04-20 00:04:44] 2025-04-19 22:04:34,472 | INFO     | [payload] validate_pre thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,477 | INFO     | [payload] validate_post thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,520 | INFO     | [payload] failed_post thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,913 | INFO     | [data] copytool_out thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:34,946 | INFO     | [payload] control thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:35,190 | INFO     | [job] control thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:38,423 | INFO     | [data] queue_monitor thread has finished
[2025-04-20 00:04:44] 2025-04-19 22:04:38,803 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140647716153152)>', '<ExcThread(monitor, started 140646916531968)>']
[2025-04-20 00:04:44] 2025-04-19 22:04:39,705 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-04-20 00:04:44] 2025-04-19 22:04:39,705 | INFO     | [monitor] control thread has ended
[2025-04-20 00:04:44] 2025-04-19 22:04:43,828 | INFO     | all workflow threads have been joined
[2025-04-20 00:04:44] 2025-04-19 22:04:43,828 | INFO     | end of generic workflow (traces error code: 0)
[2025-04-20 00:04:44] 2025-04-19 22:04:43,828 | INFO     | traces error code: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:43,828 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-04-20 00:04:44] 2025-04-19 22:04:43,905 [wrapper] ==== pilot stdout END ====
[2025-04-20 00:04:44] 2025-04-19 22:04:43,909 [wrapper] ==== wrapper stdout RESUME ====
[2025-04-20 00:04:44] 2025-04-19 22:04:43,913 [wrapper] pilotpid: 7085
[2025-04-20 00:04:44] 2025-04-19 22:04:43,917 [wrapper] Pilot exit status: 0
[2025-04-20 00:04:44] 2025-04-19 22:04:43,930 [wrapper] pandaids: 6607871717 6607871717 6607871717
[2025-04-20 00:04:44] 2025-04-19 22:04:43,953 [wrapper] cleanup supervisor_pilot   25946 7086
[2025-04-20 00:04:44] 2025-04-19 22:04:43,957 [wrapper] Test setup, not cleaning
[2025-04-20 00:04:44] 2025-04-19 22:04:43,961 [wrapper] apfmon messages muted
[2025-04-20 00:04:44] 2025-04-19 22:04:43,965 [wrapper] ==== wrapper stdout END ====
[2025-04-20 00:04:44] 2025-04-19 22:04:43,969 [wrapper] ==== wrapper stderr END ====
[2025-04-20 00:04:44]  *** Error codes and diagnostics ***
[2025-04-20 00:04:44]     "exeErrorCode": 0,
[2025-04-20 00:04:44]     "exeErrorDiag": "",
[2025-04-20 00:04:44]     "pilotErrorCode": 0,
[2025-04-20 00:04:44]     "pilotErrorDiag": "",
[2025-04-20 00:04:44]  *** Listing of results directory ***
[2025-04-20 00:04:44] total 633572
[2025-04-20 00:04:44] drwx------ 4 boinc boinc      4096 Apr  3 10:00 pilot3
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc    495897 Apr 19 16:33 pilot3.tar.gz
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc      5111 Apr 19 16:58 queuedata.json
[2025-04-20 00:04:44] -rwx------ 1 boinc boinc     37140 Apr 19 16:58 runpilot2-wrapper.sh
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc       100 Apr 19 21:59 wrapper_26015_x86_64-pc-linux-gnu
[2025-04-20 00:04:44] -rwxr-xr-x 1 boinc boinc      7986 Apr 19 21:59 run_atlas
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc       105 Apr 19 21:59 job.xml
[2025-04-20 00:04:44] -rw-r--r-- 3 boinc boinc 223620228 Apr 19 21:59 EVNT.44075481._003269.pool.root.1
[2025-04-20 00:04:44] -rw-r--r-- 3 boinc boinc 223620228 Apr 19 21:59 ATLAS.root_0
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc    508890 Apr 19 21:59 input.tar.gz
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc     17569 Apr 19 21:59 start_atlas.sh
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc         0 Apr 19 21:59 boinc_lockfile
[2025-04-20 00:04:44] -rw------- 1 boinc boinc   1618536 Apr 19 21:59 agis_ddmendpoints.agis.ALL.json
[2025-04-20 00:04:44] drwxrwx--x 2 boinc boinc      4096 Apr 19 22:24 shared
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc      6866 Apr 19 22:44 init_data.xml
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc      2578 Apr 19 22:44 pandaJob.out
[2025-04-20 00:04:44] -rw------- 1 boinc boinc       424 Apr 19 22:44 setup.sh.local
[2025-04-20 00:04:44] -rw------- 1 boinc boinc    991284 Apr 19 22:44 agis_schedconf.cvmfs.json
[2025-04-20 00:04:44] -rw------- 1 boinc boinc 196228828 Apr 20 00:04 HITS.44075483._084342.pool.root.1
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc       530 Apr 20 00:04 boinc_task_state.xml
[2025-04-20 00:04:44] -rw------- 1 boinc boinc      1043 Apr 20 00:04 memory_monitor_summary.json
[2025-04-20 00:04:44] -rw------- 1 boinc boinc        97 Apr 20 00:04 pilot_heartbeat.json
[2025-04-20 00:04:44] -rw------- 1 boinc boinc    240585 Apr 20 00:04 log.44075483._084342.job.log.tgz.1
[2025-04-20 00:04:44] -rw------- 1 boinc boinc      7696 Apr 20 00:04 heartbeat.json
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc        27 Apr 20 00:04 wrapper_checkpoint.txt
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc      8192 Apr 20 00:04 boinc_mmap_file
[2025-04-20 00:04:44] -rw------- 1 boinc boinc      4543 Apr 20 00:04 pilotlog.txt
[2025-04-20 00:04:44] -rw------- 1 boinc boinc    464312 Apr 20 00:04 log.44075483._084342.job.log.1
[2025-04-20 00:04:44] -rw------- 1 boinc boinc       357 Apr 20 00:04 output.list
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc       620 Apr 20 00:04 runtime_log
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc    727040 Apr 20 00:04 result.tar.gz
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc     11204 Apr 20 00:04 runtime_log.err
[2025-04-20 00:04:44] -rw------- 1 boinc boinc      1400 Apr 20 00:04 3B4LDmGpOQ7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmhBiLDmkIRnzm.diag
[2025-04-20 00:04:44] -rw-r--r-- 1 boinc boinc     41570 Apr 20 00:04 stderr.txt
[2025-04-20 00:04:44] HITS file was successfully produced:
[2025-04-20 00:04:44] -rw------- 1 boinc boinc 196228828 Apr 20 00:04 shared/HITS.pool.root.1
[2025-04-20 00:04:44]  *** Contents of shared directory: ***
[2025-04-20 00:04:44] total 411252
[2025-04-20 00:04:44] -rw-r--r-- 3 boinc boinc 223620228 Apr 19 21:59 ATLAS.root_0
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc    508890 Apr 19 21:59 input.tar.gz
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc     17569 Apr 19 21:59 start_atlas.sh
[2025-04-20 00:04:44] -rw------- 1 boinc boinc 196228828 Apr 20 00:04 HITS.pool.root.1
[2025-04-20 00:04:44] -rw-r--r-- 2 boinc boinc    727040 Apr 20 00:04 result.tar.gz
00:04:45 (2799): run_atlas exited; CPU time 16311.273340
00:04:45 (2799): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN