| Name | 5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm_0 |
| Workunit | 238673861 |
| Created | 24 Jan 2026, 9:28:00 UTC |
| Sent | 24 Jan 2026, 14:53:45 UTC |
| Report deadline | 1 Feb 2026, 14:53:45 UTC |
| Received | 26 Jan 2026, 1:17:08 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10815119 |
| Run time | 1 hours 28 min 33 sec |
| CPU time | 4 hours 58 min 54 sec |
| Priority | 28 |
| Validate state | Valid |
| Credit | 570.66 |
| Device peak FLOPS | 35.15 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 1.89 GB |
| Peak swap size | 2.83 GB |
| Peak disk usage | 1.54 GB |
Stderr output
<core_client_version>8.2.8</core_client_version>
<![CDATA[
<stderr_txt>
16:01:57 (1423797): wrapper (7.7.26015): starting
16:01:57 (1423797): wrapper: running run_atlas (--nthreads 4)
[2026-01-24 16:01:57] Arguments: --nthreads 4
[2026-01-24 16:01:57] Threads: 4
[2026-01-24 16:01:57] Checking for CVMFS
[2026-01-24 16:01:57] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-24 16:01:58] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-24 16:01:58] Running cvmfs_config stat atlas.cern.ch
[2026-01-24 16:01:58] 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
[2026-01-24 16:01:58] 2.13.1.0 804311 1230 66068 155475 3 188 8637482 10240001 911 130560 0 1628914 99.995 42808 202 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2026-01-24 16:01:58] CVMFS is ok
[2026-01-24 16:01:58] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-24 16:01:58] Checking for apptainer binary...
[2026-01-24 16:01:58] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-24 16:01:58] Running /usr/bin/apptainer --version
[2026-01-24 16:01:58] apptainer version 1.4.5
[2026-01-24 16:01:58] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-24 16:01:58] woolyvlneu
[2026-01-24 16:01:58] apptainer works
[2026-01-24 16:01:58] Set ATHENA_PROC_NUMBER=4
[2026-01-24 16:01:58] Set ATHENA_CORE_NUMBER=4
[2026-01-24 16:01:58] Starting ATLAS job with PandaID=6981030180
[2026-01-24 16:01:58] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
19:58:14 (4474): wrapper (7.7.26015): starting
19:58:14 (4474): wrapper: running run_atlas (--nthreads 4)
[2026-01-25 19:58:14] Arguments: --nthreads 4
[2026-01-25 19:58:14] Threads: 4
[2026-01-25 19:58:14] This job has been restarted, cleaning up previous attempt
[2026-01-25 19:58:14] Checking for CVMFS
[2026-01-25 19:58:16] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-25 19:58:17] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-25 19:58:17] Running cvmfs_config stat atlas.cern.ch
[2026-01-25 19:58:17] 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
[2026-01-25 19:58:17] 2.13.1.0 4802 0 25060 155517 3 1 8647686 10240001 0 130560 0 0 0.000 1336 3258 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2026-01-25 19:58:17] CVMFS is ok
[2026-01-25 19:58:17] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-25 19:58:17] Checking for apptainer binary...
[2026-01-25 19:58:17] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-25 19:58:17] Running /usr/bin/apptainer --version
[2026-01-25 19:58:17] apptainer version 1.4.5
[2026-01-25 19:58:17] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-25 19:58:19] woolyvlneu
[2026-01-25 19:58:19] apptainer works
[2026-01-25 19:58:19] Set ATHENA_PROC_NUMBER=4
[2026-01-25 19:58:19] Set ATHENA_CORE_NUMBER=4
[2026-01-25 19:58:19] Starting ATLAS job with PandaID=6981030180
[2026-01-25 19:58:19] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-01-25 20:01:29] Job failed
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + export RUNTIME_CONFIG_DIR=/var/lib/boinc_data/boinc-01/slots/1/
[2026-01-25 20:01:29] + RUNTIME_CONFIG_DIR=/var/lib/boinc_data/boinc-01/slots/1/
[2026-01-25 20:01:29] + mv ATLAS.root_0 EVNT.48310721._000048.pool.root.1
[2026-01-25 20:01:29] mv: 'ATLAS.root_0' and 'EVNT.48310721._000048.pool.root.1' are the same file
[2026-01-25 20:01:29] + tar --strip-components=5 -xvf input.tar.gz
[2026-01-25 20:01:29] + umask 077
[2026-01-25 20:01:29] ++ date +%s
[2026-01-25 20:01:29] + ACCOUNTING_STARTTIME=1769367500
[2026-01-25 20:01:29] + echo 'Detecting resource accounting method available for the job.'
[2026-01-25 20:01:29] Detecting resource accounting method available for the job.
[2026-01-25 20:01:29] + JOB_ACCOUNTING=
[2026-01-25 20:01:29] + command -v arc-job-cgroup
[2026-01-25 20:01:29] + '[' -z '' ']'
[2026-01-25 20:01:29] + GNU_TIME=/usr/bin/time
[2026-01-25 20:01:29] + echo 'Looking for /usr/bin/time tool for accounting measurements'
[2026-01-25 20:01:29] Looking for /usr/bin/time tool for accounting measurements
[2026-01-25 20:01:29] + '[' '!' -z /usr/bin/time ']'
[2026-01-25 20:01:29] + /usr/bin/time --version
[2026-01-25 20:01:29] + echo 'GNU time found and will be used for job accounting.'
[2026-01-25 20:01:29] GNU time found and will be used for job accounting.
[2026-01-25 20:01:29] + JOB_ACCOUNTING=gnutime
[2026-01-25 20:01:29] + '[' -z gnutime ']'
[2026-01-25 20:01:29] + export PANDA_JSID=harvester-CERN_central_ACTA
[2026-01-25 20:01:29] + PANDA_JSID=harvester-CERN_central_ACTA
[2026-01-25 20:01:29] + export GTAG=http://aipanda403.cern.ch/data/jobs/2026-01-24/BOINC_MCORE/6981030180.out
[2026-01-25 20:01:29] + GTAG=http://aipanda403.cern.ch/data/jobs/2026-01-24/BOINC_MCORE/6981030180.out
[2026-01-25 20:01:29] + export PILOT_NOKILL=YES
[2026-01-25 20:01:29] + PILOT_NOKILL=YES
[2026-01-25 20:01:29] + export GRID_GLOBAL_JOBID=5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm
[2026-01-25 20:01:29] + GRID_GLOBAL_JOBID=5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm
[2026-01-25 20:01:29] + export GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm
[2026-01-25 20:01:29] + GRID_GLOBAL_JOBURL=https://arc-boinc-03.cern.ch:443/arex/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm
[2026-01-25 20:01:29] + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2026-01-25 20:01:29] + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
[2026-01-25 20:01:29] + export GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2026-01-25 20:01:29] + GRID_GLOBAL_JOBHOST=arc-boinc-03.cern.ch
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + RUNTIME_JOB_DIR=/var/lib/boinc_data/boinc-01/slots/1
[2026-01-25 20:01:29] + RUNTIME_JOB_STDIN=/dev/null
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + RUNTIME_JOB_STDOUT=/var/lib/boinc_data/boinc-01/slots/1/log.48310724._002367.job.log.1
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + RUNTIME_JOB_STDERR=/var/lib/boinc_data/boinc-01/slots/1/log.48310724._002367.job.log.1
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + RUNTIME_JOB_DIAG=/var/lib/boinc_data/boinc-01/slots/1.diag
[2026-01-25 20:01:29] + '[' '!' -z '' ']'
[2026-01-25 20:01:29] + RUNTIME_LOCAL_SCRATCH_DIR=
[2026-01-25 20:01:29] + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
[2026-01-25 20:01:29] + RUNTIME_FRONTEND_SEES_NODE=
[2026-01-25 20:01:29] + RUNTIME_NODE_SEES_FRONTEND=yes
[2026-01-25 20:01:29] + '[' '!' -z '' ']'
[2026-01-25 20:01:29] + '[' -z yes ']'
[2026-01-25 20:01:29] ++ pwd
[2026-01-25 20:01:29] + RUNTIME_JOB_DIAG=/var/lib/boinc_data/boinc-01/slots/1/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.diag
[2026-01-25 20:01:29] + runtimeenvironments=
[2026-01-25 20:01:29] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2026-01-25 20:01:29] + RTE_function_0 1
[2026-01-25 20:01:29] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-01-25 20:01:29] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-01-25 20:01:29] + export BOINC_APP=ATLAS
[2026-01-25 20:01:29] + BOINC_APP=ATLAS
[2026-01-25 20:01:29] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-01-25 20:01:29] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-01-25 20:01:29] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-01-25 20:01:29] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-01-25 20:01:29] + '[' -z 1 ']'
[2026-01-25 20:01:29] + '[' 1 == 1 ']'
[2026-01-25 20:01:29] + shift
[2026-01-25 20:01:29] + export SITE_NAME=BOINC
[2026-01-25 20:01:29] + SITE_NAME=BOINC
[2026-01-25 20:01:29] + export ATLAS_LOCAL_AREA=/var/lib/boinc_data/boinc-01/slots/1/
[2026-01-25 20:01:29] + ATLAS_LOCAL_AREA=/var/lib/boinc_data/boinc-01/slots/1/
[2026-01-25 20:01:29] + '[' -e /var/lib/boinc_data/boinc-01/slots/1/init_data.xml ']'
[2026-01-25 20:01:29] + grep '<use_http_proxy/>' /var/lib/boinc_data/boinc-01/slots/1/init_data.xml
[2026-01-25 20:01:29] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_name>\([^<]*\).*/\1/p' -n /var/lib/boinc_data/boinc-01/slots/1/init_data.xml
[2026-01-25 20:01:29] + PROXY_HOST=192.168.101.101
[2026-01-25 20:01:29] ++ sed -e '/<proxy_info>/,/<\/proxy_info>/ s/^.*<http_server_port>\([^<]*\).*/\1/p' -n /var/lib/boinc_data/boinc-01/slots/1/init_data.xml
[2026-01-25 20:01:29] + PROXY_PORT=3128
[2026-01-25 20:01:29] + '[' -n 192.168.101.101 ']'
[2026-01-25 20:01:29] + '[' -n 3128 ']'
[2026-01-25 20:01:29] + export FRONTIER_PROXY=http://192.168.101.101:3128
[2026-01-25 20:01:29] + FRONTIER_PROXY=http://192.168.101.101:3128
[2026-01-25 20:01:29] + echo 'export FRONTIER_PROXY="http://192.168.101.101:3128"'
[2026-01-25 20:01:29] + '[' 0 -ne 0 ']'
[2026-01-25 20:01:29] + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
[2026-01-25 20:01:29] + '[' -f /etc/os-release ']'
[2026-01-25 20:01:29] +++ cat /etc/os-release
[2026-01-25 20:01:29] ++ 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"'
[2026-01-25 20:01:29] +++ NAME='CentOS Linux'
[2026-01-25 20:01:29] +++ VERSION='7 (Core)'
[2026-01-25 20:01:29] +++ ID=centos
[2026-01-25 20:01:29] +++ ID_LIKE='rhel fedora'
[2026-01-25 20:01:29] +++ VERSION_ID=7
[2026-01-25 20:01:29] +++ PRETTY_NAME='CentOS Linux 7 (Core)'
[2026-01-25 20:01:29] +++ ANSI_COLOR='0;31'
[2026-01-25 20:01:29] +++ CPE_NAME=cpe:/o:centos:centos:7
[2026-01-25 20:01:29] +++ HOME_URL=https://www.centos.org/
[2026-01-25 20:01:29] +++ BUG_REPORT_URL=https://bugs.centos.org/
[2026-01-25 20:01:29] +++ CENTOS_MANTISBT_PROJECT=CentOS-7
[2026-01-25 20:01:29] +++ CENTOS_MANTISBT_PROJECT_VERSION=7
[2026-01-25 20:01:29] +++ REDHAT_SUPPORT_PRODUCT=centos
[2026-01-25 20:01:29] +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
[2026-01-25 20:01:29] ++ echo 'CentOS Linux 7 (Core)'
[2026-01-25 20:01:29] + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
[2026-01-25 20:01:29] + '[' -n 'CentOS Linux 7 (Core)' ']'
[2026-01-25 20:01:29] + echo 'systemsoftware=CentOS Linux 7 (Core)'
[2026-01-25 20:01:29] + HOME=/var/lib/boinc_data/boinc-01/slots/1
[2026-01-25 20:01:29] + export HOME
[2026-01-25 20:01:29] + cd /var/lib/boinc_data/boinc-01/slots/1
[2026-01-25 20:01:29] + '[' '!' -z '' ']'
[2026-01-25 20:01:29] + '[' -z '' ']'
[2026-01-25 20:01:29] ++ /bin/hostname -f
[2026-01-25 20:01:29] + nodename=woolyvlneu.kor.b-s-m.de
[2026-01-25 20:01:29] + echo nodename=woolyvlneu.kor.b-s-m.de
[2026-01-25 20:01:29] + echo Processors=2
[2026-01-25 20:01:29] + echo Nodecount=1
[2026-01-25 20:01:29] + echo Benchmark=HEPSPEC:1.0
[2026-01-25 20:01:29] + executable=./runpilot2-wrapper.sh
[2026-01-25 20:01:29] + '[' '!' -f ./runpilot2-wrapper.sh ']'
[2026-01-25 20:01:29] ++ dd if=./runpilot2-wrapper.sh count=1
[2026-01-25 20:01:29] ++ head -n 1
[2026-01-25 20:01:29] ++ tr -d '\0'
[2026-01-25 20:01:29] + line1='#!/bin/bash'
[2026-01-25 20:01:29] ++ echo '#!/bin/bash'
[2026-01-25 20:01:29] ++ sed -n 's/^#! *//p'
[2026-01-25 20:01:29] + shebang=/bin/bash
[2026-01-25 20:01:29] ++ echo /bin/bash
[2026-01-25 20:01:29] ++ awk '{print $1}'
[2026-01-25 20:01:29] + interpreter=/bin/bash
[2026-01-25 20:01:29] + '[' /bin/bash = /usr/bin/env ']'
[2026-01-25 20:01:29] + '[' x/bin/bash = x ']'
[2026-01-25 20:01:29] + type /bin/bash
[2026-01-25 20:01:29] + '[' xgnutime = xgnutime ']'
[2026-01-25 20:01:29] + /usr/bin/time -o /var/lib/boinc_data/boinc-01/slots/1/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.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.11.3.9 -z -t --piloturl local --mute --container
[2026-01-25 20:01:29] + RESULT=2
[2026-01-25 20:01:29] + sed -i -e /nodename=/d /var/lib/boinc_data/boinc-01/slots/1/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.diag
[2026-01-25 20:01:29] ++ grep domain_name init_data.xml
[2026-01-25 20:01:29] ++ awk -F '>' '{print $2}'
[2026-01-25 20:01:29] ++ awk -F '<' '{print $1}'
[2026-01-25 20:01:29] ++ sed -e 's# #_#g'
[2026-01-25 20:01:29] + hostname=WoolyVLneu
[2026-01-25 20:01:29] ++ grep user_name init_data.xml
[2026-01-25 20:01:29] ++ awk -F '>' '{print $2}'
[2026-01-25 20:01:29] ++ awk -F '<' '{print $1}'
[2026-01-25 20:01:29] ++ sed -e 's# #_#g'
[2026-01-25 20:01:29] + username=Yeti
[2026-01-25 20:01:29] + nodename=Yeti@WoolyVLneu
[2026-01-25 20:01:29] + echo nodename=Yeti@WoolyVLneu
[2026-01-25 20:01:29] + '[' -n 4 ']'
[2026-01-25 20:01:29] + sed -i -e s/Processors=1/Processors=4/ /var/lib/boinc_data/boinc-01/slots/1/5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.diag
[2026-01-25 20:01:29] + echo exitcode=2
[2026-01-25 20:01:29] + runtimeenvironments=
[2026-01-25 20:01:29] + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
[2026-01-25 20:01:29] + RTE_function_0 2
[2026-01-25 20:01:29] + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-01-25 20:01:29] + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
[2026-01-25 20:01:29] + export BOINC_APP=ATLAS
[2026-01-25 20:01:29] + BOINC_APP=ATLAS
[2026-01-25 20:01:29] + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-01-25 20:01:29] + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
[2026-01-25 20:01:29] + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-01-25 20:01:29] + RESULT_TEMPLATE=templates/ATLAS_OUT_2
[2026-01-25 20:01:29] + '[' -z 2 ']'
[2026-01-25 20:01:29] + '[' 2 == 1 ']'
[2026-01-25 20:01:29] + '[' 0 -ne 0 ']'
[2026-01-25 20:01:29] + echo 'zip all output files'
[2026-01-25 20:01:29] + flist='*.diag '
[2026-01-25 20:01:29] + for f in ./heartbeat.json ./output.list ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1 ./gmlog/
[2026-01-25 20:01:29] + '[' -e ./heartbeat.json ']'
[2026-01-25 20:01:29] + flist='*.diag ./heartbeat.json'
[2026-01-25 20:01:29] + for f in ./heartbeat.json ./output.list ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1 ./gmlog/
[2026-01-25 20:01:29] + '[' -e ./output.list ']'
[2026-01-25 20:01:29] + for f in ./heartbeat.json ./output.list ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1 ./gmlog/
[2026-01-25 20:01:29] + '[' -e ./log.48310724._002367.job.log.1 ']'
[2026-01-25 20:01:29] + flist='*.diag ./heartbeat.json ./log.48310724._002367.job.log.1'
[2026-01-25 20:01:29] + for f in ./heartbeat.json ./output.list ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1 ./gmlog/
[2026-01-25 20:01:29] + '[' -e ./log.48310724._002367.job.log.1 ']'
[2026-01-25 20:01:29] + flist='*.diag ./heartbeat.json ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1'
[2026-01-25 20:01:29] + for f in ./heartbeat.json ./output.list ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1 ./gmlog/
[2026-01-25 20:01:29] + '[' -e ./gmlog/ ']'
[2026-01-25 20:01:29] + '[' -f output.list ']'
[2026-01-25 20:01:29] + tar cvf result.tar.gz 5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.diag ./heartbeat.json ./log.48310724._002367.job.log.1 ./log.48310724._002367.job.log.1
[2026-01-25 20:01:29] + '[' xgnutime = xcgroup ']'
[2026-01-25 20:01:29] + '[' -n '' ']'
[2026-01-25 20:01:29] + '[' -n '' ']'
[2026-01-25 20:01:29] ++ date +%s
[2026-01-25 20:01:29] + ACCOUNTING_ENDTIME=1769367689
[2026-01-25 20:01:29] ++ date -d '1970-01-01 UTC 1769367500 seconds' +%Y%m%d%H%M%SZ
[2026-01-25 20:01:29] + echo LRMSStartTime=20260125195820Z
[2026-01-25 20:01:29] ++ date -d '1970-01-01 UTC 1769367689 seconds' +%Y%m%d%H%M%SZ
[2026-01-25 20:01:29] + echo LRMSEndTime=20260125200129Z
[2026-01-25 20:01:29] + echo walltime=189
[2026-01-25 20:01:29] + echo exitcode=2
[2026-01-25 20:01:29] + exit 2
[2026-01-25 20:01:29] ./runtime_log
[2026-01-25 20:01:29] ./PanDA_Pilot-6981030180/log.EVNTtoHITS
[2026-01-25 20:01:29] ./PanDA_Pilot-6981030180/PoolFileCatalog.xml
[2026-01-25 20:01:29] ./PanDA_Pilot-6981030180/prmon.log
[2026-01-25 20:01:29] ./PanDA_Pilot-6981030180/pilotlog.txt
[2026-01-25 20:01:29] ./runtime_log.err
[2026-01-25 20:01:29] ./pilot3/pilot/util/lokirealtimelogger.py
[2026-01-25 20:01:29] ./pilot3/pilot/util/realtimelogger.py
[2026-01-25 20:01:29] ./pilot3/pilot/util/loggingsupport.py
[2026-01-25 20:01:29] ./pilot3/pilot/util/__pycache__/lokirealtimelogger.cpython-39.pyc
[2026-01-25 20:01:29] ./pilot3/pilot/util/__pycache__/loggingsupport.cpython-39.pyc
[2026-01-25 20:01:29] ./pilot3/pilot/util/__pycache__/realtimelogger.cpython-39.pyc
[2026-01-25 20:01:29] ./log.48310724._002367.job.log.1
[2026-01-25 20:01:29] ./pilotlog.txt
23:44:21 (3889): wrapper (7.7.26015): starting
23:44:21 (3889): wrapper: running run_atlas (--nthreads 4)
[2026-01-25 23:44:21] Arguments: --nthreads 4
[2026-01-25 23:44:21] Threads: 4
[2026-01-25 23:44:21] This job has been restarted, cleaning up previous attempt
[2026-01-25 23:44:21] Checking for CVMFS
[2026-01-25 23:44:23] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-25 23:44:23] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-25 23:44:23] Running cvmfs_config stat atlas.cern.ch
[2026-01-25 23:44:23] 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
[2026-01-25 23:44:23] 2.13.1.0 4269 0 25260 155523 4 1 8660644 10240000 0 130560 0 0 0.000 1336 5060 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2026-01-25 23:44:23] CVMFS is ok
[2026-01-25 23:44:23] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-25 23:44:23] Checking for apptainer binary...
[2026-01-25 23:44:23] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-25 23:44:23] Running /usr/bin/apptainer --version
[2026-01-25 23:44:24] apptainer version 1.4.5
[2026-01-25 23:44:24] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-25 23:44:24] woolyvlneu
[2026-01-25 23:44:24] apptainer works
[2026-01-25 23:44:24] Set ATHENA_PROC_NUMBER=4
[2026-01-25 23:44:24] Set ATHENA_CORE_NUMBER=4
[2026-01-25 23:44:24] Starting ATLAS job with PandaID=6981030180
[2026-01-25 23:44:24] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
23:48:13 (3866): wrapper (7.7.26015): starting
23:48:13 (3866): wrapper: running run_atlas (--nthreads 4)
[2026-01-25 23:48:13] Arguments: --nthreads 4
[2026-01-25 23:48:13] Threads: 4
[2026-01-25 23:48:13] This job has been restarted, cleaning up previous attempt
[2026-01-25 23:48:13] Checking for CVMFS
[2026-01-25 23:48:14] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-25 23:48:14] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-25 23:48:14] Running cvmfs_config stat atlas.cern.ch
[2026-01-25 23:48:15] 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
[2026-01-25 23:48:15] 2.13.1.0 4246 0 25236 155523 4 1 8668964 10240001 0 130560 0 0 100.000 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2026-01-25 23:48:15] CVMFS is ok
[2026-01-25 23:48:15] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-25 23:48:15] Checking for apptainer binary...
[2026-01-25 23:48:15] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-25 23:48:15] Running /usr/bin/apptainer --version
[2026-01-25 23:48:15] apptainer version 1.4.5
[2026-01-25 23:48:15] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-25 23:48:15] woolyvlneu
[2026-01-25 23:48:15] apptainer works
[2026-01-25 23:48:15] Set ATHENA_PROC_NUMBER=4
[2026-01-25 23:48:15] Set ATHENA_CORE_NUMBER=4
[2026-01-25 23:48:15] Starting ATLAS job with PandaID=6981030180
[2026-01-25 23:48:15] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
23:57:55 (3970): wrapper (7.7.26015): starting
23:57:55 (3970): wrapper: running run_atlas (--nthreads 4)
[2026-01-25 23:57:55] Arguments: --nthreads 4
[2026-01-25 23:57:55] Threads: 4
[2026-01-25 23:57:55] This job has been restarted, cleaning up previous attempt
[2026-01-25 23:57:55] Checking for CVMFS
[2026-01-25 23:57:57] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-25 23:57:57] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-25 23:57:57] Running cvmfs_config stat atlas.cern.ch
[2026-01-25 23:57:57] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2026-01-25 23:57:57] 2.13.1.0 4377 0 24884 155523 4 1 8668964 10240001 0 130560 0 0 100.000 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2026-01-25 23:57:57] CVMFS is ok
[2026-01-25 23:57:57] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-25 23:57:57] Checking for apptainer binary...
[2026-01-25 23:57:57] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-25 23:57:57] Running /usr/bin/apptainer --version
[2026-01-25 23:57:58] apptainer version 1.4.5
[2026-01-25 23:57:58] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-25 23:57:58] woolyvlneu
[2026-01-25 23:57:58] apptainer works
[2026-01-25 23:57:58] Set ATHENA_PROC_NUMBER=4
[2026-01-25 23:57:58] Set ATHENA_CORE_NUMBER=4
[2026-01-25 23:57:58] Starting ATLAS job with PandaID=6981030180
[2026-01-25 23:57:58] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-01-26 01:14:35] *** The last 200 lines of the pilot log: ***
[2026-01-26 01:14:35] guid=cd246faf-fd29-4f71-87e8-5a7fce085efe
[2026-01-26 01:14:35] inputddms=['NDGF-T1_DATADISK', 'CERN-PROD_DATADISK']
[2026-01-26 01:14:35] is_altstaged=None
[2026-01-26 01:14:35] is_tar=False
[2026-01-26 01:14:35] lfn=log.48310724._002367.job.log.tgz.1
[2026-01-26 01:14:35] mtime=0
[2026-01-26 01:14:35] protocol_id=None
[2026-01-26 01:14:35] protocols=[{'endpoint': 'davs://dav.ndgf.org:443', 'flavour': 'WEBDAV', 'id': 331, 'path': '/atlas/disk/atlasdatadisk/rucio/'}]
[2026-01-26 01:14:35] replicas=None
[2026-01-26 01:14:35] scope=mc23_13p6TeV
[2026-01-26 01:14:35] status=None
[2026-01-26 01:14:35] status_code=0
[2026-01-26 01:14:35] storage_token=
[2026-01-26 01:14:35] surl=/var/lib/boinc_data/boinc-01/slots/1/PanDA_Pilot-6981030180/log.48310724._002367.job.log.tgz.1
[2026-01-26 01:14:35] turl=davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/82/7b/log.48310724._002367.job.log.tgz.1
[2026-01-26 01:14:35] workdir=None
[2026-01-26 01:14:35] ]
[2026-01-26 01:14:35] 2026-01-26 00:13:59,948 | INFO | transferring file log.48310724._002367.job.log.tgz.1 from /var/lib/boinc_data/boinc-01/slots/1/PanDA_Pilot-6981030180/log.48310724._002367.job.log.tgz.1 to /var/li
[2026-01-26 01:14:35] 2026-01-26 00:13:59,948 | INFO | executing command: /usr/bin/env mv /var/lib/boinc_data/boinc-01/slots/1/PanDA_Pilot-6981030180/log.48310724._002367.job.log.tgz.1 /var/lib/boinc_data/boinc-01/slot
[2026-01-26 01:14:35] 2026-01-26 00:13:59,964 | INFO | adding to output.list: log.48310724._002367.job.log.tgz.1 davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/82/7b/log.48310724._002367.job.log.tg
[2026-01-26 01:14:35] 2026-01-26 00:13:59,965 | INFO | alt stage-out settings: ['pl', 'write_lan', 'w', 'default'], allow_altstageout=False, remain_files=0, has_altstorage=True
[2026-01-26 01:14:35] 2026-01-26 00:13:59,965 | INFO | summary of transferred files:
[2026-01-26 01:14:35] 2026-01-26 00:13:59,965 | INFO | -- lfn=log.48310724._002367.job.log.tgz.1, status_code=0, status=transferred
[2026-01-26 01:14:35] 2026-01-26 00:13:59,965 | INFO | stage-out finished correctly
[2026-01-26 01:14:35] 2026-01-26 00:14:00,365 | INFO | time since job start (4551s) is within the limit (349056.0s)
[2026-01-26 01:14:35] 2026-01-26 00:14:00,945 | INFO | monitor loop #350: job 0:6981030180 is in state 'finished'
[2026-01-26 01:14:35] 2026-01-26 00:14:00,945 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-01-26 01:14:35] 2026-01-26 00:14:01,198 | INFO | finished stage-out for finished payload, adding job to finished_jobs queue
[2026-01-26 01:14:35] 2026-01-26 00:14:02,371 | INFO | time since job start (4553s) is within the limit (349056.0s)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,139 | INFO | job 6981030180 has state=finished
[2026-01-26 01:14:35] 2026-01-26 00:14:03,139 | INFO | preparing for final server update for job 6981030180 in state='finished'
[2026-01-26 01:14:35] 2026-01-26 00:14:03,139 | INFO | reading metadata from: /var/lib/boinc_data/boinc-01/slots/1/PanDA_Pilot-6981030180/jobReport.json
[2026-01-26 01:14:35] 2026-01-26 00:14:03,140 | INFO | added worker_node to metadata from /var/lib/boinc_data/boinc-01/slots/1/workernode_map.json
[2026-01-26 01:14:35] 2026-01-26 00:14:03,140 | INFO | this job has now completed (state=finished)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,140 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,140 | INFO | log transfer has been attempted: DONE
[2026-01-26 01:14:35] 2026-01-26 00:14:03,141 | INFO | job 6981030180 has finished - writing final server update
[2026-01-26 01:14:35] 2026-01-26 00:14:03,141 | INFO | total number of processed events: 400 (read)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,142 | INFO | using path: /var/lib/boinc_data/boinc-01/slots/1/PanDA_Pilot-6981030180/memory_monitor_summary.json (trf name=prmon)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,142 | INFO | extracted standard info from prmon json
[2026-01-26 01:14:35] 2026-01-26 00:14:03,142 | INFO | extracted standard memory fields from prmon json
[2026-01-26 01:14:35] 2026-01-26 00:14:03,143 | WARNING | GPU info not found in prmon json: 'gpu'
[2026-01-26 01:14:35] 2026-01-26 00:14:03,143 | WARNING | format EVNTtoHITS has no such key: dbData
[2026-01-26 01:14:35] 2026-01-26 00:14:03,143 | WARNING | format EVNTtoHITS has no such key: dbTime
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | fitting pss+swap vs Time
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | sum of square deviations: 97479037.0
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | sum of deviations: -78693446.50000006
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | mean x: 1769384259.5
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | mean y: 2331004.3088235296
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | intersect: 1430729866.7525043
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | chi2: 0.005638779758964678
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | current memory leak: -0.81 B/s (using 68 data points, chi2=0.01)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | could have reported an average CPU frequency of 3700 MHz (6 samples)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | ..............................
[2026-01-26 01:14:35] 2026-01-26 00:14:03,144 | INFO | . Timing measurements:
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . get job = 0 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . initial setup = 1 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . payload setup = 5 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . stage-in = 0 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . payload execution = 4529 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . stage-out = 0 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | . log creation = 0 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,145 | INFO | ..............................
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO |
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | job summary report
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | --------------------------------------------------
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | PanDA job id: 6981030180
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | task id: 48310724
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | errors: (none)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | status: LOG_TRANSFER = DONE
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | pilot state: finished
[2026-01-26 01:14:35] 2026-01-26 00:14:03,176 | INFO | transexitcode: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | exeerrorcode: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | exeerrordiag:
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | exitcode: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | exitmsg: OK
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | cpuconsumptiontime: 17043 s
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | nevents: 400
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | neventsw: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | pid: 23495
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | pgrp: 23495
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | corecount: 4
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | event service: False
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | sizes: {0: 2284264, 11: 2284264, 4538: 2310388, 4539: 2319414, 4540: 2319470, 4542: 2319664}
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | --------------------------------------------------
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO |
[2026-01-26 01:14:35] 2026-01-26 00:14:03,177 | INFO | executing command: ls -lF /var/lib/boinc_data/boinc-01/slots/1
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue jobs had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue data_in had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue data_out had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue current_data_in had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue validated_jobs had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue validated_payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue monitored_payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue finished_jobs had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue finished_payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue finished_data_in had 1 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue finished_data_out had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue failed_jobs had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue failed_payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue failed_data_in had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue failed_data_out had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue completed_jobs had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue completed_jobids has 1 job(s)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue realtimelog_payloads had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | queue messages had 0 job(s) [purged]
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | job 6981030180 has completed (purged errors)
[2026-01-26 01:14:35] 2026-01-26 00:14:03,194 | INFO | overall cleanup function is called
[2026-01-26 01:14:35] 2026-01-26 00:14:04,201 | INFO | --- collectZombieJob: --- 10, [23495]
[2026-01-26 01:14:35] 2026-01-26 00:14:04,202 | INFO | zombie collector waiting for pid 23495
[2026-01-26 01:14:35] 2026-01-26 00:14:04,202 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes
[2026-01-26 01:14:35] 2026-01-26 00:14:04,202 | INFO | collected zombie processes
[2026-01-26 01:14:35] 2026-01-26 00:14:04,202 | INFO | will attempt to kill all subprocesses of pid=23495
[2026-01-26 01:14:35] 2026-01-26 00:14:04,291 | INFO | process IDs to be killed: [23495] (in reverse order)
[2026-01-26 01:14:35] 2026-01-26 00:14:04,336 | WARNING | found no corresponding commands to process id(s)
[2026-01-26 01:14:35] 2026-01-26 00:14:04,336 | INFO | Do not look for orphan processes in BOINC jobs
[2026-01-26 01:14:35] 2026-01-26 00:14:04,339 | INFO | did not find any defunct processes belonging to 23495
[2026-01-26 01:14:35] 2026-01-26 00:14:04,341 | INFO | did not find any defunct processes belonging to 23495
[2026-01-26 01:14:35] 2026-01-26 00:14:04,341 | INFO | ready for new job
[2026-01-26 01:14:35] 2026-01-26 00:14:04,341 | INFO | pilot has finished with previous job - re-establishing logging
[2026-01-26 01:14:35] 2026-01-26 00:14:04,342 | INFO | **************************************
[2026-01-26 01:14:35] 2026-01-26 00:14:04,342 | INFO | *** PanDA Pilot version 3.11.3.9 ***
[2026-01-26 01:14:35] 2026-01-26 00:14:04,342 | INFO | **************************************
[2026-01-26 01:14:35] 2026-01-26 00:14:04,342 | INFO |
[2026-01-26 01:14:35] 2026-01-26 00:14:04,343 | INFO | pilot is running in a VM
[2026-01-26 01:14:35] 2026-01-26 00:14:04,343 | INFO | architecture information:
[2026-01-26 01:14:35] 2026-01-26 00:14:04,343 | INFO | executing command: cat /etc/os-release
[2026-01-26 01:14:35] 2026-01-26 00:14:04,356 | INFO | cat /etc/os-release:
[2026-01-26 01:14:35] NAME="CentOS Linux"
[2026-01-26 01:14:35] VERSION="7 (Core)"
[2026-01-26 01:14:35] ID="centos"
[2026-01-26 01:14:35] ID_LIKE="rhel fedora"
[2026-01-26 01:14:35] VERSION_ID="7"
[2026-01-26 01:14:35] PRETTY_NAME="CentOS Linux 7 (Core)"
[2026-01-26 01:14:35] ANSI_COLOR="0;31"
[2026-01-26 01:14:35] CPE_NAME="cpe:/o:centos:centos:7"
[2026-01-26 01:14:35] HOME_URL="https://www.centos.org/"
[2026-01-26 01:14:35] BUG_REPORT_URL="https://bugs.centos.org/"
[2026-01-26 01:14:35]
[2026-01-26 01:14:35] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2026-01-26 01:14:35] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2026-01-26 01:14:35] REDHAT_SUPPORT_PRODUCT="centos"
[2026-01-26 01:14:35] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2026-01-26 01:14:35]
[2026-01-26 01:14:35] 2026-01-26 00:14:04,356 | INFO | **************************************
[2026-01-26 01:14:35] 2026-01-26 00:14:04,859 | INFO | executing command: df -mP /var/lib/boinc_data/boinc-01/slots/1
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | INFO | sufficient remaining disk space (41956671488 B)
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | INFO | current server update state: UPDATING_FINAL
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | INFO | update_server=False
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2026-01-26 01:14:35] 2026-01-26 00:14:04,871 | INFO | aborting loop
[2026-01-26 01:14:35] 2026-01-26 00:14:05,507 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2026-01-26 01:14:35] 2026-01-26 00:14:05,555 | INFO | all data control threads have been joined
[2026-01-26 01:14:35] 2026-01-26 00:14:05,847 | INFO | all payload control threads have been joined
[2026-01-26 01:14:35] 2026-01-26 00:14:05,876 | INFO | [job] retrieve thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:05,877 | INFO | [job] queue monitor thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:05,877 | INFO | [job] job monitor thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:05,877 | INFO | [data] copytool_in thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:06,012 | INFO | all job control threads have been joined
[2026-01-26 01:14:35] 2026-01-26 00:14:06,245 | INFO | [payload] validate_post thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:06,560 | INFO | [data] control thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:06,853 | INFO | [payload] control thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:06,895 | INFO | [job] validate thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,016 | INFO | [job] create_data_payload thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,016 | INFO | [payload] validate_pre thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,017 | INFO | [job] control thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,237 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2026-01-26 01:14:35] 2026-01-26 00:14:07,315 | INFO | [payload] execute_payloads thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,323 | INFO | [payload] failed_post thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:07,513 | INFO | [data] copytool_out thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:11,244 | INFO | [data] queue_monitor thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:14,281 | INFO | [monitor] cgroup control has ended
[2026-01-26 01:14:35] 2026-01-26 00:14:15,477 | INFO | job.realtimelogging is not enabled
[2026-01-26 01:14:35] 2026-01-26 00:14:16,483 | INFO | [payload] run_realtimelog thread has finished
[2026-01-26 01:14:35] 2026-01-26 00:14:16,952 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 124718169114432)>', '<ExcThread(monitor, started 124717344200448)>']
[2026-01-26 01:14:35] 2026-01-26 00:14:21,977 | INFO | all workflow threads have been joined
[2026-01-26 01:14:35] 2026-01-26 00:14:21,977 | INFO | end of generic workflow (traces error code: 0)
[2026-01-26 01:14:35] 2026-01-26 00:14:21,978 | INFO | traces error code: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:21,978 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2026-01-26 01:14:35] 2026-01-26 00:14:35,547 | INFO | PID=16131 has CPU usage=1.7% 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
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | INFO | .. there are 3 such processes running
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | INFO | found 0 job(s) in 20 queues
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | WARNING | will wait for a maximum of 300 s for threads to finish
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | WARNING | job_aborted has been set - aborting pilot monitoring
[2026-01-26 01:14:35] 2026-01-26 00:14:35,548 | INFO | [monitor] control thread has ended
[2026-01-26 01:14:35] 2026-01-26 00:14:35,606 [wrapper] ==== pilot stdout END ====
[2026-01-26 01:14:35] 2026-01-26 00:14:35,610 [wrapper] ==== wrapper stdout RESUME ====
[2026-01-26 01:14:35] 2026-01-26 00:14:35,613 [wrapper] pilotpid: 16131
[2026-01-26 01:14:35] 2026-01-26 00:14:35,616 [wrapper] Pilot exit status: 0
[2026-01-26 01:14:35] 2026-01-26 00:14:35,631 [wrapper] pandaids: 6981030180 6981030180 6981030180 6981030180 6981030180
[2026-01-26 01:14:35] 2026-01-26 00:14:35,661 [wrapper] cleanup supervisor_pilot 41997 16134
[2026-01-26 01:14:35] 2026-01-26 00:14:35,664 [wrapper] Test setup, not cleaning
[2026-01-26 01:14:35] 2026-01-26 00:14:35,667 [wrapper] apfmon messages muted
[2026-01-26 01:14:35] 2026-01-26 00:14:35,670 [wrapper] ==== wrapper stdout END ====
[2026-01-26 01:14:35] 2026-01-26 00:14:35,674 [wrapper] ==== wrapper stderr END ====
[2026-01-26 01:14:35] *** Error codes and diagnostics ***
[2026-01-26 01:14:35] "exeErrorCode": 0,
[2026-01-26 01:14:35] "exeErrorDiag": "",
[2026-01-26 01:14:35] "pilotErrorCode": 0,
[2026-01-26 01:14:35] "pilotErrorDiag": "",
[2026-01-26 01:14:35] *** Listing of results directory ***
[2026-01-26 01:14:35] insgesamt 1144864
[2026-01-26 01:14:35] drwx------ 5 yeti boinc 4096 Jan 14 11:00 pilot3
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 584422 Jan 24 10:17 pilot3.tar.gz
[2026-01-26 01:14:35] -rwx------ 1 yeti boinc 36322 Jan 24 10:20 runpilot2-wrapper.sh
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 5111 Jan 24 10:22 queuedata.json
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 100 Jan 24 16:01 wrapper_26015_x86_64-pc-linux-gnu
[2026-01-26 01:14:35] -rwxr-xr-x 1 yeti boinc 7986 Jan 24 16:01 run_atlas
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 105 Jan 24 16:01 job.xml
[2026-01-26 01:14:35] -rw-r--r-- 3 yeti boinc 491978111 Jan 24 16:01 EVNT.48310721._000048.pool.root.1
[2026-01-26 01:14:35] -rw-r--r-- 3 yeti boinc 491978111 Jan 24 16:01 ATLAS.root_0
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 15845 Jan 24 16:01 start_atlas.sh
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 597761 Jan 24 16:01 input.tar.gz
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 0 Jan 24 16:01 boinc_setup_complete
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 0 Jan 24 16:01 boinc_lockfile
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 0 Jan 25 19:58 wrapper_sigint_13362
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 0 Jan 25 20:01 wrapper_sigkill_13362
[2026-01-26 01:14:35] drwxrwx--x 2 yeti boinc 4096 Jan 25 20:01 shared
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 0 Jan 25 23:44 wrapper_sigint_16026
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 1516246 Jan 25 23:44 agis_ddmendpoints.agis.ALL.json
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 6564 Jan 25 23:57 init_data.xml
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 2533 Jan 25 23:57 pandaJob.out
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 52 Jan 25 23:57 setup.sh.local
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 1004254 Jan 25 23:58 agis_schedconf.cvmfs.json
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 423 Jan 25 23:58 workernode_map.json
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 182507295 Jan 26 01:13 HITS.48310724._002367.pool.root.1
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 530 Jan 26 01:13 boinc_task_state.xml
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 99 Jan 26 01:13 pilot_heartbeat.json
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 1024 Jan 26 01:13 memory_monitor_summary.json
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 268487 Jan 26 01:13 log.48310724._002367.job.log.tgz.1
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 6292 Jan 26 01:14 heartbeat.json
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 27 Jan 26 01:14 wrapper_checkpoint.txt
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 8192 Jan 26 01:14 boinc_mmap_file
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 820 Jan 26 01:14 pilotlog.txt
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 686942 Jan 26 01:14 log.48310724._002367.job.log.1
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 357 Jan 26 01:14 output.list
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 620 Jan 26 01:14 runtime_log
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 972800 Jan 26 01:14 result.tar.gz
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 9628 Jan 26 01:14 runtime_log.err
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 1619 Jan 26 01:14 5Y7LDm7zo38n9Rq4apOajLDm4fhM0noT9bVo0NGKDmGLyKDmEuwuXm.diag
[2026-01-26 01:14:35] -rw-r--r-- 1 yeti boinc 42514 Jan 26 01:14 stderr.txt
[2026-01-26 01:14:35] HITS file was successfully produced:
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 182507295 Jan 26 01:13 shared/HITS.pool.root.1
[2026-01-26 01:14:35] *** Contents of shared directory: ***
[2026-01-26 01:14:35] insgesamt 660240
[2026-01-26 01:14:35] -rw-r--r-- 3 yeti boinc 491978111 Jan 24 16:01 ATLAS.root_0
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 15845 Jan 24 16:01 start_atlas.sh
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 597761 Jan 24 16:01 input.tar.gz
[2026-01-26 01:14:35] -rw------- 1 yeti boinc 182507295 Jan 26 01:13 HITS.pool.root.1
[2026-01-26 01:14:35] -rw-r--r-- 2 yeti boinc 972800 Jan 26 01:14 result.tar.gz
01:14:37 (3970): run_atlas exited; CPU time 17087.787500
01:14:37 (3970): called boinc_finish(0)
</stderr_txt>
]]>
©2026 CERN