Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
11:36:11 (2279079): wrapper (7.7.26015): starting
11:36:11 (2279079): wrapper: running run_atlas (--nthreads 9)
[2026-04-18 11:36:11] Arguments: --nthreads 9
[2026-04-18 11:36:11] Threads: 9
[2026-04-18 11:36:11] Checking for CVMFS
[2026-04-18 11:36:12] Probing /cvmfs/atlas.cern.ch... OK
[2026-04-18 11:36:12] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-04-18 11:36:12] Running cvmfs_config stat atlas.cern.ch
[2026-04-18 11:36:12] 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-04-18 11:36:12] 2.13.3.0 7489 236157 354028 158589 2 282 24507780 32935937 25044 16776704 0 1078509244 99.559 1262084166 36536 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2026-04-18 11:36:12] CVMFS is ok
[2026-04-18 11:36:12] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-04-18 11:36:12] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-04-18 11:36:12] Further information can be found at the LHC@home message board.
[2026-04-18 11:36:12] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-04-18 11:36:12] Checking for apptainer binary...
[2026-04-18 11:36:12] Using apptainer found in PATH at /usr/bin/apptainer
[2026-04-18 11:36:12] Running /usr/bin/apptainer --version
[2026-04-18 11:36:13] apptainer version 1.4.5-2.el9
[2026-04-18 11:36:13] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-04-18 11:36:13] c7-13-32.aglt2.org
[2026-04-18 11:36:13] apptainer works
[2026-04-18 11:36:13] Set ATHENA_PROC_NUMBER=9
[2026-04-18 11:36:13] Set ATHENA_CORE_NUMBER=9
[2026-04-18 11:36:13] Starting ATLAS job with PandaID=7100923224
[2026-04-18 11:36:13] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
14:45:17 (2932067): wrapper (7.7.26015): starting
14:45:17 (2932067): wrapper: running run_atlas (--nthreads 8)
[2026-04-18 14:45:17] Arguments: --nthreads 8
[2026-04-18 14:45:17] Threads: 8
[2026-04-18 14:45:17] This job has been restarted, cleaning up previous attempt
[2026-04-18 14:45:18] Checking for CVMFS
[2026-04-18 14:45:18] Probing /cvmfs/atlas.cern.ch... OK
[2026-04-18 14:45:18] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-04-18 14:45:18] Running cvmfs_config stat atlas.cern.ch
[2026-04-18 14:45:19] 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-04-18 14:45:19] 2.13.3.0 7489 236346 351836 158594 1 145 25483886 32935937 22528 16776704 0 1079320327 99.560 1262148576 36535 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2026-04-18 14:45:19] CVMFS is ok
[2026-04-18 14:45:19] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-04-18 14:45:19] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-04-18 14:45:19] Further information can be found at the LHC@home message board.
[2026-04-18 14:45:19] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-04-18 14:45:19] Checking for apptainer binary...
[2026-04-18 14:45:19] Using apptainer found in PATH at /usr/bin/apptainer
[2026-04-18 14:45:19] Running /usr/bin/apptainer --version
[2026-04-18 14:45:20] apptainer version 1.4.5-2.el9
[2026-04-18 14:45:20] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-04-18 14:45:20] c7-13-32.aglt2.org
[2026-04-18 14:45:20] apptainer works
[2026-04-18 14:45:20] Set ATHENA_PROC_NUMBER=8
[2026-04-18 14:45:20] Set ATHENA_CORE_NUMBER=8
[2026-04-18 14:45:20] Starting ATLAS job with PandaID=7100923224
[2026-04-18 14:45:20] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-04-18 18:57:25]  *** The last 200 lines of the pilot log: ***
[2026-04-18 18:57:25] 2026-04-18 22:56:42,135 | INFO     | total number of processed events: 400 (read)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,144 | INFO     | using path: /tmp/boinchome/slots/2/PanDA_Pilot-7100923224/memory_monitor_summary.json (trf name=prmon)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,145 | INFO     | extracted standard info from prmon json
[2026-04-18 18:57:25] 2026-04-18 22:56:42,145 | INFO     | extracted standard memory fields from prmon json
[2026-04-18 18:57:25] 2026-04-18 22:56:42,145 | WARNING  | format EVNTtoHITS has no such key: dbData
[2026-04-18 18:57:25] 2026-04-18 22:56:42,146 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2026-04-18 18:57:25] 2026-04-18 22:56:42,148 | INFO     | fitting pss+swap vs Time
[2026-04-18 18:57:25] 2026-04-18 22:56:42,149 | INFO     | sum of square deviations: 4616043080.573188
[2026-04-18 18:57:25] 2026-04-18 22:56:42,150 | INFO     | sum of deviations: 46110196151.987785
[2026-04-18 18:57:25] 2026-04-18 22:56:42,150 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,150 | INFO     | mean y: 2548019.3943089433
[2026-04-18 18:57:25] 2026-04-18 22:56:42,150 | INFO     | intersect: 2548019.3943089433
[2026-04-18 18:57:25] 2026-04-18 22:56:42,151 | INFO     | chi2: 1.6972711614451845
[2026-04-18 18:57:25] 2026-04-18 22:56:42,151 | INFO     | sum of square deviations: 4340284679.311179
[2026-04-18 18:57:25] 2026-04-18 22:56:42,152 | INFO     | sum of deviations: 44908186386.456436
[2026-04-18 18:57:25] 2026-04-18 22:56:42,152 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,152 | INFO     | mean y: 2547354.609958506
[2026-04-18 18:57:25] 2026-04-18 22:56:42,152 | INFO     | intersect: 2547354.609958506
[2026-04-18 18:57:25] 2026-04-18 22:56:42,153 | INFO     | chi2: 1.6980608997915603
[2026-04-18 18:57:25] 2026-04-18 22:56:42,153 | INFO     | current chi2=1.6980608997915603 (change=-0.04652988658001489 %)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,153 | INFO     | right removable region: 240
[2026-04-18 18:57:25] 2026-04-18 22:56:42,153 | INFO     | sum of square deviations: 4340204281.020768
[2026-04-18 18:57:25] 2026-04-18 22:56:42,154 | INFO     | sum of deviations: 1207506074.5394213
[2026-04-18 18:57:25] 2026-04-18 22:56:42,154 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,154 | INFO     | mean y: 2572668.8298755186
[2026-04-18 18:57:25] 2026-04-18 22:56:42,155 | INFO     | intersect: 2572668.8298755186
[2026-04-18 18:57:25] 2026-04-18 22:56:42,155 | INFO     | chi2: 0.05289531495632669
[2026-04-18 18:57:25] 2026-04-18 22:56:42,155 | INFO     | current chi2=0.05289531495632669 (change=96.88350829508659 %)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,155 | INFO     | sum of square deviations: 4075589573.1991744
[2026-04-18 18:57:25] 2026-04-18 22:56:42,156 | INFO     | sum of deviations: -3140457227.5296636
[2026-04-18 18:57:25] 2026-04-18 22:56:42,156 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,157 | INFO     | mean y: 2575140.9872881356
[2026-04-18 18:57:25] 2026-04-18 22:56:42,157 | INFO     | intersect: 2575140.9872881356
[2026-04-18 18:57:25] 2026-04-18 22:56:42,157 | INFO     | chi2: 0.024358834122601866
[2026-04-18 18:57:25] 2026-04-18 22:56:42,157 | INFO     | current chi2=0.024358834122601866 (change=53.94897611874724 %)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,157 | INFO     | sum of square deviations: 3822009394.5974116
[2026-04-18 18:57:25] 2026-04-18 22:56:42,158 | INFO     | sum of deviations: -1307122303.220778
[2026-04-18 18:57:25] 2026-04-18 22:56:42,158 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,158 | INFO     | mean y: 2574037.1948051946
[2026-04-18 18:57:25] 2026-04-18 22:56:42,159 | INFO     | intersect: 2574037.1948051946
[2026-04-18 18:57:25] 2026-04-18 22:56:42,159 | INFO     | chi2: 0.0227023099172621
[2026-04-18 18:57:25] 2026-04-18 22:56:42,159 | INFO     | current chi2=0.0227023099172621 (change=6.8005069413512045 %)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,159 | INFO     | left removable region: 15
[2026-04-18 18:57:25] 2026-04-18 22:56:42,159 | INFO     | sum of square deviations: 3531886804.3288703
[2026-04-18 18:57:25] 2026-04-18 22:56:42,160 | INFO     | sum of deviations: -1560525201.315556
[2026-04-18 18:57:25] 2026-04-18 22:56:42,160 | INFO     | mean x (centered): 0.0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,160 | INFO     | mean y: 2573877.351111111
[2026-04-18 18:57:25] 2026-04-18 22:56:42,161 | INFO     | intersect: 2573877.351111111
[2026-04-18 18:57:25] 2026-04-18 22:56:42,161 | INFO     | chi2: 0.0226264675730731
[2026-04-18 18:57:25] 2026-04-18 22:56:42,161 | INFO     | current memory leak: -0.44 B/s (using 225 data points, chi2=0.02)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,161 | INFO     | could have reported an average CPU frequency of 3283 MHz (12 samples)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,161 | INFO     | ..............................
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . Timing measurements:
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . get job = 0 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . initial setup = 2 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . payload setup = 23 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . stage-in = 0 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . payload execution = 15006 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . stage-out = 2 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | . log creation = 0 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,162 | INFO     | ..............................
[2026-04-18 18:57:25] 2026-04-18 22:56:42,228 | INFO     | 
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | job summary report
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | --------------------------------------------------
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | PanDA job id: 7100923224
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | task id: 49820375
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | errors: (none)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | status: LOG_TRANSFER = DONE 
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | pilot state: finished 
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | transexitcode: 0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | exeerrorcode: 0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | exeerrordiag: 
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | exitcode: 0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | exitmsg: OK
[2026-04-18 18:57:25] 2026-04-18 22:56:42,229 | INFO     | cpuconsumptiontime: 58322 s
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | nevents: 400
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | neventsw: 0
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | pid: 2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | pgrp: 2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | corecount: 8
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | event service: False
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | sizes: {0: 2283435, 11: 2283435, 15033: 2314725, 15036: 2323779, 15037: 2323917}
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | --------------------------------------------------
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | 
[2026-04-18 18:57:25] 2026-04-18 22:56:42,230 | INFO     | executing command: ls -lF /tmp/boinchome/slots/2
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue jobs had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue data_in had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue data_out had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue current_data_in had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,271 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue completed_jobids has 1 job(s)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | queue messages had 0 job(s) [purged]
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | job 7100923224 has completed (purged errors)
[2026-04-18 18:57:25] 2026-04-18 22:56:42,272 | INFO     | overall cleanup function is called
[2026-04-18 18:57:25] 2026-04-18 22:56:43,282 | INFO     | --- collectZombieJob: --- 10, [2961980]
[2026-04-18 18:57:25] 2026-04-18 22:56:43,282 | INFO     | zombie collector waiting for pid 2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:43,283 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2026-04-18 18:57:25] 2026-04-18 22:56:43,283 | INFO     | collected zombie processes
[2026-04-18 18:57:25] 2026-04-18 22:56:43,283 | INFO     | will attempt to kill all subprocesses of pid=2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:43,592 | INFO     | process IDs to be killed: [2961980] (in reverse order)
[2026-04-18 18:57:25] 2026-04-18 22:56:43,728 | WARNING  | found no corresponding commands to process id(s)
[2026-04-18 18:57:25] 2026-04-18 22:56:43,728 | INFO     | Do not look for orphan processes in BOINC jobs
[2026-04-18 18:57:25] 2026-04-18 22:56:43,744 | INFO     | did not find any defunct processes belonging to 2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:43,772 | INFO     | did not find any defunct processes belonging to 2961980
[2026-04-18 18:57:25] 2026-04-18 22:56:43,773 | INFO     | Ready for new job
[2026-04-18 18:57:25] 2026-04-18 22:56:43,776 | INFO     | **************************************
[2026-04-18 18:57:25] 2026-04-18 22:56:43,776 | INFO     | ***  PanDA Pilot version 3.12.4.1  ***
[2026-04-18 18:57:25] 2026-04-18 22:56:43,777 | INFO     | **************************************
[2026-04-18 18:57:25] 2026-04-18 22:56:43,777 | INFO     | 
[2026-04-18 18:57:25] 2026-04-18 22:56:43,781 | INFO     | architecture information:
[2026-04-18 18:57:25] 2026-04-18 22:56:43,805 | INFO     | executing command: cat /etc/os-release
[2026-04-18 18:57:25] 2026-04-18 22:56:43,899 | INFO     | cat /etc/os-release:
[2026-04-18 18:57:25] NAME="CentOS Linux"
[2026-04-18 18:57:25] VERSION="7 (Core)"
[2026-04-18 18:57:25] ID="centos"
[2026-04-18 18:57:25] ID_LIKE="rhel fedora"
[2026-04-18 18:57:25] VERSION_ID="7"
[2026-04-18 18:57:25] PRETTY_NAME="CentOS Linux 7 (Core)"
[2026-04-18 18:57:25] ANSI_COLOR="0;31"
[2026-04-18 18:57:25] CPE_NAME="cpe:/o:centos:centos:7"
[2026-04-18 18:57:25] HOME_URL="https://www.centos.org/"
[2026-04-18 18:57:25] BUG_REPORT_URL="https://bugs.centos.org/"
[2026-04-18 18:57:25] 
[2026-04-18 18:57:25] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2026-04-18 18:57:25] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2026-04-18 18:57:25] REDHAT_SUPPORT_PRODUCT="centos"
[2026-04-18 18:57:25] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2026-04-18 18:57:25] 
[2026-04-18 18:57:25] 2026-04-18 22:56:43,899 | INFO     | **************************************
[2026-04-18 18:57:25] 2026-04-18 22:56:44,406 | INFO     | executing command: df -mP /tmp/boinchome/slots/2
[2026-04-18 18:57:25] 2026-04-18 22:56:44,531 | INFO     | sufficient remaining disk space (82898321408 B)
[2026-04-18 18:57:25] 2026-04-18 22:56:44,531 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2026-04-18 18:57:25] 2026-04-18 22:56:44,531 | INFO     | current server update state: UPDATING_FINAL
[2026-04-18 18:57:25] 2026-04-18 22:56:44,531 | INFO     | update_server=False
[2026-04-18 18:57:25] 2026-04-18 22:56:44,531 | WARNING  | proceed_with_getjob() returned False &#226;&#128;&#148; stopping retrieve loop (pilot will end)
[2026-04-18 18:57:25] 2026-04-18 22:56:44,532 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2026-04-18 18:57:25] 2026-04-18 22:56:44,647 | INFO     | all data control threads have been joined
[2026-04-18 18:57:25] 2026-04-18 22:56:44,957 | WARNING  | process 2961980 can no longer be monitored (due to stat problems) - aborting
[2026-04-18 18:57:25] 2026-04-18 22:56:45,192 | INFO     | all payload control threads have been joined
[2026-04-18 18:57:25] 2026-04-18 22:56:45,318 | INFO     | using path: /tmp/boinchome/slots/2/memory_monitor_summary.json (trf name=prmon)
[2026-04-18 18:57:25] 2026-04-18 22:56:45,401 | INFO     | all job control threads have been joined
[2026-04-18 18:57:25] 2026-04-18 22:56:45,539 | INFO     | [job] retrieve thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:45,623 | INFO     | [payload] validate_post thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:45,640 | INFO     | [job] validate thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:45,648 | INFO     | number of running child processes to parent process 2961980: 1
[2026-04-18 18:57:25] 2026-04-18 22:56:45,648 | INFO     | maximum number of monitored processes: 6
[2026-04-18 18:57:25] 2026-04-18 22:56:45,648 | INFO     | aborting job monitoring since job object (job id=7100923224) has expired
[2026-04-18 18:57:25] 2026-04-18 22:56:45,648 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2026-04-18 18:57:25] 2026-04-18 22:56:45,648 | INFO     | will abort loop
[2026-04-18 18:57:25] 2026-04-18 22:56:45,658 | INFO     | [data] control thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:45,806 | INFO     | [job] create_data_payload thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:45,912 | INFO     | [payload] failed_post thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,202 | INFO     | [payload] control thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,407 | INFO     | [job] control thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,541 | INFO     | [data] copytool_out thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,651 | INFO     | [payload] execute_payloads thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,654 | INFO     | [job] job monitor thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,747 | INFO     | [payload] validate_pre thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,756 | INFO     | [data] copytool_in thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:46,824 | INFO     | [payload] run_realtimelog thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:47,263 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2026-04-18 18:57:25] 2026-04-18 22:56:47,474 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2026-04-18 18:57:25] 2026-04-18 22:56:48,269 | INFO     | [job] queue monitor thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:56:51,487 | INFO     | [data] queue_monitor thread has finished
[2026-04-18 18:57:25] 2026-04-18 22:57:14,949 | INFO     | PID=2947696 has CPU usage=6.9% 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 P
[2026-04-18 18:57:25] 2026-04-18 22:57:14,949 | INFO     | .. there are 16 such processes running
[2026-04-18 18:57:25] 2026-04-18 22:57:14,949 | INFO     | found 0 job(s) in 20 queues
[2026-04-18 18:57:25] 2026-04-18 22:57:14,950 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2026-04-18 18:57:25] 2026-04-18 22:57:14,950 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2026-04-18 18:57:25] 2026-04-18 22:57:19,213 | INFO     | [monitor] cgroup control has ended
[2026-04-18 18:57:25] 2026-04-18 22:57:19,777 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140427667134272)>', '<ExcThread(monitor, started 140427009177344)>']
[2026-04-18 18:57:25] 2026-04-18 22:57:19,980 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2026-04-18 18:57:25] 2026-04-18 22:57:19,981 | INFO     | [monitor] control thread has ended
[2026-04-18 18:57:25] 2026-04-18 22:57:24,803 | INFO     | all workflow threads have been joined
[2026-04-18 18:57:25] 2026-04-18 22:57:24,803 | INFO     | end of generic workflow (traces error code: 0)
[2026-04-18 18:57:25] 2026-04-18 22:57:24,803 | INFO     | traces error code: 0
[2026-04-18 18:57:25] 2026-04-18 22:57:24,804 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2026-04-18 18:57:25] 2026-04-18 22:57:24,942 [wrapper] ==== pilot stdout END ====
[2026-04-18 18:57:25] 2026-04-18 22:57:24,945 [wrapper] ==== wrapper stdout RESUME ====
[2026-04-18 18:57:25] 2026-04-18 22:57:24,950 [wrapper] pilotpid: 2947696
[2026-04-18 18:57:25] 2026-04-18 22:57:24,953 [wrapper] Pilot exit status: 0
[2026-04-18 18:57:25] 2026-04-18 22:57:24,967 [wrapper] pandaids: 7100923224 7100923224
[2026-04-18 18:57:25] 2026-04-18 22:57:25,051 [wrapper] cleanup supervisor_pilot 4173463 2947697
[2026-04-18 18:57:25] 2026-04-18 22:57:25,056 [wrapper] Test setup, not cleaning
[2026-04-18 18:57:25] 2026-04-18 22:57:25,058 [wrapper] apfmon messages muted
[2026-04-18 18:57:25] 2026-04-18 22:57:25,061 [wrapper] ==== wrapper stdout END ====
[2026-04-18 18:57:25] 2026-04-18 22:57:25,063 [wrapper] ==== wrapper stderr END ====
[2026-04-18 18:57:25]  *** Error codes and diagnostics ***
[2026-04-18 18:57:25]     "exeErrorCode": 0,
[2026-04-18 18:57:25]     "pilotErrorCode": 0,
[2026-04-18 18:57:25]  *** Listing of results directory ***
[2026-04-18 18:57:25] total 4615424
[2026-04-18 18:57:25] drwx------. 5 boincer umatlas       4096 Apr  1 08:07 pilot3
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas     644190 Apr 18 07:57 pilot3.tar.gz
[2026-04-18 18:57:25] -rwx------. 1 boincer umatlas      36322 Apr 18 08:01 runpilot2-wrapper.sh
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas       5094 Apr 18 08:20 queuedata.json
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas        100 Apr 18 11:36 wrapper_26015_x86_64-pc-linux-gnu
[2026-04-18 18:57:25] -rwxr-xr-x. 1 boincer umatlas       7986 Apr 18 11:36 run_atlas
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas        105 Apr 18 11:36 job.xml
[2026-04-18 18:57:25] -rw-r--r--. 3 boincer umatlas 2223969571 Apr 18 11:36 EVNT.49820373._000008.pool.root.1
[2026-04-18 18:57:25] -rw-r--r--. 3 boincer umatlas 2223969571 Apr 18 11:36 ATLAS.root_0
[2026-04-18 18:57:25] drwxrwx--x. 2 boincer umatlas       4096 Apr 18 11:36 shared
[2026-04-18 18:57:25] -rw-r--r--. 2 boincer umatlas     656915 Apr 18 11:36 input.tar.gz
[2026-04-18 18:57:25] -rw-r--r--. 2 boincer umatlas      15665 Apr 18 11:36 start_atlas.sh
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas          0 Apr 18 11:36 boinc_lockfile
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas       2582 Apr 18 14:45 pandaJob.out
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas         57 Apr 18 14:45 setup.sh.local
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas     997676 Apr 18 14:45 agis_schedconf.cvmfs.json
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas        429 Apr 18 14:45 workernode_map.json
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas       6819 Apr 18 18:48 init_data.xml
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas  270448291 Apr 18 18:55 HITS.49820375._000674.pool.root.1
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas        489 Apr 18 18:55 boinc_task_state.xml
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas         96 Apr 18 18:56 pilot_heartbeat.json
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas       1049 Apr 18 18:56 memory_monitor_summary.json
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas    1512404 Apr 18 18:56 agis_ddmendpoints.agis.ALL.json
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas     554710 Apr 18 18:56 log.49820375._000674.job.log.tgz.1
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas       6374 Apr 18 18:56 heartbeat_new.json
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas       6265 Apr 18 18:56 heartbeat.json
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas       8192 Apr 18 18:57 boinc_mmap_file
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas         28 Apr 18 18:57 wrapper_checkpoint.txt
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas       5340 Apr 18 18:57 pilotlog.txt
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas    1311689 Apr 18 18:57 log.49820375._000674.job.log.1
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas        357 Apr 18 18:57 output.list
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas        410 Apr 18 18:57 runtime_log
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas    1884160 Apr 18 18:57 result.tar.gz
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas       9049 Apr 18 18:57 runtime_log.err
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas        785 Apr 18 18:57 7289d9b1a5d3.diag
[2026-04-18 18:57:25] -rw-r--r--. 1 boincer umatlas      23095 Apr 18 18:57 stderr.txt
[2026-04-18 18:57:25] HITS file was successfully produced:
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas 270448291 Apr 18 18:55 shared/HITS.pool.root.1
[2026-04-18 18:57:25]  *** Contents of shared directory: ***
[2026-04-18 18:57:25] total 2438468
[2026-04-18 18:57:25] -rw-r--r--. 3 boincer umatlas 2223969571 Apr 18 11:36 ATLAS.root_0
[2026-04-18 18:57:25] -rw-r--r--. 2 boincer umatlas     656915 Apr 18 11:36 input.tar.gz
[2026-04-18 18:57:25] -rw-r--r--. 2 boincer umatlas      15665 Apr 18 11:36 start_atlas.sh
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas  270448291 Apr 18 18:55 HITS.pool.root.1
[2026-04-18 18:57:25] -rw-------. 1 boincer umatlas    1884160 Apr 18 18:57 result.tar.gz
18:57:27 (2932067): run_atlas exited; CPU time 58609.280234
18:57:27 (2932067): called boinc_finish(0)

</stderr_txt>
]]>

©2026 CERN