Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
20:00:56 (3619278): wrapper (7.7.26015): starting
20:00:56 (3619278): wrapper: running run_atlas (--nthreads 8)
[2025-12-12 20:00:56] Arguments: --nthreads 8
[2025-12-12 20:00:56] Threads: 8
[2025-12-12 20:00:56] Checking for CVMFS
[2025-12-12 20:00:57] Probing /cvmfs/atlas.cern.ch... OK
[2025-12-12 20:00:58] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-12-12 20:00:58] Running cvmfs_config stat atlas.cern.ch
[2025-12-12 20:01:00] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2025-12-12 20:01:00] 2.13.3.0 11561 52146 309344 153942 1 220 32292754 32935936 22691 16776704 0 252368881 99.731 169424468 32394 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2025-12-12 20:01:00] CVMFS is ok
[2025-12-12 20:01:00] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-12-12 20:01:00] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-12-12 20:01:00] Further information can be found at the LHC@home message board.
[2025-12-12 20:01:00] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-12-12 20:01:00] Checking for apptainer binary...
[2025-12-12 20:01:00] Using apptainer found in PATH at /usr/bin/apptainer
[2025-12-12 20:01:00] Running /usr/bin/apptainer --version
[2025-12-12 20:01:00] apptainer version 1.4.4-1.el9
[2025-12-12 20:01:00] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-12-12 20:01:01] c-8-14.aglt2.org
[2025-12-12 20:01:01] apptainer works
[2025-12-12 20:01:01] Set ATHENA_PROC_NUMBER=8
[2025-12-12 20:01:01] Set ATHENA_CORE_NUMBER=8
[2025-12-12 20:01:01] Starting ATLAS job with PandaID=6928768344
[2025-12-12 20:01:01] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
07:00:19 (2294410): wrapper (7.7.26015): starting
07:00:19 (2294410): wrapper: running run_atlas (--nthreads 8)
[2025-12-13 07:00:19] Arguments: --nthreads 8
[2025-12-13 07:00:19] Threads: 8
[2025-12-13 07:00:19] This job has been restarted, cleaning up previous attempt
[2025-12-13 07:00:19] Checking for CVMFS
[2025-12-13 07:00:20] Probing /cvmfs/atlas.cern.ch... OK
[2025-12-13 07:00:21] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-12-13 07:00:21] Running cvmfs_config stat atlas.cern.ch
[2025-12-13 07:00: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
[2025-12-13 07:00:23] 2.13.3.0 11561 52805 340140 153959 3 608 30912472 32935937 22741 16776704 0 255172560 99.728 173028062 32349 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2025-12-13 07:00:23] CVMFS is ok
[2025-12-13 07:00:23] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-12-13 07:00:23] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-12-13 07:00:23] Further information can be found at the LHC@home message board.
[2025-12-13 07:00:23] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-12-13 07:00:23] Checking for apptainer binary...
[2025-12-13 07:00:23] Using apptainer found in PATH at /usr/bin/apptainer
[2025-12-13 07:00:23] Running /usr/bin/apptainer --version
[2025-12-13 07:00:24] apptainer version 1.4.5-2.el9
[2025-12-13 07:00:24] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-12-13 07:00:25] c-8-14.aglt2.org
[2025-12-13 07:00:25] apptainer works
[2025-12-13 07:00:25] Set ATHENA_PROC_NUMBER=8
[2025-12-13 07:00:25] Set ATHENA_CORE_NUMBER=8
[2025-12-13 07:00:25] Starting ATLAS job with PandaID=6928768344
[2025-12-13 07:00:25] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-12-13 20:40:32]  *** The last 200 lines of the pilot log: ***
[2025-12-13 20:40:32] 2025-12-14 01:39:58,147 | INFO     | current chi2=3.393476785203891 (change=-0.004395549857026181 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,147 | INFO     | right removable region: 796
[2025-12-13 20:40:32] 2025-12-14 01:39:58,148 | INFO     | sum of square deviations: 156985992925.36978
[2025-12-13 20:40:32] 2025-12-14 01:39:58,176 | INFO     | sum of deviations: 264521867647.6284
[2025-12-13 20:40:32] 2025-12-14 01:39:58,176 | INFO     | mean x: 1765652040.3588457
[2025-12-13 20:40:32] 2025-12-14 01:39:58,176 | INFO     | mean y: 2492222.3789209537
[2025-12-13 20:40:32] 2025-12-14 01:39:58,176 | INFO     | intersect: -2972636746.9527707
[2025-12-13 20:40:32] 2025-12-14 01:39:58,177 | INFO     | chi2: 0.37868067113904014
[2025-12-13 20:40:32] 2025-12-14 01:39:58,178 | INFO     | current chi2=0.37868067113904014 (change=88.84043297753146 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,179 | INFO     | sum of square deviations: 154049644761.07977
[2025-12-13 20:40:32] 2025-12-14 01:39:58,212 | INFO     | time since job start (49109s) is within the limit (174528.0s)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,212 | INFO     | 49116s have passed since pilot start - server update state is 'UPDATING_FINAL'
[2025-12-13 20:40:32] 2025-12-14 01:39:58,215 | INFO     | sum of deviations: 211538441702.95084
[2025-12-13 20:40:32] 2025-12-14 01:39:58,216 | INFO     | mean x: 1765652192.8674242
[2025-12-13 20:40:32] 2025-12-14 01:39:58,216 | INFO     | mean y: 2494971.3042929294
[2025-12-13 20:40:32] 2025-12-14 01:39:58,216 | INFO     | intersect: -2422069616.610534
[2025-12-13 20:40:32] 2025-12-14 01:39:58,223 | INFO     | chi2: 0.22867971180132743
[2025-12-13 20:40:32] 2025-12-14 01:39:58,224 | INFO     | current chi2=0.22867971180132743 (change=39.611464426352214 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,225 | INFO     | sum of square deviations: 151149941355.6417
[2025-12-13 20:40:32] 2025-12-14 01:39:58,263 | INFO     | sum of deviations: 178156104666.28604
[2025-12-13 20:40:32] 2025-12-14 01:39:58,263 | INFO     | mean x: 1765652345.3811944
[2025-12-13 20:40:32] 2025-12-14 01:39:58,263 | INFO     | mean y: 2496729.249047014
[2025-12-13 20:40:32] 2025-12-14 01:39:58,264 | INFO     | intersect: -2078627095.3898993
[2025-12-13 20:40:32] 2025-12-14 01:39:58,265 | INFO     | chi2: 0.1676906304297838
[2025-12-13 20:40:32] 2025-12-14 01:39:58,265 | INFO     | current chi2=0.1676906304297838 (change=26.670088435536325 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,270 | INFO     | sum of square deviations: 148287083461.32095
[2025-12-13 20:40:32] 2025-12-14 01:39:58,299 | INFO     | sum of deviations: 134461397102.32486
[2025-12-13 20:40:32] 2025-12-14 01:39:58,299 | INFO     | mean x: 1765652497.8887467
[2025-12-13 20:40:32] 2025-12-14 01:39:58,299 | INFO     | mean y: 2499056.9232736574
[2025-12-13 20:40:32] 2025-12-14 01:39:58,299 | INFO     | intersect: -1598531161.7690842
[2025-12-13 20:40:32] 2025-12-14 01:39:58,300 | INFO     | chi2: 0.07231082413931075
[2025-12-13 20:40:32] 2025-12-14 01:39:58,300 | INFO     | current chi2=0.07231082413931075 (change=56.87843503600574 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,301 | INFO     | sum of square deviations: 145460883332.6203
[2025-12-13 20:40:32] 2025-12-14 01:39:58,362 | INFO     | sum of deviations: 103616129552.80186
[2025-12-13 20:40:32] 2025-12-14 01:39:58,362 | INFO     | mean x: 1765652650.3886745
[2025-12-13 20:40:32] 2025-12-14 01:39:58,362 | INFO     | mean y: 2500718.4774774774
[2025-12-13 20:40:32] 2025-12-14 01:39:58,362 | INFO     | intersect: -1255226373.3453825
[2025-12-13 20:40:32] 2025-12-14 01:39:58,363 | INFO     | chi2: 0.010546335873634531
[2025-12-13 20:40:32] 2025-12-14 01:39:58,364 | INFO     | current chi2=0.010546335873634531 (change=85.4152735787986 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,365 | INFO     | sum of square deviations: 142670730210.86005
[2025-12-13 20:40:32] 2025-12-14 01:39:58,429 | INFO     | sum of deviations: 99676422480.43002
[2025-12-13 20:40:32] 2025-12-14 01:39:58,430 | INFO     | mean x: 1765652802.8911917
[2025-12-13 20:40:32] 2025-12-14 01:39:58,430 | INFO     | mean y: 2500933.695595855
[2025-12-13 20:40:32] 2025-12-14 01:39:58,430 | INFO     | intersect: -1231066417.3274753
[2025-12-13 20:40:32] 2025-12-14 01:39:58,447 | INFO     | chi2: 0.010298535490833791
[2025-12-13 20:40:32] 2025-12-14 01:39:58,448 | INFO     | current chi2=0.010298535490833791 (change=2.349634847304953 %)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,448 | INFO     | left removable region: 60
[2025-12-13 20:40:32] 2025-12-14 01:39:58,449 | INFO     | sum of square deviations: 123629133772.56
[2025-12-13 20:40:32] 2025-12-14 01:39:58,508 | INFO     | sum of deviations: 94255552517.5625
[2025-12-13 20:40:32] 2025-12-14 01:39:58,526 | INFO     | mean x: 1765653534.8994565
[2025-12-13 20:40:32] 2025-12-14 01:39:58,526 | INFO     | mean y: 2500583.65625
[2025-12-13 20:40:32] 2025-12-14 01:39:58,526 | INFO     | intersect: -1343643681.9235983
[2025-12-13 20:40:32] 2025-12-14 01:39:58,527 | INFO     | chi2: 0.00782121765520346
[2025-12-13 20:40:32] 2025-12-14 01:39:58,528 | INFO     | current memory leak: 0.76 B/s (using 736 data points, chi2=0.01)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | could have reported an average CPU frequency of 2600 MHz (30 samples)
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | ..............................
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | . Timing measurements:
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | . get job = 0 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | . initial setup = 6 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | . payload setup = 48 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,529 | INFO     | . stage-in = 0 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,530 | INFO     | . payload execution = 48950 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,530 | INFO     | . stage-out = 4 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,530 | INFO     | . log creation = 0 s
[2025-12-13 20:40:32] 2025-12-14 01:39:58,530 | INFO     | ..............................
[2025-12-13 20:40:32] 2025-12-14 01:39:59,273 | INFO     | 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,273 | INFO     | job summary report
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | --------------------------------------------------
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | PanDA job id: 6928768344
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | task id: 47886831
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | errors: (none)
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | status: LOG_TRANSFER = DONE 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | pilot state: finished 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | transexitcode: 0
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | exeerrorcode: 0
[2025-12-13 20:40:32] 2025-12-14 01:39:59,275 | INFO     | exeerrordiag: 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | exitcode: 0
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | exitmsg: OK
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | cpuconsumptiontime: 56150 s
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | nevents: 400
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | neventsw: 0
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | pid: 2322206
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | pgrp: 2322206
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | corecount: 8
[2025-12-13 20:40:32] 2025-12-14 01:39:59,276 | INFO     | event service: False
[2025-12-13 20:40:32] 2025-12-14 01:39:59,291 | INFO     | sizes: {0: 2283757, 1: 2283813, 2: 2283869, 3: 2284068, 15: 2284068, 27: 2284096, 30: 2284514, 38: 2284542, 49002: 2329369, 49003: 2329368, 49007: 2338422, 49008: 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,291 | INFO     | --------------------------------------------------
[2025-12-13 20:40:32] 2025-12-14 01:39:59,291 | INFO     | 
[2025-12-13 20:40:32] 2025-12-14 01:39:59,291 | INFO     | executing command: ls -lF /tmp/boinchome/slots/1
[2025-12-13 20:40:32] 2025-12-14 01:39:59,360 | INFO     | queue jobs had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,360 | INFO     | queue payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue data_in had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue data_out had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,361 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,362 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,363 | INFO     | queue completed_jobids has 1 job(s)
[2025-12-13 20:40:32] 2025-12-14 01:39:59,363 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,363 | INFO     | queue messages had 0 job(s) [purged]
[2025-12-13 20:40:32] 2025-12-14 01:39:59,363 | INFO     | job 6928768344 has completed (purged errors)
[2025-12-13 20:40:32] 2025-12-14 01:39:59,363 | INFO     | overall cleanup function is called
[2025-12-13 20:40:32] 2025-12-14 01:40:00,376 | INFO     | --- collectZombieJob: --- 10, [2322206]
[2025-12-13 20:40:32] 2025-12-14 01:40:00,376 | INFO     | zombie collector waiting for pid 2322206
[2025-12-13 20:40:32] 2025-12-14 01:40:00,376 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-12-13 20:40:32] 2025-12-14 01:40:00,376 | INFO     | collected zombie processes
[2025-12-13 20:40:32] 2025-12-14 01:40:00,376 | INFO     | will attempt to kill all subprocesses of pid=2322206
[2025-12-13 20:40:32] 2025-12-14 01:40:00,945 | INFO     | process IDs to be killed: [2322206] (in reverse order)
[2025-12-13 20:40:32] 2025-12-14 01:40:01,098 | WARNING  | found no corresponding commands to process id(s)
[2025-12-13 20:40:32] 2025-12-14 01:40:01,099 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-12-13 20:40:32] 2025-12-14 01:40:01,162 | INFO     | did not find any defunct processes belonging to 2322206
[2025-12-13 20:40:32] 2025-12-14 01:40:01,215 | INFO     | did not find any defunct processes belonging to 2322206
[2025-12-13 20:40:32] 2025-12-14 01:40:01,215 | INFO     | ready for new job
[2025-12-13 20:40:32] 2025-12-14 01:40:01,215 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-12-13 20:40:32] 2025-12-14 01:40:01,233 | INFO     | ***************************************
[2025-12-13 20:40:32] 2025-12-14 01:40:01,234 | INFO     | ***  PanDA Pilot version 3.11.2.19  ***
[2025-12-13 20:40:32] 2025-12-14 01:40:01,234 | INFO     | ***************************************
[2025-12-13 20:40:32] 2025-12-14 01:40:01,234 | INFO     | 
[2025-12-13 20:40:32] 2025-12-14 01:40:01,236 | INFO     | architecture information:
[2025-12-13 20:40:32] 2025-12-14 01:40:01,245 | INFO     | executing command: cat /etc/os-release
[2025-12-13 20:40:32] 2025-12-14 01:40:01,358 | INFO     | cat /etc/os-release:
[2025-12-13 20:40:32] NAME="CentOS Linux"
[2025-12-13 20:40:32] VERSION="7 (Core)"
[2025-12-13 20:40:32] ID="centos"
[2025-12-13 20:40:32] ID_LIKE="rhel fedora"
[2025-12-13 20:40:32] VERSION_ID="7"
[2025-12-13 20:40:32] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-12-13 20:40:32] ANSI_COLOR="0;31"
[2025-12-13 20:40:32] CPE_NAME="cpe:/o:centos:centos:7"
[2025-12-13 20:40:32] HOME_URL="https://www.centos.org/"
[2025-12-13 20:40:32] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-12-13 20:40:32] 
[2025-12-13 20:40:32] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-12-13 20:40:32] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-12-13 20:40:32] REDHAT_SUPPORT_PRODUCT="centos"
[2025-12-13 20:40:32] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-12-13 20:40:32] 
[2025-12-13 20:40:32] 2025-12-14 01:40:01,358 | INFO     | ***************************************
[2025-12-13 20:40:32] 2025-12-14 01:40:01,862 | INFO     | executing command: df -mP /tmp/boinchome/slots/1
[2025-12-13 20:40:32] 2025-12-14 01:40:01,906 | INFO     | sufficient remaining disk space (75587649536 B)
[2025-12-13 20:40:32] 2025-12-14 01:40:01,907 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-12-13 20:40:32] 2025-12-14 01:40:01,907 | INFO     | current server update state: UPDATING_FINAL
[2025-12-13 20:40:32] 2025-12-14 01:40:01,907 | INFO     | update_server=False
[2025-12-13 20:40:32] 2025-12-14 01:40:01,907 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-12-13 20:40:32] 2025-12-14 01:40:01,908 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-12-13 20:40:32] 2025-12-14 01:40:02,198 | INFO     | all data control threads have been joined
[2025-12-13 20:40:32] 2025-12-14 01:40:02,437 | INFO     | all job control threads have been joined
[2025-12-13 20:40:32] 2025-12-14 01:40:02,767 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-12-13 20:40:32] 2025-12-14 01:40:02,767 | INFO     | aborting loop
[2025-12-13 20:40:32] 2025-12-14 01:40:02,914 | INFO     | [job] retrieve thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:02,953 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-12-13 20:40:32] 2025-12-14 01:40:03,029 | INFO     | all payload control threads have been joined
[2025-12-13 20:40:32] 2025-12-14 01:40:03,065 | INFO     | [payload] failed_post thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,088 | INFO     | [job] create_data_payload thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,135 | INFO     | [job] validate thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,204 | INFO     | [data] control thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,287 | INFO     | [payload] execute_payloads thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,443 | INFO     | [job] control thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,731 | INFO     | [data] copytool_in thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,772 | INFO     | [payload] validate_pre thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,773 | INFO     | [job] job monitor thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:03,851 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-12-13 20:40:32] 2025-12-14 01:40:04,035 | INFO     | [payload] control thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:04,288 | INFO     | [payload] run_realtimelog thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:04,355 | INFO     | [payload] validate_post thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:04,857 | INFO     | [job] queue monitor thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:04,960 | INFO     | [data] copytool_out thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:05,917 | INFO     | [data] queue_monitor thread has finished
[2025-12-13 20:40:32] 2025-12-14 01:40:08,803 | INFO     | [monitor] cgroup control has ended
[2025-12-13 20:40:32] 2025-12-14 01:40:09,297 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140404928071488)>', '<ExcThread(monitor, started 140404225734400)>']
[2025-12-13 20:40:32] 2025-12-14 01:40:14,323 | INFO     | all workflow threads have been joined
[2025-12-13 20:40:32] 2025-12-14 01:40:14,327 | INFO     | end of generic workflow (traces error code: 0)
[2025-12-13 20:40:32] 2025-12-14 01:40:14,327 | INFO     | traces error code: 0
[2025-12-13 20:40:32] 2025-12-14 01:40:14,327 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-12-13 20:40:32] 2025-12-14 01:40:31,904 | INFO     | PID=2304570 has CPU usage=3.2% 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
[2025-12-13 20:40:32] 2025-12-14 01:40:31,904 | INFO     | .. there are 35 such processes running
[2025-12-13 20:40:32] 2025-12-14 01:40:31,905 | INFO     | found 0 job(s) in 20 queues
[2025-12-13 20:40:32] 2025-12-14 01:40:31,905 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-12-13 20:40:32] 2025-12-14 01:40:31,905 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-12-13 20:40:32] 2025-12-14 01:40:31,905 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-12-13 20:40:32] 2025-12-14 01:40:31,905 | INFO     | [monitor] control thread has ended
[2025-12-13 20:40:32] 2025-12-14 01:40:32,083 [wrapper] ==== pilot stdout END ====
[2025-12-13 20:40:32] 2025-12-14 01:40:32,086 [wrapper] ==== wrapper stdout RESUME ====
[2025-12-13 20:40:32] 2025-12-14 01:40:32,088 [wrapper] pilotpid: 2304570
[2025-12-13 20:40:32] 2025-12-14 01:40:32,091 [wrapper] Pilot exit status: 0
[2025-12-13 20:40:32] 2025-12-14 01:40:32,216 [wrapper] pandaids: 6928768344 6928768344
[2025-12-13 20:40:32] 2025-12-14 01:40:32,301 [wrapper] cleanup supervisor_pilot  596060 2304571
[2025-12-13 20:40:32] 2025-12-14 01:40:32,308 [wrapper] Test setup, not cleaning
[2025-12-13 20:40:32] 2025-12-14 01:40:32,311 [wrapper] apfmon messages muted
[2025-12-13 20:40:32] 2025-12-14 01:40:32,315 [wrapper] ==== wrapper stdout END ====
[2025-12-13 20:40:32] 2025-12-14 01:40:32,330 [wrapper] ==== wrapper stderr END ====
[2025-12-13 20:40:32]  *** Error codes and diagnostics ***
[2025-12-13 20:40:32]     "exeErrorCode": 0,
[2025-12-13 20:40:32]     "exeErrorDiag": "",
[2025-12-13 20:40:32]     "pilotErrorCode": 0,
[2025-12-13 20:40:32]     "pilotErrorDiag": "",
[2025-12-13 20:40:32]  *** Listing of results directory ***
[2025-12-13 20:40:32] total 531340
[2025-12-13 20:40:32] drwx------. 5 boincer umatlas      4096 Dec  3 09:30 pilot3
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas    579449 Dec 12 18:46 pilot3.tar.gz
[2025-12-13 20:40:32] -rwx------. 1 boincer umatlas     36322 Dec 12 18:48 runpilot2-wrapper.sh
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas      5112 Dec 12 18:48 queuedata.json
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas       100 Dec 12 20:00 wrapper_26015_x86_64-pc-linux-gnu
[2025-12-13 20:40:32] -rwxr-xr-x. 1 boincer umatlas      7986 Dec 12 20:00 run_atlas
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas       105 Dec 12 20:00 job.xml
[2025-12-13 20:40:32] -rw-r--r--. 3 boincer umatlas 191655535 Dec 12 20:00 EVNT.47886829._000011.pool.root.1
[2025-12-13 20:40:32] -rw-r--r--. 3 boincer umatlas 191655535 Dec 12 20:00 ATLAS.root_0
[2025-12-13 20:40:32] -rw-r--r--. 2 boincer umatlas     15847 Dec 12 20:00 start_atlas.sh
[2025-12-13 20:40:32] drwxrwx--x. 2 boincer umatlas      4096 Dec 12 20:00 shared
[2025-12-13 20:40:32] -rw-r--r--. 2 boincer umatlas    592395 Dec 12 20:00 input.tar.gz
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas         0 Dec 12 20:00 boinc_lockfile
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas      2538 Dec 13 07:00 pandaJob.out
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas        57 Dec 13 07:00 setup.sh.local
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas    991728 Dec 13 07:01 agis_schedconf.cvmfs.json
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas 145212783 Dec 13 20:38 HITS.47886831._000251.pool.root.1
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas       531 Dec 13 20:38 boinc_task_state.xml
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas      1051 Dec 13 20:39 memory_monitor_summary.json
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas   1516240 Dec 13 20:39 agis_ddmendpoints.agis.ALL.json
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas    799346 Dec 13 20:39 log.47886831._000251.job.log.tgz.1
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas        96 Dec 13 20:39 pilot_heartbeat.json
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas      7832 Dec 13 20:39 heartbeat.json
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas      6660 Dec 13 20:40 init_data.xml
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas      8192 Dec 13 20:40 boinc_mmap_file
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas        28 Dec 13 20:40 wrapper_checkpoint.txt
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas       823 Dec 13 20:40 pilotlog.txt
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas   5025192 Dec 13 20:40 log.47886831._000251.job.log.1
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas       357 Dec 13 20:40 output.list
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas       620 Dec 13 20:40 runtime_log
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas   5847040 Dec 13 20:40 result.tar.gz
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas      9418 Dec 13 20:40 runtime_log.err
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas       785 Dec 13 20:40 KNNLDmE3Ro8n9Rq4apOajLDm4fhM0noT9bVo0NGKDmLRNKDmVCtGPn.diag
[2025-12-13 20:40:32] -rw-r--r--. 1 boincer umatlas     23346 Dec 13 20:40 stderr.txt
[2025-12-13 20:40:32] HITS file was successfully produced:
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas 145212783 Dec 13 20:38 shared/HITS.pool.root.1
[2025-12-13 20:40:32]  *** Contents of shared directory: ***
[2025-12-13 20:40:32] total 335288
[2025-12-13 20:40:32] -rw-r--r--. 3 boincer umatlas 191655535 Dec 12 20:00 ATLAS.root_0
[2025-12-13 20:40:32] -rw-r--r--. 2 boincer umatlas     15847 Dec 12 20:00 start_atlas.sh
[2025-12-13 20:40:32] -rw-r--r--. 2 boincer umatlas    592395 Dec 12 20:00 input.tar.gz
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas 145212783 Dec 13 20:38 HITS.pool.root.1
[2025-12-13 20:40:32] -rw-------. 1 boincer umatlas   5847040 Dec 13 20:40 result.tar.gz
20:40:34 (2294410): run_atlas exited; CPU time 57906.623491
20:40:34 (2294410): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN