Name | KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn_1 |
Workunit | 231570841 |
Created | 12 Apr 2025, 23:55:57 UTC |
Sent | 13 Apr 2025, 3:14:40 UTC |
Report deadline | 21 Apr 2025, 3:14:40 UTC |
Received | 15 Apr 2025, 7:01:52 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10855370 |
Run time | 47 min 51 sec |
CPU time | 11 hours 59 min 26 sec |
Validate state | Valid |
Credit | 118.54 |
Device peak FLOPS | 18.11 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.48 GB |
Peak swap size | 2.82 GB |
Peak disk usage | 827.11 MB |
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> 12:31:10 (2678675): wrapper (7.7.26015): starting 12:31:10 (2678675): wrapper: running run_atlas (--nthreads 4) [2025-04-14 12:31:10] Arguments: --nthreads 4 [2025-04-14 12:31:10] Threads: 4 [2025-04-14 12:31:10] Checking for CVMFS [2025-04-14 12:31:10] No cvmfs_config command found, will try listing directly [2025-04-14 12:31:10] CVMFS is ok [2025-04-14 12:31:10] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-04-14 12:31:10] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-04-14 12:31:10] Further information can be found at the LHC@home message board. [2025-04-14 12:31:10] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-04-14 12:31:10] Checking for apptainer binary... [2025-04-14 12:31:10] which: no apptainer in ((null)) [2025-04-14 12:31:10] apptainer is not installed, using version from CVMFS [2025-04-14 12:31:10] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-04-14 12:31:10] WARNING: Environment variable TMPDIR already has value [/scratch/boinc/var/slot36/slots/0/.apptainertmp], will not forward new value [/tmp] from parent process environment skurut17.grid.cesnet.cz [2025-04-14 12:31:10] apptainer works [2025-04-14 12:31:10] Set ATHENA_PROC_NUMBER=4 [2025-04-14 12:31:10] Set ATHENA_CORE_NUMBER=4 [2025-04-14 12:31:10] Starting ATLAS job with PandaID=6600504960 [2025-04-14 12:31:10] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/scratch/boinc/var/slot36/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh 01:31:33 (1392238): wrapper (7.7.26015): starting 01:31:33 (1392238): wrapper: running run_atlas (--nthreads 4) [2025-04-15 01:31:33] Arguments: --nthreads 4 [2025-04-15 01:31:33] Threads: 4 [2025-04-15 01:31:33] This job has been restarted, cleaning up previous attempt [2025-04-15 01:31:33] Checking for CVMFS [2025-04-15 01:31:33] No cvmfs_config command found, will try listing directly [2025-04-15 01:31:33] CVMFS is ok [2025-04-15 01:31:33] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-04-15 01:31:33] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-04-15 01:31:33] Further information can be found at the LHC@home message board. [2025-04-15 01:31:33] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-04-15 01:31:33] Checking for apptainer binary... [2025-04-15 01:31:33] which: no apptainer in ((null)) [2025-04-15 01:31:33] apptainer is not installed, using version from CVMFS [2025-04-15 01:31:33] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-04-15 01:31:33] WARNING: Environment variable TMPDIR already has value [/scratch/boinc/var/slot36/slots/0/.apptainertmp], will not forward new value [/tmp] from parent process environment skurut17.grid.cesnet.cz [2025-04-15 01:31:33] apptainer works [2025-04-15 01:31:33] Set ATHENA_PROC_NUMBER=4 [2025-04-15 01:31:33] Set ATHENA_CORE_NUMBER=4 [2025-04-15 01:31:33] Starting ATLAS job with PandaID=6600504960 [2025-04-15 01:31:33] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/scratch/boinc/var/slot36/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-04-15 01:34:43] Job failed [2025-04-15 01:34:43] WARNING: Environment variable TMPDIR already has value [/scratch/boinc/var/slot36/slots/0/.apptainertmp], will not forward new value [/tmp] from parent process environment [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + export RUNTIME_CONFIG_DIR=/scratch/boinc/var/slot36/slots/0/ [2025-04-15 01:34:43] + RUNTIME_CONFIG_DIR=/scratch/boinc/var/slot36/slots/0/ [2025-04-15 01:34:43] + mv ATLAS.root_0 EVNT.44075162._001864.pool.root.1 [2025-04-15 01:34:43] mv: 'ATLAS.root_0' and 'EVNT.44075162._001864.pool.root.1' are the same file [2025-04-15 01:34:43] + tar --strip-components=5 -xvf input.tar.gz [2025-04-15 01:34:43] + umask 077 [2025-04-15 01:34:43] ++ date +%s [2025-04-15 01:34:43] + ACCOUNTING_STARTTIME=1744673494 [2025-04-15 01:34:43] + echo 'Detecting resource accounting method available for the job.' [2025-04-15 01:34:43] Detecting resource accounting method available for the job. [2025-04-15 01:34:43] + JOB_ACCOUNTING= [2025-04-15 01:34:43] + command -v arc-job-cgroup [2025-04-15 01:34:43] + '[' -z '' ']' [2025-04-15 01:34:43] + GNU_TIME=/usr/bin/time [2025-04-15 01:34:43] + echo 'Looking for /usr/bin/time tool for accounting measurements' [2025-04-15 01:34:43] Looking for /usr/bin/time tool for accounting measurements [2025-04-15 01:34:43] + '[' '!' -z /usr/bin/time ']' [2025-04-15 01:34:43] + /usr/bin/time --version [2025-04-15 01:34:43] + echo 'GNU time found and will be used for job accounting.' [2025-04-15 01:34:43] GNU time found and will be used for job accounting. [2025-04-15 01:34:43] + JOB_ACCOUNTING=gnutime [2025-04-15 01:34:43] + '[' -z gnutime ']' [2025-04-15 01:34:43] + export PANDA_JSID=harvester-CERN_central_ACTA [2025-04-15 01:34:43] + PANDA_JSID=harvester-CERN_central_ACTA [2025-04-15 01:34:43] + export GTAG=http://aipanda404.cern.ch/data/jobs/2025-04-12/BOINC_MCORE/6600504960.out [2025-04-15 01:34:43] + GTAG=http://aipanda404.cern.ch/data/jobs/2025-04-12/BOINC_MCORE/6600504960.out [2025-04-15 01:34:43] + export PILOT_NOKILL=YES [2025-04-15 01:34:43] + PILOT_NOKILL=YES [2025-04-15 01:34:43] + export GRID_GLOBAL_JOBID=KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn [2025-04-15 01:34:43] + GRID_GLOBAL_JOBID=KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn [2025-04-15 01:34:43] + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn [2025-04-15 01:34:43] + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn [2025-04-15 01:34:43] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-04-15 01:34:43] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest [2025-04-15 01:34:43] + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-04-15 01:34:43] + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + RUNTIME_JOB_DIR=/scratch/boinc/var/slot36/slots/0 [2025-04-15 01:34:43] + RUNTIME_JOB_STDIN=/dev/null [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + RUNTIME_JOB_STDOUT=/scratch/boinc/var/slot36/slots/0/log.44075164._047914.job.log.1 [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + RUNTIME_JOB_STDERR=/scratch/boinc/var/slot36/slots/0/log.44075164._047914.job.log.1 [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + RUNTIME_JOB_DIAG=/scratch/boinc/var/slot36/slots/0.diag [2025-04-15 01:34:43] + '[' '!' -z '' ']' [2025-04-15 01:34:43] + RUNTIME_LOCAL_SCRATCH_DIR= [2025-04-15 01:34:43] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv [2025-04-15 01:34:43] + RUNTIME_FRONTEND_SEES_NODE= [2025-04-15 01:34:43] + RUNTIME_NODE_SEES_FRONTEND=yes [2025-04-15 01:34:43] + '[' '!' -z '' ']' [2025-04-15 01:34:43] + '[' -z yes ']' [2025-04-15 01:34:43] ++ pwd [2025-04-15 01:34:43] + RUNTIME_JOB_DIAG=/scratch/boinc/var/slot36/slots/0/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.diag [2025-04-15 01:34:43] + runtimeenvironments= [2025-04-15 01:34:43] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-04-15 01:34:43] + RTE_function_0 1 [2025-04-15 01:34:43] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-04-15 01:34:43] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-04-15 01:34:43] + export BOINC_APP=ATLAS [2025-04-15 01:34:43] + BOINC_APP=ATLAS [2025-04-15 01:34:43] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-04-15 01:34:43] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-04-15 01:34:43] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-04-15 01:34:43] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-04-15 01:34:43] + '[' -z 1 ']' [2025-04-15 01:34:43] + '[' 1 == 1 ']' [2025-04-15 01:34:43] + shift [2025-04-15 01:34:43] + 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-15 01:34:43] + FRONTIER_BACKUP='(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)' [2025-04-15 01:34:43] + FRONTIER_WPAD='(proxyconfigurl=http://grid-wpad/wpad.dat)' [2025-04-15 01:34:43] + export ATLAS_LOCAL_AREA=/scratch/boinc/var/slot36/slots/0/ [2025-04-15 01:34:43] + ATLAS_LOCAL_AREA=/scratch/boinc/var/slot36/slots/0/ [2025-04-15 01:34:43] + '[' -e /scratch/boinc/var/slot36/slots/0/init_data.xml ']' [2025-04-15 01:34:43] + grep '<use_http_proxy/>' /scratch/boinc/var/slot36/slots/0/init_data.xml [2025-04-15 01:34:43] + '[' -e /scratch/boinc/var/slot36/slots/0/init_data.xml ']' [2025-04-15 01:34:43] + grep '.cern.ch</domain_name>' /scratch/boinc/var/slot36/slots/0/init_data.xml [2025-04-15 01:34:43] + FRONTIER_SERVER_URLS='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)' [2025-04-15 01:34:43] + 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-15 01:34:43] + 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-15 01:34:43] + 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-15 01:34:43] + 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-15 01:34:43] + '[' 0 -ne 0 ']' [2025-04-15 01:34:43] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;' [2025-04-15 01:34:43] + '[' -f /etc/os-release ']' [2025-04-15 01:34:43] +++ cat /etc/os-release [2025-04-15 01:34:43] ++ 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-15 01:34:43] +++ NAME='CentOS Linux' [2025-04-15 01:34:43] +++ VERSION='7 (Core)' [2025-04-15 01:34:43] +++ ID=centos [2025-04-15 01:34:43] +++ ID_LIKE='rhel fedora' [2025-04-15 01:34:43] +++ VERSION_ID=7 [2025-04-15 01:34:43] +++ PRETTY_NAME='CentOS Linux 7 (Core)' [2025-04-15 01:34:43] +++ ANSI_COLOR='0;31' [2025-04-15 01:34:43] +++ CPE_NAME=cpe:/o:centos:centos:7 [2025-04-15 01:34:43] +++ HOME_URL=https://www.centos.org/ [2025-04-15 01:34:43] +++ BUG_REPORT_URL=https://bugs.centos.org/ [2025-04-15 01:34:43] +++ CENTOS_MANTISBT_PROJECT=CentOS-7 [2025-04-15 01:34:43] +++ CENTOS_MANTISBT_PROJECT_VERSION=7 [2025-04-15 01:34:43] +++ REDHAT_SUPPORT_PRODUCT=centos [2025-04-15 01:34:43] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7 [2025-04-15 01:34:43] ++ echo 'CentOS Linux 7 (Core)' [2025-04-15 01:34:43] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)' [2025-04-15 01:34:43] + '[' -n 'CentOS Linux 7 (Core)' ']' [2025-04-15 01:34:43] + echo 'systemsoftware=CentOS Linux 7 (Core)' [2025-04-15 01:34:43] + HOME=/scratch/boinc/var/slot36/slots/0 [2025-04-15 01:34:43] + export HOME [2025-04-15 01:34:43] + cd /scratch/boinc/var/slot36/slots/0 [2025-04-15 01:34:43] + '[' '!' -z '' ']' [2025-04-15 01:34:43] + '[' -z '' ']' [2025-04-15 01:34:43] ++ /bin/hostname -f [2025-04-15 01:34:43] + nodename=skurut17.grid.cesnet.cz [2025-04-15 01:34:43] + echo nodename=skurut17.grid.cesnet.cz [2025-04-15 01:34:43] + echo Processors=2 [2025-04-15 01:34:43] + echo Nodecount=1 [2025-04-15 01:34:43] + echo Benchmark=HEPSPEC:1.0 [2025-04-15 01:34:43] + executable=./runpilot2-wrapper.sh [2025-04-15 01:34:43] + '[' '!' -f ./runpilot2-wrapper.sh ']' [2025-04-15 01:34:43] ++ dd if=./runpilot2-wrapper.sh count=1 [2025-04-15 01:34:43] ++ head -n 1 [2025-04-15 01:34:43] ++ tr -d '\0' [2025-04-15 01:34:43] + line1='#!/bin/bash' [2025-04-15 01:34:43] ++ echo '#!/bin/bash' [2025-04-15 01:34:43] ++ sed -n 's/^#! *//p' [2025-04-15 01:34:43] + shebang=/bin/bash [2025-04-15 01:34:43] ++ echo /bin/bash [2025-04-15 01:34:43] ++ awk '{print $1}' [2025-04-15 01:34:43] + interpreter=/bin/bash [2025-04-15 01:34:43] + '[' /bin/bash = /usr/bin/env ']' [2025-04-15 01:34:43] + '[' x/bin/bash = x ']' [2025-04-15 01:34:43] + type /bin/bash [2025-04-15 01:34:43] + '[' xgnutime = xgnutime ']' [2025-04-15 01:34:43] + /usr/bin/time -o /scratch/boinc/var/slot36/slots/0/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.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-15 01:34:43] + RESULT=2 [2025-04-15 01:34:43] + sed -i -e /nodename=/d /scratch/boinc/var/slot36/slots/0/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.diag [2025-04-15 01:34:43] ++ grep domain_name init_data.xml [2025-04-15 01:34:43] ++ awk -F '>' '{print $2}' [2025-04-15 01:34:43] ++ awk -F '<' '{print $1}' [2025-04-15 01:34:43] ++ sed -e 's# #_#g' [2025-04-15 01:34:43] + hostname=skurut17.grid.cesnet.cz [2025-04-15 01:34:43] ++ grep user_name init_data.xml [2025-04-15 01:34:43] ++ awk -F '>' '{print $2}' [2025-04-15 01:34:43] ++ awk -F '<' '{print $1}' [2025-04-15 01:34:43] ++ sed -e 's# #_#g' [2025-04-15 01:34:43] + username=praguelcg2 [2025-04-15 01:34:43] + nodename=praguelcg2@skurut17.grid.cesnet.cz [2025-04-15 01:34:43] + echo nodename=praguelcg2@skurut17.grid.cesnet.cz [2025-04-15 01:34:43] + '[' -n 4 ']' [2025-04-15 01:34:43] + sed -i -e s/Processors=1/Processors=4/ /scratch/boinc/var/slot36/slots/0/KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.diag [2025-04-15 01:34:43] + echo exitcode=2 [2025-04-15 01:34:43] + runtimeenvironments= [2025-04-15 01:34:43] + runtimeenvironments='APPS/HEP/ATLAS-SITE;' [2025-04-15 01:34:43] + RTE_function_0 2 [2025-04-15 01:34:43] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-04-15 01:34:43] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome [2025-04-15 01:34:43] + export BOINC_APP=ATLAS [2025-04-15 01:34:43] + BOINC_APP=ATLAS [2025-04-15 01:34:43] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-04-15 01:34:43] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC [2025-04-15 01:34:43] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-04-15 01:34:43] + RESULT_TEMPLATE=templates/ATLAS_OUT_2 [2025-04-15 01:34:43] + '[' -z 2 ']' [2025-04-15 01:34:43] + '[' 2 == 1 ']' [2025-04-15 01:34:43] + '[' 0 -ne 0 ']' [2025-04-15 01:34:43] + echo 'zip all output files' [2025-04-15 01:34:43] + flist='*.diag ' [2025-04-15 01:34:43] + for f in ./heartbeat.json ./output.list ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 ./gmlog/ [2025-04-15 01:34:43] + '[' -e ./heartbeat.json ']' [2025-04-15 01:34:43] + flist='*.diag ./heartbeat.json' [2025-04-15 01:34:43] + for f in ./heartbeat.json ./output.list ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 ./gmlog/ [2025-04-15 01:34:43] + '[' -e ./output.list ']' [2025-04-15 01:34:43] + for f in ./heartbeat.json ./output.list ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 ./gmlog/ [2025-04-15 01:34:43] + '[' -e ./log.44075164._047914.job.log.1 ']' [2025-04-15 01:34:43] + flist='*.diag ./heartbeat.json ./log.44075164._047914.job.log.1' [2025-04-15 01:34:43] + for f in ./heartbeat.json ./output.list ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 ./gmlog/ [2025-04-15 01:34:43] + '[' -e ./log.44075164._047914.job.log.1 ']' [2025-04-15 01:34:43] + flist='*.diag ./heartbeat.json ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1' [2025-04-15 01:34:43] + for f in ./heartbeat.json ./output.list ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 ./gmlog/ [2025-04-15 01:34:43] + '[' -e ./gmlog/ ']' [2025-04-15 01:34:43] + '[' -f output.list ']' [2025-04-15 01:34:43] + tar cvf result.tar.gz KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.diag ./heartbeat.json ./log.44075164._047914.job.log.1 ./log.44075164._047914.job.log.1 [2025-04-15 01:34:43] + '[' xgnutime = xcgroup ']' [2025-04-15 01:34:43] + '[' -n '' ']' [2025-04-15 01:34:43] + '[' -n '' ']' [2025-04-15 01:34:43] ++ date +%s [2025-04-15 01:34:43] + ACCOUNTING_ENDTIME=1744673683 [2025-04-15 01:34:43] ++ date -d '1970-01-01 UTC 1744673494 seconds' +%Y%m%d%H%M%SZ [2025-04-15 01:34:43] + echo LRMSStartTime=20250415013134Z [2025-04-15 01:34:43] ++ date -d '1970-01-01 UTC 1744673683 seconds' +%Y%m%d%H%M%SZ [2025-04-15 01:34:43] + echo LRMSEndTime=20250415013443Z [2025-04-15 01:34:43] + echo walltime=189 [2025-04-15 01:34:43] + echo exitcode=2 [2025-04-15 01:34:43] + exit 2 [2025-04-15 01:34:43] ./runtime_log.err [2025-04-15 01:34:43] ./pilotlog.txt [2025-04-15 01:34:43] ./pilot3/pilot/util/lokirealtimelogger.py [2025-04-15 01:34:43] ./pilot3/pilot/util/loggingsupport.py [2025-04-15 01:34:43] ./pilot3/pilot/util/realtimelogger.py [2025-04-15 01:34:43] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc [2025-04-15 01:34:43] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc [2025-04-15 01:34:43] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc [2025-04-15 01:34:43] ./runtime_log [2025-04-15 01:34:43] ./log.44075164._047914.job.log.1 [2025-04-15 01:34:43] ./PanDA_Pilot-6600504960/PoolFileCatalog.xml [2025-04-15 01:34:43] ./PanDA_Pilot-6600504960/prmon.log [2025-04-15 01:34:43] ./PanDA_Pilot-6600504960/pilotlog.txt [2025-04-15 01:34:43] ./PanDA_Pilot-6600504960/log.EVNTtoHITS 02:07:46 (1516872): wrapper (7.7.26015): starting 02:07:46 (1516872): wrapper: running run_atlas (--nthreads 4) [2025-04-15 02:07:46] Arguments: --nthreads 4 [2025-04-15 02:07:46] Threads: 4 [2025-04-15 02:07:46] This job has been restarted, cleaning up previous attempt [2025-04-15 02:07:46] Checking for CVMFS [2025-04-15 02:07:46] No cvmfs_config command found, will try listing directly [2025-04-15 02:07:46] CVMFS is ok [2025-04-15 02:07:46] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-04-15 02:07:46] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-04-15 02:07:46] Further information can be found at the LHC@home message board. [2025-04-15 02:07:46] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-04-15 02:07:46] Checking for apptainer binary... [2025-04-15 02:07:46] which: no apptainer in ((null)) [2025-04-15 02:07:46] apptainer is not installed, using version from CVMFS [2025-04-15 02:07:46] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-04-15 02:07:46] WARNING: Environment variable TMPDIR already has value [/scratch/boinc/var/slot36/slots/0/.apptainertmp], will not forward new value [/tmp] from parent process environment skurut17.grid.cesnet.cz [2025-04-15 02:07:46] apptainer works [2025-04-15 02:07:46] Set ATHENA_PROC_NUMBER=4 [2025-04-15 02:07:46] Set ATHENA_CORE_NUMBER=4 [2025-04-15 02:07:46] Starting ATLAS job with PandaID=6600504960 [2025-04-15 02:07:46] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/scratch/boinc/var/slot36/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-04-15 04:50:24] *** The last 200 lines of the pilot log: *** [2025-04-15 04:50:24] 2025-04-15 02:50:09,835 | INFO | sum of square deviations: 1246386160.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | sum of deviations: 55924502747.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | mean x: 1744680530.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | mean y: 2273283.0314465407 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | -- intersect: -78280360321.16583 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | intersect: -78280360321.16583 [2025-04-15 04:50:24] 2025-04-15 02:50:09,836 | INFO | chi2: 3.624723285499347 [2025-04-15 04:50:24] 2025-04-15 02:50:09,837 | INFO | sum of square deviations: 1132458442.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | sum of deviations: 54115795986.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | mean x: 1744680377.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | mean y: 2270861.162337662 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | -- intersect: -83369236495.8856 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | intersect: -83369236495.8856 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | chi2: 3.6247371023572454 [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | current chi2=3.6247371023572454 (change=-0.0003811837983198995 %) [2025-04-15 04:50:24] 2025-04-15 02:50:09,838 | INFO | right removable region: 153 [2025-04-15 04:50:24] 2025-04-15 02:50:09,839 | INFO | sum of square deviations: 1132458442.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | sum of deviations: 21153036154.499992 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | mean x: 1744680682.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | mean y: 2319622.772727273 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | -- intersect: -32586331907.351936 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | intersect: -32586331907.351936 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | chi2: 1.284886425331553 [2025-04-15 04:50:24] 2025-04-15 02:50:09,840 | INFO | current chi2=1.284886425331553 (change=64.55215131947526 %) [2025-04-15 04:50:24] 2025-04-15 02:50:09,841 | INFO | sum of square deviations: 1025693650.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,841 | INFO | sum of deviations: -5086134738.000001 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | mean x: 1744680835.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | mean y: 2357109.9395973156 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | -- intersect: 8653752974.207985 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | intersect: 8653752974.207985 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | chi2: 0.0657780692884546 [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | current chi2=0.0657780692884546 (change=94.88063162691743 %) [2025-04-15 04:50:24] 2025-04-15 02:50:09,842 | INFO | sum of square deviations: 925859220.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,843 | INFO | sum of deviations: -7896229698.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,843 | INFO | mean x: 1744680987.5 [2025-04-15 04:50:24] 2025-04-15 02:50:09,843 | INFO | mean y: 2361284.923611111 [2025-04-15 04:50:24] 2025-04-15 02:50:09,844 | INFO | -- intersect: 14881947220.143661 [2025-04-15 04:50:24] 2025-04-15 02:50:09,844 | INFO | intersect: 14881947220.143661 [2025-04-15 04:50:24] 2025-04-15 02:50:09,844 | INFO | chi2: 0.011302859451053048 [2025-04-15 04:50:24] 2025-04-15 02:50:09,844 | INFO | current chi2=0.011302859451053048 (change=82.8166749597241 %) [2025-04-15 04:50:24] 2025-04-15 02:50:09,844 | INFO | sum of square deviations: 832722590.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,845 | INFO | sum of deviations: -6923221901.000001 [2025-04-15 04:50:24] 2025-04-15 02:50:09,845 | INFO | mean x: 1744681140.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,845 | INFO | mean y: 2359683.237410072 [2025-04-15 04:50:24] 2025-04-15 02:50:09,845 | INFO | -- intersect: 14507568048.858486 [2025-04-15 04:50:24] 2025-04-15 02:50:09,845 | INFO | intersect: 14507568048.858486 [2025-04-15 04:50:24] 2025-04-15 02:50:09,846 | INFO | chi2: 0.011075362797009495 [2025-04-15 04:50:24] 2025-04-15 02:50:09,846 | INFO | current chi2=0.011075362797009495 (change=2.0127354058388964 %) [2025-04-15 04:50:24] 2025-04-15 02:50:09,846 | INFO | left removable region: 40 [2025-04-15 04:50:24] 2025-04-15 02:50:09,846 | INFO | sum of square deviations: 447383272.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | sum of deviations: -3776558556.000001 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | mean x: 1744681567.0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | mean y: 2354099.4601769913 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | -- intersect: 14729976949.313488 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | intersect: 14729976949.313488 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | chi2: 0.010108564343492851 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | -- intersect: 14729976949.313488 [2025-04-15 04:50:24] 2025-04-15 02:50:09,847 | INFO | current memory leak: -8.44 B/s (using 113 data points, chi2=0.01) [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | .............................. [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . Timing measurements: [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . get job = 0 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . initial setup = 1 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . payload setup = 8 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . stage-in = 0 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . payload execution = 9692 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,848 | INFO | . stage-out = 1 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,849 | INFO | . log creation = 0 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,849 | INFO | .............................. [2025-04-15 04:50:24] 2025-04-15 02:50:09,952 | INFO | [2025-04-15 04:50:24] 2025-04-15 02:50:09,952 | INFO | job summary report [2025-04-15 04:50:24] 2025-04-15 02:50:09,952 | INFO | -------------------------------------------------- [2025-04-15 04:50:24] 2025-04-15 02:50:09,952 | INFO | PanDA job id: 6600504960 [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | task id: 44075164 [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | errors: (none) [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | status: LOG_TRANSFER = DONE [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | pilot state: finished [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | transexitcode: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | exeerrorcode: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | exeerrordiag: [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | exitcode: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | exitmsg: OK [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | cpuconsumptiontime: 34772 s [2025-04-15 04:50:24] 2025-04-15 02:50:09,953 | INFO | nevents: 400 [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | neventsw: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | pid: 1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | pgrp: 1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | corecount: 4 [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | event service: False [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | sizes: {0: 2417167, 1: 2417366, 7: 2417572, 11: 2417600, 9704: 2446339, 9705: 2455302, 9707: 2455486, 9714: 2455656} [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | -------------------------------------------------- [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | [2025-04-15 04:50:24] 2025-04-15 02:50:09,954 | INFO | executing command: ls -lF /scratch/boinc/var/slot36/slots/0 [2025-04-15 04:50:24] 2025-04-15 02:50:09,988 | INFO | queue jobs had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,988 | INFO | queue payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,988 | INFO | queue data_in had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,988 | INFO | queue data_out had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,988 | INFO | queue current_data_in had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,989 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | queue completed_jobids has 1 job(s) [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | queue messages had 0 job(s) [purged] [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | job 6600504960 has completed (purged errors) [2025-04-15 04:50:24] 2025-04-15 02:50:09,990 | INFO | overall cleanup function is called [2025-04-15 04:50:24] 2025-04-15 02:50:10,999 | INFO | --- collectZombieJob: --- 10, [1539333] [2025-04-15 04:50:24] 2025-04-15 02:50:11,000 | INFO | zombie collector waiting for pid 1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:11,000 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-04-15 04:50:24] 2025-04-15 02:50:11,000 | INFO | collected zombie processes [2025-04-15 04:50:24] 2025-04-15 02:50:11,000 | INFO | will attempt to kill all subprocesses of pid=1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:11,749 | INFO | process IDs to be killed: [1539333] (in reverse order) [2025-04-15 04:50:24] 2025-04-15 02:50:12,002 | WARNING | found no corresponding commands to process id(s) [2025-04-15 04:50:24] 2025-04-15 02:50:12,003 | INFO | Do not look for orphan processes in BOINC jobs [2025-04-15 04:50:24] 2025-04-15 02:50:12,028 | INFO | did not find any defunct processes belonging to 1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:12,050 | INFO | did not find any defunct processes belonging to 1539333 [2025-04-15 04:50:24] 2025-04-15 02:50:12,050 | INFO | ready for new job [2025-04-15 04:50:24] 2025-04-15 02:50:12,051 | INFO | pilot has finished with previous job - re-establishing logging [2025-04-15 04:50:24] 2025-04-15 02:50:12,053 | INFO | ************************************** [2025-04-15 04:50:24] 2025-04-15 02:50:12,053 | INFO | *** PanDA Pilot version 3.10.2.2 *** [2025-04-15 04:50:24] 2025-04-15 02:50:12,053 | INFO | ************************************** [2025-04-15 04:50:24] 2025-04-15 02:50:12,053 | INFO | [2025-04-15 04:50:24] 2025-04-15 02:50:12,061 | INFO | architecture information: [2025-04-15 04:50:24] 2025-04-15 02:50:12,062 | INFO | executing command: cat /etc/os-release [2025-04-15 04:50:24] 2025-04-15 02:50:12,084 | INFO | cat /etc/os-release: [2025-04-15 04:50:24] NAME="CentOS Linux" [2025-04-15 04:50:24] VERSION="7 (Core)" [2025-04-15 04:50:24] ID="centos" [2025-04-15 04:50:24] ID_LIKE="rhel fedora" [2025-04-15 04:50:24] VERSION_ID="7" [2025-04-15 04:50:24] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-04-15 04:50:24] ANSI_COLOR="0;31" [2025-04-15 04:50:24] CPE_NAME="cpe:/o:centos:centos:7" [2025-04-15 04:50:24] HOME_URL="https://www.centos.org/" [2025-04-15 04:50:24] BUG_REPORT_URL="https://bugs.centos.org/" [2025-04-15 04:50:24] [2025-04-15 04:50:24] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-04-15 04:50:24] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-04-15 04:50:24] REDHAT_SUPPORT_PRODUCT="centos" [2025-04-15 04:50:24] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-04-15 04:50:24] [2025-04-15 04:50:24] 2025-04-15 02:50:12,085 | INFO | ************************************** [2025-04-15 04:50:24] 2025-04-15 02:50:12,587 | INFO | executing command: df -mP /scratch/boinc/var/slot36/slots/0 [2025-04-15 04:50:24] 2025-04-15 02:50:12,612 | INFO | sufficient remaining disk space (3299787931648 B) [2025-04-15 04:50:24] 2025-04-15 02:50:12,612 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-04-15 04:50:24] 2025-04-15 02:50:12,613 | INFO | current server update state: UPDATING_FINAL [2025-04-15 04:50:24] 2025-04-15 02:50:12,613 | INFO | update_server=False [2025-04-15 04:50:24] 2025-04-15 02:50:12,613 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-04-15 04:50:24] 2025-04-15 02:50:12,613 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-04-15 04:50:24] 2025-04-15 02:50:12,798 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-04-15 04:50:24] 2025-04-15 02:50:12,799 | INFO | aborting loop [2025-04-15 04:50:24] 2025-04-15 02:50:12,962 | INFO | all job control threads have been joined [2025-04-15 04:50:24] 2025-04-15 02:50:13,022 | INFO | all data control threads have been joined [2025-04-15 04:50:24] 2025-04-15 02:50:13,541 | INFO | found 0 job(s) in 20 queues [2025-04-15 04:50:24] 2025-04-15 02:50:13,541 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-04-15 04:50:24] 2025-04-15 02:50:13,542 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-04-15 04:50:24] 2025-04-15 02:50:13,618 | INFO | [job] retrieve thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,674 | INFO | [data] copytool_in thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,713 | INFO | [payload] failed_post thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,803 | INFO | [job] job monitor thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,812 | INFO | [payload] run_realtimelog thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,867 | INFO | [job] validate thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:13,967 | INFO | [job] control thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,028 | INFO | [data] control thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,050 | INFO | all payload control threads have been joined [2025-04-15 04:50:24] 2025-04-15 02:50:14,109 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-04-15 04:50:24] 2025-04-15 02:50:14,201 | INFO | [payload] validate_pre thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,317 | INFO | [job] create_data_payload thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,473 | INFO | [payload] validate_post thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,618 | INFO | [data] copytool_out thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:14,962 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-04-15 04:50:24] 2025-04-15 02:50:15,013 | INFO | [payload] execute_payloads thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:15,055 | INFO | [payload] control thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:15,967 | INFO | [job] queue monitor thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:18,115 | INFO | [data] queue_monitor thread has finished [2025-04-15 04:50:24] 2025-04-15 02:50:19,002 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 22907872720704)>', '<ExcThread(monitor, started 22907631650560)>'] [2025-04-15 04:50:24] 2025-04-15 02:50:19,571 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-04-15 04:50:24] 2025-04-15 02:50:19,571 | INFO | [monitor] control thread has ended [2025-04-15 04:50:24] 2025-04-15 02:50:24,027 | INFO | all workflow threads have been joined [2025-04-15 04:50:24] 2025-04-15 02:50:24,027 | INFO | end of generic workflow (traces error code: 0) [2025-04-15 04:50:24] 2025-04-15 02:50:24,028 | INFO | traces error code: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:24,028 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-04-15 04:50:24] 2025-04-15 02:50:24,168 [wrapper] ==== pilot stdout END ==== [2025-04-15 04:50:24] 2025-04-15 02:50:24,172 [wrapper] ==== wrapper stdout RESUME ==== [2025-04-15 04:50:24] 2025-04-15 02:50:24,176 [wrapper] pilotpid: 1524714 [2025-04-15 04:50:24] 2025-04-15 02:50:24,181 [wrapper] Pilot exit status: 0 [2025-04-15 04:50:24] 2025-04-15 02:50:24,196 [wrapper] pandaids: 6600504960 6600504960 6600504960 [2025-04-15 04:50:24] 2025-04-15 02:50:24,343 [wrapper] cleanup supervisor_pilot 2295563 1524715 [2025-04-15 04:50:24] 2025-04-15 02:50:24,347 [wrapper] Test setup, not cleaning [2025-04-15 04:50:24] 2025-04-15 02:50:24,351 [wrapper] apfmon messages muted [2025-04-15 04:50:24] 2025-04-15 02:50:24,355 [wrapper] ==== wrapper stdout END ==== [2025-04-15 04:50:24] 2025-04-15 02:50:24,359 [wrapper] ==== wrapper stderr END ==== [2025-04-15 04:50:24] *** Error codes and diagnostics *** [2025-04-15 04:50:24] "exeErrorCode": 0, [2025-04-15 04:50:24] "exeErrorDiag": "", [2025-04-15 04:50:24] "pilotErrorCode": 0, [2025-04-15 04:50:24] "pilotErrorDiag": "", [2025-04-15 04:50:24] *** Listing of results directory *** [2025-04-15 04:50:24] total 630160 [2025-04-15 04:50:24] drwx------ 4 boinc boinc 4096 Apr 3 10:00 pilot3 [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 495897 Apr 12 20:58 pilot3.tar.gz [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 5111 Apr 12 21:07 queuedata.json [2025-04-15 04:50:24] -rwx------ 1 boinc boinc 37140 Apr 12 21:08 runpilot2-wrapper.sh [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 100 Apr 14 12:20 wrapper_26015_x86_64-pc-linux-gnu [2025-04-15 04:50:24] -rwxr-xr-x 1 boinc boinc 7986 Apr 14 12:20 run_atlas [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 105 Apr 14 12:20 job.xml [2025-04-15 04:50:24] -rw-r--r-- 3 boinc boinc 220202787 Apr 14 12:31 EVNT.44075162._001864.pool.root.1 [2025-04-15 04:50:24] -rw-r--r-- 3 boinc boinc 220202787 Apr 14 12:31 ATLAS.root_0 [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 17569 Apr 14 12:31 start_atlas.sh [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 508886 Apr 14 12:31 input.tar.gz [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 0 Apr 14 12:31 boinc_lockfile [2025-04-15 04:50:24] -rw------- 1 boinc boinc 0 Apr 15 01:31 wrapper_sigint_1396159 [2025-04-15 04:50:24] -rw------- 1 boinc boinc 0 Apr 15 01:34 wrapper_sigkill_1396159 [2025-04-15 04:50:24] drwxrwx--x 2 boinc boinc 4096 Apr 15 01:34 shared [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 2550 Apr 15 02:07 pandaJob.out [2025-04-15 04:50:24] -rw------- 1 boinc boinc 424 Apr 15 02:07 setup.sh.local [2025-04-15 04:50:24] -rw------- 1 boinc boinc 986083 Apr 15 02:07 agis_schedconf.cvmfs.json [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 6681 Apr 15 02:57 init_data.xml [2025-04-15 04:50:24] -rw------- 1 boinc boinc 198566121 Apr 15 04:49 HITS.44075164._047914.pool.root.1 [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 529 Apr 15 04:49 boinc_task_state.xml [2025-04-15 04:50:24] -rw------- 1 boinc boinc 1030 Apr 15 04:49 memory_monitor_summary.json [2025-04-15 04:50:24] -rw------- 1 boinc boinc 98 Apr 15 04:49 pilot_heartbeat.json [2025-04-15 04:50:24] -rw------- 1 boinc boinc 1603529 Apr 15 04:50 agis_ddmendpoints.agis.ALL.json [2025-04-15 04:50:24] -rw------- 1 boinc boinc 309090 Apr 15 04:50 log.44075164._047914.job.log.tgz.1 [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 8192 Apr 15 04:50 boinc_mmap_file [2025-04-15 04:50:24] -rw------- 1 boinc boinc 7702 Apr 15 04:50 heartbeat.json [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 27 Apr 15 04:50 wrapper_checkpoint.txt [2025-04-15 04:50:24] -rw------- 1 boinc boinc 4364 Apr 15 04:50 pilotlog.txt [2025-04-15 04:50:24] -rw------- 1 boinc boinc 910150 Apr 15 04:50 log.44075164._047914.job.log.1 [2025-04-15 04:50:24] -rw------- 1 boinc boinc 357 Apr 15 04:50 output.list [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 620 Apr 15 04:50 runtime_log [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 1239040 Apr 15 04:50 result.tar.gz [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 11500 Apr 15 04:50 runtime_log.err [2025-04-15 04:50:24] -rw------- 1 boinc boinc 1390 Apr 15 04:50 KfIODm9NvN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmv7RLDmgPrIHn.diag [2025-04-15 04:50:24] -rw-r--r-- 1 boinc boinc 40325 Apr 15 04:50 stderr.txt [2025-04-15 04:50:24] HITS file was successfully produced: [2025-04-15 04:50:24] -rw------- 1 boinc boinc 198566121 Apr 15 04:49 shared/HITS.pool.root.1 [2025-04-15 04:50:24] *** Contents of shared directory: *** [2025-04-15 04:50:24] total 410700 [2025-04-15 04:50:24] -rw-r--r-- 3 boinc boinc 220202787 Apr 14 12:31 ATLAS.root_0 [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 17569 Apr 14 12:31 start_atlas.sh [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 508886 Apr 14 12:31 input.tar.gz [2025-04-15 04:50:24] -rw------- 1 boinc boinc 198566121 Apr 15 04:49 HITS.pool.root.1 [2025-04-15 04:50:24] -rw-r--r-- 2 boinc boinc 1239040 Apr 15 04:50 result.tar.gz 04:50:26 (1516872): run_atlas exited; CPU time 35331.237837 04:50:26 (1516872): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN