| Name | OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm_0 |
| Workunit | 223040226 |
| Created | 16 May 2024, 1:31:51 UTC |
| Sent | 16 May 2024, 6:35:20 UTC |
| Report deadline | 24 May 2024, 6:35:20 UTC |
| Received | 18 May 2024, 12:56:50 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10804957 |
| Run time | 9 hours 39 min 32 sec |
| CPU time | 1 days 17 hours 29 min 4 sec |
| Validate state | Valid |
| Credit | 2,205.72 |
| Device peak FLOPS | 41.63 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 2.46 GB |
| Peak swap size | 3.15 GB |
| Peak disk usage | 1.85 GB |
Stderr output
<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
02:36:00 (9654): wrapper (7.7.26015): starting
02:36:00 (9654): wrapper: running run_atlas (--nthreads 8)
[2024-05-16 02:36:00] Arguments: --nthreads 8
[2024-05-16 02:36:00] Threads: 8
[2024-05-16 02:36:00] Checking for CVMFS
[2024-05-16 02:36:00] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-16 02:36:00] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-16 02:36:00] Running cvmfs_config stat atlas.cern.ch
[2024-05-16 02:36:01] 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
[2024-05-16 02:36:01] 2.11.2.0 18811 3395 107044 132788 1 432 14023416 18432000 21742 130560 0 224694 93.711 4061756 35086 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-16 02:36:01] CVMFS is ok
[2024-05-16 02:36:01] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-16 02:36:01] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-16 02:36:01] Further information can be found at the LHC@home message board.
[2024-05-16 02:36:01] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-16 02:36:01] Checking for apptainer binary...
[2024-05-16 02:36:01] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-16 02:36:01] Running /usr/bin/apptainer --version
[2024-05-16 02:36:01] apptainer version 1.3.0-1.el7
[2024-05-16 02:36:01] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-16 02:36:03] c-212-7.aglt2.org
[2024-05-16 02:36:03] apptainer works
[2024-05-16 02:36:04] Set ATHENA_PROC_NUMBER=8
[2024-05-16 02:36:04] Set ATHENA_CORE_NUMBER=8
[2024-05-16 02:36:04] Starting ATLAS job with PandaID=6207095024
[2024-05-16 02:36:04] 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
05:04:10 (9654): BOINC client no longer exists - exiting
05:04:10 (9654): timer handler: client dead, exiting
01:12:48 (3996): wrapper (7.7.26015): starting
01:12:48 (3996): wrapper: running run_atlas (--nthreads 8)
[2024-05-18 01:12:48] Arguments: --nthreads 8
[2024-05-18 01:12:48] Threads: 8
[2024-05-18 01:12:48] This job has been restarted, cleaning up previous attempt
[2024-05-18 01:12:48] Checking for CVMFS
[2024-05-18 01:12:48] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-18 01:12:48] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-18 01:12:48] Running cvmfs_config stat atlas.cern.ch
[2024-05-18 01:12:48] 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
[2024-05-18 01:12:48] 2.11.2.0 94999 2781 213200 132867 0 378 16611764 18432001 12135 130560 0 12496743 97.343 69642993 66470 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-18 01:12:48] CVMFS is ok
[2024-05-18 01:12:48] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-18 01:12:48] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-18 01:12:48] Further information can be found at the LHC@home message board.
[2024-05-18 01:12:48] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-18 01:12:48] Checking for apptainer binary...
[2024-05-18 01:12:48] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-18 01:12:48] Running /usr/bin/apptainer --version
[2024-05-18 01:12:48] apptainer version 1.3.0-1.el7
[2024-05-18 01:12:48] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-18 01:12:50] c-212-7.aglt2.org
[2024-05-18 01:12:50] apptainer works
[2024-05-18 01:12:50] Set ATHENA_PROC_NUMBER=8
[2024-05-18 01:12:50] Set ATHENA_CORE_NUMBER=8
[2024-05-18 01:12:50] Starting ATLAS job with PandaID=6207095024
[2024-05-18 01:12:50] 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
[2024-05-18 01:15:59] Job failed
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + export RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/5/
[2024-05-18 01:15:59] + RUNTIME_CONFIG_DIR=/tmp/boinchome/slots/5/
[2024-05-18 01:15:59] + mv ATLAS.root_0 EVNT.38776210._000015.pool.root.1
[2024-05-18 01:15:59] mv: ‘ATLAS.root_0’ and ‘EVNT.38776210._000015.pool.root.1’ are the same file
[2024-05-18 01:15:59] + tar --strip-components=5 -xvf input.tar.gz
[2024-05-18 01:15:59] + umask 077
[2024-05-18 01:15:59] ++ date +%s
[2024-05-18 01:15:59] + ACCOUNTING_STARTTIME=1716009171
[2024-05-18 01:15:59] + echo 'Detecting resource accounting method available for the job.'
[2024-05-18 01:15:59] Detecting resource accounting method available for the job.
[2024-05-18 01:15:59] + JOB_ACCOUNTING=
[2024-05-18 01:15:59] + command -v arc-job-cgroup
[2024-05-18 01:15:59] + '[' -z '' ']'
[2024-05-18 01:15:59] + GNU_TIME=/usr/bin/time
[2024-05-18 01:15:59] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2024-05-18 01:15:59] Looking for /usr/bin/time tool for accounting measurements
[2024-05-18 01:15:59] + '[' '!' -z /usr/bin/time ']'
[2024-05-18 01:15:59] + /usr/bin/time --version
[2024-05-18 01:15:59] + echo 'GNU time found and will be used for job accounting.'
[2024-05-18 01:15:59] GNU time found and will be used for job accounting.
[2024-05-18 01:15:59] + JOB_ACCOUNTING=gnutime
[2024-05-18 01:15:59] + '[' -z gnutime ']'
[2024-05-18 01:15:59] + export PANDA_JSID=harvester-CERN_central_ACTA
[2024-05-18 01:15:59] + PANDA_JSID=harvester-CERN_central_ACTA
[2024-05-18 01:15:59] + export GTAG=http://aipanda403.cern.ch/data/jobs/2024-05-16/BOINC_MCORE/6207095024.out
[2024-05-18 01:15:59] + GTAG=http://aipanda403.cern.ch/data/jobs/2024-05-16/BOINC_MCORE/6207095024.out
[2024-05-18 01:15:59] + export PILOT_NOKILL=YES
[2024-05-18 01:15:59] + PILOT_NOKILL=YES
[2024-05-18 01:15:59] + export GRID_GLOBAL_JOBID=OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm
[2024-05-18 01:15:59] + GRID_GLOBAL_JOBID=OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm
[2024-05-18 01:15:59] + export GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm
[2024-05-18 01:15:59] + GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm
[2024-05-18 01:15:59] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2024-05-18 01:15:59] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2024-05-18 01:15:59] + export GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2024-05-18 01:15:59] + GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + RUNTIME_JOB_DIR=/tmp/boinchome/slots/5
[2024-05-18 01:15:59] + RUNTIME_JOB_STDIN=/dev/null
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + RUNTIME_JOB_STDOUT=/tmp/boinchome/slots/5/log.38921013._000301.job.log.1
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + RUNTIME_JOB_STDERR=/tmp/boinchome/slots/5/log.38921013._000301.job.log.1
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/5.diag
[2024-05-18 01:15:59] + '[' '!' -z '' ']'
[2024-05-18 01:15:59] + RUNTIME_LOCAL_SCRATCH_DIR=
[2024-05-18 01:15:59] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2024-05-18 01:15:59] + RUNTIME_FRONTEND_SEES_NODE=
[2024-05-18 01:15:59] + RUNTIME_NODE_SEES_FRONTEND=yes
[2024-05-18 01:15:59] + '[' '!' -z '' ']'
[2024-05-18 01:15:59] + '[' -z yes ']'
[2024-05-18 01:15:59] ++ pwd
[2024-05-18 01:15:59] + RUNTIME_JOB_DIAG=/tmp/boinchome/slots/5/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.diag
[2024-05-18 01:15:59] + runtimeenvironments=
[2024-05-18 01:15:59] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2024-05-18 01:15:59] + RTE_function_0 1
[2024-05-18 01:15:59] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2024-05-18 01:15:59] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2024-05-18 01:15:59] + export BOINC_APP=ATLAS
[2024-05-18 01:15:59] + BOINC_APP=ATLAS
[2024-05-18 01:15:59] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2024-05-18 01:15:59] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2024-05-18 01:15:59] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2024-05-18 01:15:59] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2024-05-18 01:15:59] + '[' -z 1 ']'
[2024-05-18 01:15:59] + '[' 1 == 1 ']'
[2024-05-18 01:15:59] + shift
[2024-05-18 01:15:59] + 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)'
[2024-05-18 01:15:59] + FRONTIER_BACKUP='(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
[2024-05-18 01:15:59] + FRONTIER_WPAD='(proxyconfigurl=http://grid-wpad/wpad.dat)'
[2024-05-18 01:15:59] + export ATLAS_LOCAL_AREA=/tmp/boinchome/slots/5/
[2024-05-18 01:15:59] + ATLAS_LOCAL_AREA=/tmp/boinchome/slots/5/
[2024-05-18 01:15:59] + '[' -e /tmp/boinchome/slots/5/init_data.xml ']'
[2024-05-18 01:15:59] + grep '<use_http_proxy/>' /tmp/boinchome/slots/5/init_data.xml
[2024-05-18 01:15:59] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_name>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/5/init_data.xml
[2024-05-18 01:15:59] + PROXY_HOST=sl-um-es2.slateci.io
[2024-05-18 01:15:59] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_port>\([^<]*\).*/\1/p' -n /tmp/boinchome/slots/5/init_data.xml
[2024-05-18 01:15:59] + PROXY_PORT=6081
[2024-05-18 01:15:59] + '[' -n sl-um-es2.slateci.io ']'
[2024-05-18 01:15:59] + '[' -n 6081 ']'
[2024-05-18 01:15:59] + FRONTIER_SERVER_URLS='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)'
[2024-05-18 01:15:59] + FRONTIER_PROXY_URLS='(proxyurl=http://sl-um-es2.slateci.io:6081)(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)'
[2024-05-18 01:15:59] + echo 'export FRONTIER_SERVER="(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://sl-um-es2.slateci.io:6081)(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)"'
[2024-05-18 01:15:59] + export 'FRONTIER_SERVER=(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://sl-um-es2.slateci.io:6081)(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)'
[2024-05-18 01:15:59] + FRONTIER_SERVER='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://sl-um-es2.slateci.io:6081)(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)'
[2024-05-18 01:15:59] + '[' 0 -ne 0 ']'
[2024-05-18 01:15:59] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2024-05-18 01:15:59] + '[' -f /etc/os-release ']'
[2024-05-18 01:15:59] +++ cat /etc/os-release
[2024-05-18 01:15:59] ++ 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"'
[2024-05-18 01:15:59] +++ NAME='CentOS Linux'
[2024-05-18 01:15:59] +++ VERSION='7 (Core)'
[2024-05-18 01:15:59] +++ ID=centos
[2024-05-18 01:15:59] +++ ID_LIKE='rhel fedora'
[2024-05-18 01:15:59] +++ VERSION_ID=7
[2024-05-18 01:15:59] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2024-05-18 01:15:59] +++ ANSI_COLOR='0;31'
[2024-05-18 01:15:59] +++ CPE_NAME=cpe:/o:centos:centos:7
[2024-05-18 01:15:59] +++ HOME_URL=https://www.centos.org/
[2024-05-18 01:15:59] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2024-05-18 01:15:59] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2024-05-18 01:15:59] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2024-05-18 01:15:59] +++ REDHAT_SUPPORT_PRODUCT=centos
[2024-05-18 01:15:59] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2024-05-18 01:15:59] ++ echo 'CentOS Linux 7 (Core)'
[2024-05-18 01:15:59] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2024-05-18 01:15:59] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2024-05-18 01:15:59] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2024-05-18 01:15:59] + HOME=/tmp/boinchome/slots/5
[2024-05-18 01:15:59] + export HOME
[2024-05-18 01:15:59] + cd /tmp/boinchome/slots/5
[2024-05-18 01:15:59] + '[' '!' -z '' ']'
[2024-05-18 01:15:59] + '[' -z '' ']'
[2024-05-18 01:15:59] ++ /bin/hostname -f
[2024-05-18 01:15:59] + nodename=c-212-7.aglt2.org
[2024-05-18 01:15:59] + echo nodename=c-212-7.aglt2.org
[2024-05-18 01:15:59] + echo Processors=1
[2024-05-18 01:15:59] + echo Benchmark=HEPSPEC:1.0
[2024-05-18 01:15:59] + executable=./runpilot2-wrapper.sh
[2024-05-18 01:15:59] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2024-05-18 01:15:59] ++ tr -d '\0'
[2024-05-18 01:15:59] ++ head -n 1
[2024-05-18 01:15:59] ++ dd if=./runpilot2-wrapper.sh count=1
[2024-05-18 01:15:59] + line1='#!/bin/bash'
[2024-05-18 01:15:59] ++ echo '#!/bin/bash'
[2024-05-18 01:15:59] ++ sed -n 's/^#! *//p'
[2024-05-18 01:15:59] + shebang=/bin/bash
[2024-05-18 01:15:59] ++ echo /bin/bash
[2024-05-18 01:15:59] ++ awk '{print $1}'
[2024-05-18 01:15:59] + interpreter=/bin/bash
[2024-05-18 01:15:59] + '[' /bin/bash = /usr/bin/env ']'
[2024-05-18 01:15:59] + '[' x/bin/bash = x ']'
[2024-05-18 01:15:59] + type /bin/bash
[2024-05-18 01:15:59] + '[' xgnutime = xgnutime ']'
[2024-05-18 01:15:59] + /usr/bin/time -o /tmp/boinchome/slots/5/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.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 SCORE_HIMEM --pilotversion 3.7.5.4 -z -t --piloturl local --mute --container
[2024-05-18 01:15:59] + RESULT=2
[2024-05-18 01:15:59] + sed -i -e /nodename=/d /tmp/boinchome/slots/5/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.diag
[2024-05-18 01:15:59] ++ grep domain_name init_data.xml
[2024-05-18 01:15:59] ++ awk -F '>' '{print $2}'
[2024-05-18 01:15:59] ++ awk -F '<' '{print $1}'
[2024-05-18 01:15:59] ++ sed -e 's# #_#g'
[2024-05-18 01:15:59] + hostname=c-212-7.aglt2.org
[2024-05-18 01:15:59] ++ grep user_name init_data.xml
[2024-05-18 01:15:59] ++ awk -F '>' '{print $2}'
[2024-05-18 01:15:59] ++ awk -F '<' '{print $1}'
[2024-05-18 01:15:59] ++ sed -e 's# #_#g'
[2024-05-18 01:15:59] + username=AGLT2
[2024-05-18 01:15:59] + nodename=AGLT2@c-212-7.aglt2.org
[2024-05-18 01:15:59] + echo nodename=AGLT2@c-212-7.aglt2.org
[2024-05-18 01:15:59] + '[' -n 8 ']'
[2024-05-18 01:15:59] + sed -i -e s/Processors=1/Processors=8/ /tmp/boinchome/slots/5/OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.diag
[2024-05-18 01:15:59] + echo exitcode=2
[2024-05-18 01:15:59] + runtimeenvironments=
[2024-05-18 01:15:59] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2024-05-18 01:15:59] + RTE_function_0 2
[2024-05-18 01:15:59] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2024-05-18 01:15:59] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2024-05-18 01:15:59] + export BOINC_APP=ATLAS
[2024-05-18 01:15:59] + BOINC_APP=ATLAS
[2024-05-18 01:15:59] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2024-05-18 01:15:59] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2024-05-18 01:15:59] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2024-05-18 01:15:59] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2024-05-18 01:15:59] + '[' -z 2 ']'
[2024-05-18 01:15:59] + '[' 2 == 1 ']'
[2024-05-18 01:15:59] + '[' 0 -ne 0 ']'
[2024-05-18 01:15:59] + echo 'zip all output files'
[2024-05-18 01:15:59] + flist='*.diag '
[2024-05-18 01:15:59] + for f in ./heartbeat.json ./output.list ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1 ./gmlog/
[2024-05-18 01:15:59] + '[' -e ./heartbeat.json ']'
[2024-05-18 01:15:59] + flist='*.diag ./heartbeat.json'
[2024-05-18 01:15:59] + for f in ./heartbeat.json ./output.list ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1 ./gmlog/
[2024-05-18 01:15:59] + '[' -e ./output.list ']'
[2024-05-18 01:15:59] + for f in ./heartbeat.json ./output.list ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1 ./gmlog/
[2024-05-18 01:15:59] + '[' -e ./log.38921013._000301.job.log.1 ']'
[2024-05-18 01:15:59] + flist='*.diag ./heartbeat.json ./log.38921013._000301.job.log.1'
[2024-05-18 01:15:59] + for f in ./heartbeat.json ./output.list ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1 ./gmlog/
[2024-05-18 01:15:59] + '[' -e ./log.38921013._000301.job.log.1 ']'
[2024-05-18 01:15:59] + flist='*.diag ./heartbeat.json ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1'
[2024-05-18 01:15:59] + for f in ./heartbeat.json ./output.list ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1 ./gmlog/
[2024-05-18 01:15:59] + '[' -e ./gmlog/ ']'
[2024-05-18 01:15:59] + '[' -f output.list ']'
[2024-05-18 01:15:59] + tar cvf result.tar.gz OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.diag ./heartbeat.json ./log.38921013._000301.job.log.1 ./log.38921013._000301.job.log.1
[2024-05-18 01:15:59] + '[' xgnutime = xcgroup ']'
[2024-05-18 01:15:59] + '[' -n '' ']'
[2024-05-18 01:15:59] + '[' -n '' ']'
[2024-05-18 01:15:59] ++ date +%s
[2024-05-18 01:15:59] + ACCOUNTING_ENDTIME=1716009358
[2024-05-18 01:15:59] ++ date -d '1970-01-01 UTC 1716009171 seconds' +%Y%m%d%H%M%SZ
[2024-05-18 01:15:59] + echo LRMSStartTime=20240518011251Z
[2024-05-18 01:15:59] ++ date -d '1970-01-01 UTC 1716009358 seconds' +%Y%m%d%H%M%SZ
[2024-05-18 01:15:59] + echo LRMSEndTime=20240518011558Z
[2024-05-18 01:15:59] + echo walltime=187
[2024-05-18 01:15:59] + echo exitcode=2
[2024-05-18 01:15:59] + exit 2
[2024-05-18 01:15:59] INFO: Cleanup error: while stopping driver for /var/lib/apptainer/mnt/session/final: fuse-overlayfs exited
[2024-05-18 01:15:59] ./runtime_log
[2024-05-18 01:15:59] ./runtime_log.err
[2024-05-18 01:15:59] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2024-05-18 01:15:59] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2024-05-18 01:15:59] ./pilot3/pilot/util/loggingsupport.py
[2024-05-18 01:15:59] ./pilot3/pilot/util/realtimelogger.py
[2024-05-18 01:15:59] ./PanDA_Pilot-6207095024/prmon.log
[2024-05-18 01:15:59] ./PanDA_Pilot-6207095024/pilotlog.txt
[2024-05-18 01:15:59] ./PanDA_Pilot-6207095024/log.EVNTtoHITS
[2024-05-18 01:15:59] ./PanDA_Pilot-6207095024/PoolFileCatalog.xml
[2024-05-18 01:15:59] ./log.38921013._000301.job.log.1
[2024-05-18 01:15:59] ./pilotlog.txt
01:30:30 (50910): wrapper (7.7.26015): starting
01:30:30 (50910): wrapper: running run_atlas (--nthreads 8)
[2024-05-18 01:30:30] Arguments: --nthreads 8
[2024-05-18 01:30:30] Threads: 8
[2024-05-18 01:30:30] This job has been restarted, cleaning up previous attempt
[2024-05-18 01:30:30] Checking for CVMFS
[2024-05-18 01:30:30] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-18 01:30:30] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-18 01:30:30] Running cvmfs_config stat atlas.cern.ch
[2024-05-18 01:30:30] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2024-05-18 01:30:30] 2.11.2.0 94999 2799 209204 132868 3 178 17444240 18432000 13744 130560 0 12879301 97.402 69789536 66493 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-18 01:30:30] CVMFS is ok
[2024-05-18 01:30:30] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-18 01:30:30] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-18 01:30:30] Further information can be found at the LHC@home message board.
[2024-05-18 01:30:30] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-18 01:30:30] Checking for apptainer binary...
[2024-05-18 01:30:30] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-18 01:30:30] Running /usr/bin/apptainer --version
[2024-05-18 01:30:30] apptainer version 1.3.0-1.el7
[2024-05-18 01:30:30] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-18 01:30:32] c-212-7.aglt2.org
[2024-05-18 01:30:32] apptainer works
[2024-05-18 01:30:32] Set ATHENA_PROC_NUMBER=8
[2024-05-18 01:30:32] Set ATHENA_CORE_NUMBER=8
[2024-05-18 01:30:32] Starting ATLAS job with PandaID=6207095024
[2024-05-18 01:30:32] 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
[2024-05-18 08:38:49] *** The last 200 lines of the pilot log: ***
[2024-05-18 08:38:49] 2024-05-18 12:38:21,697 | INFO | executing command: lscpu
[2024-05-18 08:38:49] 2024-05-18 12:38:21,820 | INFO | found 48 cores (24 cores per socket, 2 sockets)
[2024-05-18 08:38:49] 2024-05-18 12:38:21,821 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2024-05-18 08:38:49] 2024-05-18 12:38:21,894 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup
[2024-05-18 08:38:49] 2024-05-18 12:38:22,465 | INFO | monitor loop #1911: job 0:6207095024 is in state 'finished'
[2024-05-18 08:38:49] 2024-05-18 12:38:22,465 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-18 08:38:49] 2024-05-18 12:38:24,968 | INFO | monitor loop #1912: job 0:6207095024 is in state 'finished'
[2024-05-18 08:38:49] 2024-05-18 12:38:24,968 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-18 08:38:49] 2024-05-18 12:38:27,472 | INFO | monitor loop #1913: job 0:6207095024 is in state 'finished'
[2024-05-18 08:38:49] 2024-05-18 12:38:27,472 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-18 08:38:49] 2024-05-18 12:38:28,887 | INFO | CPU arch script returned: x86-64-v3
[2024-05-18 08:38:49] 2024-05-18 12:38:28,887 | INFO | using path: /tmp/boinchome/slots/5/PanDA_Pilot-6207095024/memory_monitor_summary.json (trf name=prmon)
[2024-05-18 08:38:49] 2024-05-18 12:38:28,888 | INFO | extracted standard info from prmon json
[2024-05-18 08:38:49] 2024-05-18 12:38:28,888 | INFO | extracted standard memory fields from prmon json
[2024-05-18 08:38:49] 2024-05-18 12:38:28,888 | WARNING | GPU info not found in prmon json
[2024-05-18 08:38:49] 2024-05-18 12:38:28,889 | WARNING | format EVNTtoHITS has no such key: dbData
[2024-05-18 08:38:49] 2024-05-18 12:38:28,889 | WARNING | format EVNTtoHITS has no such key: dbTime
[2024-05-18 08:38:49] 2024-05-18 12:38:28,894 | INFO | fitting pss+swap vs Time
[2024-05-18 08:38:49] 2024-05-18 12:38:28,894 | INFO | model: linear, x: [1716010271.0, 1716010332.0, 1716010393.0, 1716010454.0, 1716010515.0, 1716010576.0, 1716010637.0, 1716010698.0, 1716010759.0, 1716010820.0, 1716
[2024-05-18 08:38:49] 2024-05-18 12:38:28,895 | INFO | sum of square deviations: 22973309918.99762
[2024-05-18 08:38:49] 2024-05-18 12:38:28,897 | INFO | sum of deviations: 789562193759.429
[2024-05-18 08:38:49] 2024-05-18 12:38:28,897 | INFO | mean x: 1716023050.5023808
[2024-05-18 08:38:49] 2024-05-18 12:38:28,897 | INFO | mean y: 2387204.5714285714
[2024-05-18 08:38:49] 2024-05-18 12:38:28,897 | INFO | -- intersect: -58975049180.24729
[2024-05-18 08:38:49] 2024-05-18 12:38:28,897 | INFO | intersect: -58975049180.24729
[2024-05-18 08:38:49] 2024-05-18 12:38:28,898 | INFO | chi2: 15.692094604562334
[2024-05-18 08:38:49] 2024-05-18 12:38:28,898 | INFO | model: linear, x: [1716010271.0, 1716010332.0, 1716010393.0, 1716010454.0, 1716010515.0, 1716010576.0, 1716010637.0, 1716010698.0, 1716010759.0, 1716010820.0, 1716
[2024-05-18 08:38:49] 2024-05-18 12:38:28,898 | INFO | sum of square deviations: 22162560138.997646
[2024-05-18 08:38:49] 2024-05-18 12:38:28,900 | INFO | sum of deviations: 778415904183.1201
[2024-05-18 08:38:49] 2024-05-18 12:38:28,900 | INFO | mean x: 1716022898.0024097
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | mean y: 2385107.879518072
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | -- intersect: -60269510709.65385
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | intersect: -60269510709.65385
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | chi2: 15.672562835394531
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | current chi2=15.672562835394531 (change=0.12446884663901656 %)
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | right removable region: 414
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | model: linear, x: [1716010576.0, 1716010637.0, 1716010698.0, 1716010759.0, 1716010820.0, 1716010881.0, 1716010942.0, 1716011003.0, 1716011064.0, 1716011125.0, 1716
[2024-05-18 08:38:49] 2024-05-18 12:38:28,901 | INFO | sum of square deviations: 22162559528.997643
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | sum of deviations: 665883761253.4996
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | mean x: 1716023203.0024097
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | mean y: 2410444.5012048194
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | -- intersect: -51556254668.99539
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | intersect: -51556254668.99539
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | chi2: 12.015273383817023
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | current chi2=12.015273383817023 (change=23.431041638484057 %)
[2024-05-18 08:38:49] 2024-05-18 12:38:28,904 | INFO | left removable region: 10
[2024-05-18 08:38:49] 2024-05-18 12:38:28,905 | INFO | model: linear, x: [1716010881.0, 1716010942.0, 1716011003.0, 1716011064.0, 1716011125.0, 1716011186.0, 1716011247.0, 1716011308.0, 1716011369.0, 1716011430.0, 1716
[2024-05-18 08:38:49] 2024-05-18 12:38:28,905 | INFO | sum of square deviations: 20446527414.997402
[2024-05-18 08:38:49] 2024-05-18 12:38:28,907 | INFO | sum of deviations: 555986832957.9636
[2024-05-18 08:38:49] 2024-05-18 12:38:28,907 | INFO | mean x: 1716023172.5024753
[2024-05-18 08:38:49] 2024-05-18 12:38:28,907 | INFO | mean y: 2427765.537128713
[2024-05-18 08:38:49] 2024-05-18 12:38:28,907 | INFO | -- intersect: -46660082185.287674
[2024-05-18 08:38:49] 2024-05-18 12:38:28,907 | INFO | intersect: -46660082185.287674
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | chi2: 9.83141119287896
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | -- intersect: -46660082185.287674
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | current memory leak: 27.19 B/s (using 404 data points, chi2=9.83)
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | ..............................
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | . Timing measurements:
[2024-05-18 08:38:49] 2024-05-18 12:38:28,908 | INFO | . get job = 0 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . initial setup = 0 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . payload setup = 5 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . stage-in = 0 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . payload execution = 25627 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . stage-out = 1 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | . log creation = 0 s
[2024-05-18 08:38:49] 2024-05-18 12:38:28,909 | INFO | ..............................
[2024-05-18 08:38:49] 2024-05-18 12:38:29,246 | INFO |
[2024-05-18 08:38:49] 2024-05-18 12:38:29,249 | INFO | job summary report
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | --------------------------------------------------
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | PanDA job id: 6207095024
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | task id: 38921013
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | errors: (none)
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | status: LOG_TRANSFER = DONE
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | pilot state: finished
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | transexitcode: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | exeerrorcode: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | exeerrordiag:
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | exitcode: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | exitmsg: OK
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | cpuconsumptiontime: 137610 s
[2024-05-18 08:38:49] 2024-05-18 12:38:29,250 | INFO | nevents: 400
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | neventsw: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | pid: 23054
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | pgrp: 23054
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | corecount: 8
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | event service: False
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | sizes: {0: 2390694, 1: 2392230, 5: 2392436, 11: 2392492, 25637: 2428101, 25638: 2437061, 25642: 2437245, 25652: 2437415}
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | --------------------------------------------------
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO |
[2024-05-18 08:38:49] 2024-05-18 12:38:29,251 | INFO | executing command: ls -lF /tmp/boinchome/slots/5
[2024-05-18 08:38:49] 2024-05-18 12:38:29,274 | INFO | queue jobs had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,274 | INFO | queue payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,274 | INFO | queue data_in had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,274 | INFO | queue data_out had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,274 | INFO | queue current_data_in had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue validated_jobs had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue validated_payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue monitored_payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue finished_jobs had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue finished_payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue finished_data_in had 1 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue finished_data_out had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue failed_jobs had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue failed_payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue failed_data_in had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue failed_data_out had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue completed_jobs had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,275 | INFO | queue completed_jobids has 1 job(s)
[2024-05-18 08:38:49] 2024-05-18 12:38:29,276 | INFO | queue realtimelog_payloads had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,276 | INFO | queue messages had 0 job(s) [purged]
[2024-05-18 08:38:49] 2024-05-18 12:38:29,276 | INFO | job 6207095024 has completed (purged errors)
[2024-05-18 08:38:49] 2024-05-18 12:38:29,276 | INFO | overall cleanup function is called
[2024-05-18 08:38:49] 2024-05-18 12:38:30,284 | INFO | --- collectZombieJob: --- 10, [23054]
[2024-05-18 08:38:49] 2024-05-18 12:38:30,284 | INFO | zombie collector waiting for pid 23054
[2024-05-18 08:38:49] 2024-05-18 12:38:30,284 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes
[2024-05-18 08:38:49] 2024-05-18 12:38:31,290 | INFO | collected zombie processes
[2024-05-18 08:38:49] 2024-05-18 12:38:31,290 | INFO | will now attempt to kill all subprocesses of pid=23054
[2024-05-18 08:38:49] 2024-05-18 12:38:31,649 | INFO | process IDs to be killed: [23054] (in reverse order)
[2024-05-18 08:38:49] 2024-05-18 12:38:31,790 | WARNING | found no corresponding commands to process id(s)
[2024-05-18 08:38:49] 2024-05-18 12:38:31,790 | INFO | Do not look for orphan processes in BOINC jobs
[2024-05-18 08:38:49] 2024-05-18 12:38:31,802 | INFO | did not find any defunct processes belonging to 23054
[2024-05-18 08:38:49] 2024-05-18 12:38:31,814 | INFO | did not find any defunct processes belonging to 23054
[2024-05-18 08:38:49] 2024-05-18 12:38:31,814 | INFO | ready for new job
[2024-05-18 08:38:49] 2024-05-18 12:38:31,815 | INFO | pilot has finished with previous job - re-establishing logging
[2024-05-18 08:38:49] 2024-05-18 12:38:31,817 | INFO | *************************************
[2024-05-18 08:38:49] 2024-05-18 12:38:31,817 | INFO | *** PanDA Pilot version 3.7.5.4 ***
[2024-05-18 08:38:49] 2024-05-18 12:38:31,818 | INFO | *************************************
[2024-05-18 08:38:49] 2024-05-18 12:38:31,818 | INFO |
[2024-05-18 08:38:49] 2024-05-18 12:38:31,822 | INFO | architecture information:
[2024-05-18 08:38:49] 2024-05-18 12:38:31,822 | INFO | executing command: cat /etc/os-release
[2024-05-18 08:38:49] 2024-05-18 12:38:31,949 | INFO | cat /etc/os-release:
[2024-05-18 08:38:49] NAME="CentOS Linux"
[2024-05-18 08:38:49] VERSION="7 (Core)"
[2024-05-18 08:38:49] ID="centos"
[2024-05-18 08:38:49] ID_LIKE="rhel fedora"
[2024-05-18 08:38:49] VERSION_ID="7"
[2024-05-18 08:38:49] PRETTY_NAME="CentOS Linux 7 (Core)"
[2024-05-18 08:38:49] ANSI_COLOR="0;31"
[2024-05-18 08:38:49] CPE_NAME="cpe:/o:centos:centos:7"
[2024-05-18 08:38:49] HOME_URL="https://www.centos.org/"
[2024-05-18 08:38:49] BUG_REPORT_URL="https://bugs.centos.org/"
[2024-05-18 08:38:49]
[2024-05-18 08:38:49] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2024-05-18 08:38:49] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2024-05-18 08:38:49] REDHAT_SUPPORT_PRODUCT="centos"
[2024-05-18 08:38:49] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2024-05-18 08:38:49]
[2024-05-18 08:38:49] 2024-05-18 12:38:31,950 | INFO | *************************************
[2024-05-18 08:38:49] 2024-05-18 12:38:32,452 | INFO | executing command: df -mP /tmp/boinchome/slots/5
[2024-05-18 08:38:49] 2024-05-18 12:38:32,469 | INFO | sufficient remaining disk space (97990475776 B)
[2024-05-18 08:38:49] 2024-05-18 12:38:32,469 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job
[2024-05-18 08:38:49] 2024-05-18 12:38:32,470 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2024-05-18 08:38:49] 2024-05-18 12:38:32,470 | WARNING | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2024-05-18 08:38:49] 2024-05-18 12:38:32,470 | INFO | found 0 job(s) in 20 queues
[2024-05-18 08:38:49] 2024-05-18 12:38:32,470 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2024-05-18 08:38:49] 2024-05-18 12:38:32,470 | WARNING | will wait for a maximum of 300 s for threads to finish
[2024-05-18 08:38:49] 2024-05-18 12:38:32,487 | WARNING | job monitor detected an abort_job request (signal=args.signal)
[2024-05-18 08:38:49] 2024-05-18 12:38:32,487 | WARNING | cannot recover job monitoring - aborting pilot
[2024-05-18 08:38:49] 2024-05-18 12:38:32,487 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2024-05-18 08:38:49] 2024-05-18 12:38:32,488 | INFO | will abort loop
[2024-05-18 08:38:49] 2024-05-18 12:38:33,360 | INFO | all data control threads have been joined
[2024-05-18 08:38:49] 2024-05-18 12:38:33,462 | INFO | all job control threads have been joined
[2024-05-18 08:38:49] 2024-05-18 12:38:33,475 | INFO | [job] retrieve thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:33,493 | INFO | [job] job monitor thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:33,499 | INFO | [payload] failed_post thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:33,631 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2024-05-18 08:38:49] 2024-05-18 12:38:33,717 | INFO | [job] create_data_payload thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:33,778 | INFO | all payload control threads have been joined
[2024-05-18 08:38:49] 2024-05-18 12:38:33,903 | INFO | [data] copytool_in thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:33,981 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2024-05-18 08:38:49] 2024-05-18 12:38:34,133 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2024-05-18 08:38:49] 2024-05-18 12:38:34,202 | INFO | [payload] validate_post thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,364 | INFO | [data] control thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,373 | INFO | [job] validate thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,464 | INFO | [payload] execute_payloads thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,469 | INFO | [job] control thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,784 | INFO | [payload] control thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,838 | INFO | [payload] validate_pre thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:34,989 | INFO | [job] queue monitor thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:35,637 | INFO | [data] copytool_out thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:38,140 | INFO | [data] queue_monitor thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:42,826 | INFO | job.realtimelogging is not enabled
[2024-05-18 08:38:49] 2024-05-18 12:38:43,831 | INFO | [payload] run_realtimelog thread has finished
[2024-05-18 08:38:49] 2024-05-18 12:38:43,916 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140680856307520)>', '<ExcThread(monitor, started 140680303208192)>']
[2024-05-18 08:38:49] 2024-05-18 12:38:44,535 | WARNING | job_aborted has been set - aborting pilot monitoring
[2024-05-18 08:38:49] 2024-05-18 12:38:44,535 | INFO | [monitor] control thread has ended
[2024-05-18 08:38:49] 2024-05-18 12:38:48,942 | INFO | all workflow threads have been joined
[2024-05-18 08:38:49] 2024-05-18 12:38:48,942 | INFO | end of generic workflow (traces error code: 0)
[2024-05-18 08:38:49] 2024-05-18 12:38:48,943 | INFO | traces error code: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:48,943 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2024-05-18 08:38:49] 2024-05-18 12:38:49,027 [wrapper] ==== pilot stdout END ====
[2024-05-18 08:38:49] 2024-05-18 12:38:49,031 [wrapper] ==== wrapper stdout RESUME ====
[2024-05-18 08:38:49] 2024-05-18 12:38:49,038 [wrapper] pilotpid: 77113
[2024-05-18 08:38:49] 2024-05-18 12:38:49,041 [wrapper] Pilot exit status: 0
[2024-05-18 08:38:49] 2024-05-18 12:38:49,070 [wrapper] pandaids: 6207095024 6207095024 6207095024
[2024-05-18 08:38:49] 2024-05-18 12:38:49,147 [wrapper] cleanup: SIGTERM to supervisor_pilot 70467 77114
[2024-05-18 08:38:49] 2024-05-18 12:38:49,151 [wrapper] Test setup, not cleaning
[2024-05-18 08:38:49] 2024-05-18 12:38:49,169 [wrapper] ==== wrapper stdout END ====
[2024-05-18 08:38:49] 2024-05-18 12:38:49,171 [wrapper] ==== wrapper stderr END ====
[2024-05-18 08:38:49] 2024-05-18 12:38:49,175 [wrapper] apfmon messages muted
[2024-05-18 08:38:49] *** Error codes and diagnostics ***
[2024-05-18 08:38:49] "exeErrorCode": 0,
[2024-05-18 08:38:49] "exeErrorDiag": "",
[2024-05-18 08:38:49] "pilotErrorCode": 0,
[2024-05-18 08:38:49] "pilotErrorDiag": "",
[2024-05-18 08:38:49] *** Listing of results directory ***
[2024-05-18 08:38:49] total 1404672
[2024-05-18 08:38:49] drwx------ 4 boincer umatlas 4096 May 8 08:24 pilot3
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 467845 May 15 21:27 pilot3.tar.gz
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 5633 May 15 21:30 queuedata.json
[2024-05-18 08:38:49] -rwx------ 1 boincer umatlas 32251 May 15 21:31 runpilot2-wrapper.sh
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 100 May 16 02:35 wrapper_26015_x86_64-pc-linux-gnu
[2024-05-18 08:38:49] -rwxr-xr-x 1 boincer umatlas 7986 May 16 02:35 run_atlas
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 105 May 16 02:35 job.xml
[2024-05-18 08:38:49] -rw-r--r-- 3 boincer umatlas 540981011 May 16 02:36 EVNT.38776210._000015.pool.root.1
[2024-05-18 08:38:49] -rw-r--r-- 3 boincer umatlas 540981011 May 16 02:36 ATLAS.root_0
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 17537 May 16 02:36 start_atlas.sh
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 479991 May 16 02:36 input.tar.gz
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 0 May 16 02:36 boinc_lockfile
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 1324701 May 16 02:36 cric_ddmendpoints.json
[2024-05-18 08:38:49] drwxrwx--x 2 boincer umatlas 4096 May 18 01:15 shared
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 2639 May 18 01:30 pandaJob.out
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 467 May 18 01:30 setup.sh.local
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 1019057 May 18 01:30 agis_schedconf.cvmfs.json
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 6388 May 18 08:30 init_data.xml
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 346646470 May 18 08:37 HITS.38921013._000301.pool.root.1
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 532 May 18 08:37 boinc_task_state.xml
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 1094 May 18 08:38 memory_monitor_summary.json
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 99 May 18 08:38 pilot_heartbeat.json
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 0 May 18 08:38 agis_ddmendpoints.agis.ALL.json
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 517518 May 18 08:38 log.38921013._000301.job.log.tgz.1
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 7739 May 18 08:38 heartbeat.json
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 8192 May 18 08:38 boinc_mmap_file
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 29 May 18 08:38 wrapper_checkpoint.txt
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 4592 May 18 08:38 pilotlog.txt
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 2588811 May 18 08:38 log.38921013._000301.job.log.1
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 357 May 18 08:38 output.list
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 620 May 18 08:38 runtime_log
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 3123200 May 18 08:38 result.tar.gz
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 11485 May 18 08:38 runtime_log.err
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 1358 May 18 08:38 OTXNDm48eR5n9Rq4apoT9bVoABFKDmABFKDmlqFKDmO1JKDmVq1FNm.diag
[2024-05-18 08:38:49] -rw-r--r-- 1 boincer umatlas 42283 May 18 08:38 stderr.txt
[2024-05-18 08:38:49] HITS file was successfully produced:
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 346646470 May 18 08:37 shared/HITS.pool.root.1
[2024-05-18 08:38:49] *** Contents of shared directory: ***
[2024-05-18 08:38:49] total 870380
[2024-05-18 08:38:49] -rw-r--r-- 3 boincer umatlas 540981011 May 16 02:36 ATLAS.root_0
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 17537 May 16 02:36 start_atlas.sh
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 479991 May 16 02:36 input.tar.gz
[2024-05-18 08:38:49] -rw------- 1 boincer umatlas 346646470 May 18 08:37 HITS.pool.root.1
[2024-05-18 08:38:49] -rw-r--r-- 2 boincer umatlas 3123200 May 18 08:38 result.tar.gz
08:38:50 (50910): run_atlas exited; CPU time 135776.219562
08:38:50 (50910): called boinc_finish(0)
</stderr_txt>
]]>
©2024 CERN