Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
00:03:31 (2105954): wrapper (7.7.26015): starting
00:03:31 (2105954): wrapper: running run_atlas (--nthreads 8)
[2026-02-20 00:03:31] Arguments: --nthreads 8
[2026-02-20 00:03:31] Threads: 8
[2026-02-20 00:03:31] Checking for CVMFS
[2026-02-20 00:03:32] Probing /cvmfs/atlas.cern.ch... OK
[2026-02-20 00:03:32] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-02-20 00:03:32] Running cvmfs_config stat atlas.cern.ch
[2026-02-20 00:03:33] 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-02-20 00:03:33] 2.13.3.0 8602 153359 654688 156435 2 168 14517239 21042177 21866 16776704 0 553508213 99.395 832395600 33066 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2026-02-20 00:03:33] CVMFS is ok
[2026-02-20 00:03:33] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-02-20 00:03:33] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-02-20 00:03:33] Further information can be found at the LHC@home message board.
[2026-02-20 00:03:33] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-02-20 00:03:33] Checking for apptainer binary...
[2026-02-20 00:03:33] Using apptainer found in PATH at /usr/bin/apptainer
[2026-02-20 00:03:33] Running /usr/bin/apptainer --version
[2026-02-20 00:03:33] apptainer version 1.4.5-2.el9
[2026-02-20 00:03:33] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-02-20 00:03:35] c-16-16.aglt2.org
[2026-02-20 00:03:35] apptainer works
[2026-02-20 00:03:35] Set ATHENA_PROC_NUMBER=8
[2026-02-20 00:03:35] Set ATHENA_CORE_NUMBER=8
[2026-02-20 00:03:35] Starting ATLAS job with PandaID=7021129885
[2026-02-20 00:03:35] 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
00:20:07 (2105954): BOINC client no longer exists - exiting
00:20:07 (2105954): timer handler: client dead, exiting
00:31:53 (2217856): wrapper (7.7.26015): starting
00:31:53 (2217856): wrapper: running run_atlas (--nthreads 8)
[2026-02-20 00:31:54] Arguments: --nthreads 8
[2026-02-20 00:31:54] Threads: 8
[2026-02-20 00:31:54] This job has been restarted, cleaning up previous attempt
[2026-02-20 00:31:54] Checking for CVMFS
[2026-02-20 00:31:55] Probing /cvmfs/atlas.cern.ch... OK
[2026-02-20 00:31:55] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-02-20 00:31:55] Running cvmfs_config stat atlas.cern.ch
[2026-02-20 00:31:56] 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-02-20 00:31:56] 2.13.3.0 8602 153388 654888 156437 2 160 16528356 21042176 19675 16776704 0 553637021 99.395 832623453 33070 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2026-02-20 00:31:56] CVMFS is ok
[2026-02-20 00:31:56] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-02-20 00:31:56] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-02-20 00:31:56] Further information can be found at the LHC@home message board.
[2026-02-20 00:31:56] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-02-20 00:31:56] Checking for apptainer binary...
[2026-02-20 00:31:56] Using apptainer found in PATH at /usr/bin/apptainer
[2026-02-20 00:31:56] Running /usr/bin/apptainer --version
[2026-02-20 00:31:56] apptainer version 1.4.5-2.el9
[2026-02-20 00:31:56] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-02-20 00:31:56] c-16-16.aglt2.org
[2026-02-20 00:31:56] apptainer works
[2026-02-20 00:31:56] Set ATHENA_PROC_NUMBER=8
[2026-02-20 00:31:56] Set ATHENA_CORE_NUMBER=8
[2026-02-20 00:31:57] Starting ATLAS job with PandaID=7021129885
[2026-02-20 00:31:57] 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-02-22 18:03:48]  *** The last 200 lines of the pilot log: ***
[2026-02-22 18:03:48] 2026-02-22 22:16:02,676 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:05,389 | INFO     | monitor loop #9881: job 0:7021129885 is in state 'finished'
[2026-02-22 18:03:48] 2026-02-22 22:16:05,390 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:05,508 | INFO     | sum of deviations: 4510782161349.404
[2026-02-22 18:03:48] 2026-02-22 22:16:05,515 | INFO     | mean x: 1771681934.7164962
[2026-02-22 18:03:48] 2026-02-22 22:16:05,515 | INFO     | mean y: 2578312.0013113036
[2026-02-22 18:03:48] 2026-02-22 22:16:05,516 | INFO     | intersect: -462324875.27690303
[2026-02-22 18:03:48] 2026-02-22 22:16:05,525 | INFO     | chi2: 4.1205055155230585
[2026-02-22 18:03:48] 2026-02-22 22:16:05,526 | INFO     | current chi2=4.1205055155230585 (change=25.119606469528478 %)
[2026-02-22 18:03:48] 2026-02-22 22:16:05,535 | INFO     | sum of square deviations: 17122433389340.828
[2026-02-22 18:03:48] 2026-02-22 22:16:08,044 | INFO     | monitor loop #9882: job 0:7021129885 is in state 'finished'
[2026-02-22 18:03:48] 2026-02-22 22:16:08,044 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:08,566 | INFO     | PID=2235872 has CPU usage=12.5% 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 
[2026-02-22 18:03:48] 2026-02-22 22:16:08,567 | INFO     | .. there are 43 such processes running
[2026-02-22 18:03:48] 2026-02-22 22:16:08,960 | INFO     | sum of deviations: 4502277073597.335
[2026-02-22 18:03:48] 2026-02-22 22:16:08,961 | INFO     | mean x: 1771681782.2169118
[2026-02-22 18:03:48] 2026-02-22 22:16:08,961 | INFO     | mean y: 2578292.7962184874
[2026-02-22 18:03:48] 2026-02-22 22:16:08,961 | INFO     | intersect: -463278521.38481474
[2026-02-22 18:03:48] 2026-02-22 22:16:08,966 | INFO     | chi2: 4.120440725004226
[2026-02-22 18:03:48] 2026-02-22 22:16:08,966 | INFO     | current chi2=4.120440725004226 (change=0.0015723924792382118 %)
[2026-02-22 18:03:48] 2026-02-22 22:16:08,966 | INFO     | right removable region: 3807
[2026-02-22 18:03:48] 2026-02-22 22:16:08,972 | INFO     | sum of square deviations: 17189967328214.982
[2026-02-22 18:03:48] 2026-02-22 22:16:09,602 | INFO     | time since job start (232987s) is within the limit (349056.0s)
[2026-02-22 18:03:48] 2026-02-22 22:16:10,691 | INFO     | monitor loop #9883: job 0:7021129885 is in state 'finished'
[2026-02-22 18:03:48] 2026-02-22 22:16:10,691 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:10,958 | INFO     | sum of deviations: 2836080650596.7803
[2026-02-22 18:03:48] 2026-02-22 22:16:10,958 | INFO     | mean x: 1771682239.716234
[2026-02-22 18:03:48] 2026-02-22 22:16:10,958 | INFO     | mean y: 2579865.5866771573
[2026-02-22 18:03:48] 2026-02-22 22:16:10,966 | INFO     | intersect: -289720499.1044138
[2026-02-22 18:03:48] 2026-02-22 22:16:10,971 | INFO     | chi2: 2.2999592725729254
[2026-02-22 18:03:48] 2026-02-22 22:16:10,971 | INFO     | current chi2=2.2999592725729254 (change=58.20370709722111 %)
[2026-02-22 18:03:48] 2026-02-22 22:16:10,977 | INFO     | sum of square deviations: 17122431219632.242
[2026-02-22 18:03:48] 2026-02-22 22:16:11,643 | INFO     | time since job start (232989s) is within the limit (349056.0s)
[2026-02-22 18:03:48] 2026-02-22 22:16:13,406 | INFO     | monitor loop #9884: job 0:7021129885 is in state 'finished'
[2026-02-22 18:03:48] 2026-02-22 22:16:13,406 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:13,452 | INFO     | sum of deviations: 2354501131684.2812
[2026-02-22 18:03:48] 2026-02-22 22:16:13,452 | INFO     | mean x: 1771682392.216649
[2026-02-22 18:03:48] 2026-02-22 22:16:13,480 | INFO     | mean y: 2580952.8093487397
[2026-02-22 18:03:48] 2026-02-22 22:16:13,480 | INFO     | intersect: -241042639.188284
[2026-02-22 18:03:48] 2026-02-22 22:16:13,544 | INFO     | chi2: 1.7502235330229756
[2026-02-22 18:03:48] 2026-02-22 22:16:13,544 | INFO     | current chi2=1.7502235330229756 (change=23.901977139576466 %)
[2026-02-22 18:03:48] 2026-02-22 22:16:13,544 | INFO     | left removable region: 20
[2026-02-22 18:03:48] 2026-02-22 22:16:13,557 | INFO     | sum of square deviations: 16840713871096.357
[2026-02-22 18:03:48] 2026-02-22 22:16:13,675 | INFO     | time since job start (232991s) is within the limit (349056.0s)
[2026-02-22 18:03:48] 2026-02-22 22:16:15,726 | INFO     | time since job start (232993s) is within the limit (349056.0s)
[2026-02-22 18:03:48] 2026-02-22 22:16:16,005 | INFO     | monitor loop #9885: job 0:7021129885 is in state 'finished'
[2026-02-22 18:03:48] 2026-02-22 22:16:16,006 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-02-22 18:03:48] 2026-02-22 22:16:16,434 | INFO     | sum of deviations: 2391277431377.9844
[2026-02-22 18:03:48] 2026-02-22 22:16:16,434 | INFO     | mean x: 1771682361.7182467
[2026-02-22 18:03:48] 2026-02-22 22:16:16,434 | INFO     | mean y: 2583075.64853446
[2026-02-22 18:03:48] 2026-02-22 22:16:16,455 | INFO     | intersect: -248984885.16211268
[2026-02-22 18:03:48] 2026-02-22 22:16:16,506 | INFO     | chi2: 0.14314417032593663
[2026-02-22 18:03:48] 2026-02-22 22:16:16,507 | INFO     | current memory leak: 0.14 B/s (using 3787 data points, chi2=0.14)
[2026-02-22 18:03:48] 2026-02-22 22:16:16,545 | INFO     | could have reported an average CPU frequency of 2900 MHz (131 samples)
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | ..............................
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | . Timing measurements:
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | . get job = 1 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | . initial setup = 2 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | . payload setup = 41 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,546 | INFO     | . stage-in = 0 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,547 | INFO     | . payload execution = 232905 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,547 | INFO     | . stage-out = 13 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,547 | INFO     | . log creation = 6 s
[2026-02-22 18:03:48] 2026-02-22 22:16:16,547 | INFO     | ..............................
[2026-02-22 18:03:48] 2026-02-22 22:16:17,759 | INFO     | time since job start (232995s) is within the limit (349056.0s)
[2026-02-22 18:03:48] 2026-02-22 22:16:17,948 | INFO     | 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,948 | INFO     | job summary report
[2026-02-22 18:03:48] 2026-02-22 22:16:17,948 | INFO     | --------------------------------------------------
[2026-02-22 18:03:48] 2026-02-22 22:16:17,948 | INFO     | PanDA job id: 7021129885
[2026-02-22 18:03:48] 2026-02-22 22:16:17,948 | INFO     | task id: 48508763
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | errors: (none)
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | status: LOG_TRANSFER = DONE 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | pilot state: finished 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | transexitcode: 0
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | exeerrorcode: 0
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | exeerrordiag: 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,949 | INFO     | exitcode: 0
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | exitmsg: OK
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | cpuconsumptiontime: 117362 s
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | nevents: 400
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | neventsw: 0
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | pid: 2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | pgrp: 2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:17,950 | INFO     | corecount: 8
[2026-02-22 18:03:48] 2026-02-22 22:16:17,951 | INFO     | event service: False
[2026-02-22 18:03:48] 2026-02-22 22:16:17,951 | INFO     | sizes: {0: 2281171, 1: 2281772, 2: 2281856, 3: 2281884, 4: 2281884, 5: 2282345, 6: 2282529, 7: 2282557, 232952: 2406601, 232967: 2415599, 232968: 2415655, 232988: 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,951 | INFO     | --------------------------------------------------
[2026-02-22 18:03:48] 2026-02-22 22:16:17,951 | INFO     | 
[2026-02-22 18:03:48] 2026-02-22 22:16:17,951 | INFO     | executing command: ls -lF /tmp/boinchome/slots/2
[2026-02-22 18:03:48] 2026-02-22 22:16:18,185 | INFO     | queue jobs had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,185 | INFO     | queue payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,185 | INFO     | queue data_in had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue data_out had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue current_data_in had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,186 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,187 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,188 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,188 | INFO     | queue completed_jobids has 1 job(s)
[2026-02-22 18:03:48] 2026-02-22 22:16:18,188 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,188 | INFO     | queue messages had 0 job(s) [purged]
[2026-02-22 18:03:48] 2026-02-22 22:16:18,225 | INFO     | job 7021129885 has completed (purged errors)
[2026-02-22 18:03:48] 2026-02-22 22:16:18,225 | INFO     | overall cleanup function is called
[2026-02-22 18:03:48] 2026-02-22 22:16:19,260 | INFO     | --- collectZombieJob: --- 10, [2249330]
[2026-02-22 18:03:48] 2026-02-22 22:16:19,260 | INFO     | zombie collector waiting for pid 2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:19,260 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2026-02-22 18:03:48] 2026-02-22 22:16:19,260 | INFO     | collected zombie processes
[2026-02-22 18:03:48] 2026-02-22 22:16:19,260 | INFO     | will attempt to kill all subprocesses of pid=2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:22,553 | INFO     | process IDs to be killed: [2249330] (in reverse order)
[2026-02-22 18:03:48] 2026-02-22 22:16:25,857 | WARNING  | found no corresponding commands to process id(s)
[2026-02-22 18:03:48] 2026-02-22 22:16:25,857 | INFO     | Do not look for orphan processes in BOINC jobs
[2026-02-22 18:03:48] 2026-02-22 22:16:26,129 | INFO     | did not find any defunct processes belonging to 2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:26,366 | INFO     | did not find any defunct processes belonging to 2249330
[2026-02-22 18:03:48] 2026-02-22 22:16:26,366 | INFO     | ready for new job
[2026-02-22 18:03:48] 2026-02-22 22:16:26,366 | INFO     | pilot has finished with previous job - re-establishing logging
[2026-02-22 18:03:48] 2026-02-22 22:16:26,420 | INFO     | **************************************
[2026-02-22 18:03:48] 2026-02-22 22:16:26,421 | INFO     | ***  PanDA Pilot version 3.11.4.1  ***
[2026-02-22 18:03:48] 2026-02-22 22:16:26,421 | INFO     | **************************************
[2026-02-22 18:03:48] 2026-02-22 22:16:26,421 | INFO     | 
[2026-02-22 18:03:48] 2026-02-22 22:16:26,423 | INFO     | architecture information:
[2026-02-22 18:03:48] 2026-02-22 22:16:26,424 | INFO     | executing command: cat /etc/os-release
[2026-02-22 18:03:48] 2026-02-22 22:16:26,558 | INFO     | cat /etc/os-release:
[2026-02-22 18:03:48] NAME="CentOS Linux"
[2026-02-22 18:03:48] VERSION="7 (Core)"
[2026-02-22 18:03:48] ID="centos"
[2026-02-22 18:03:48] ID_LIKE="rhel fedora"
[2026-02-22 18:03:48] VERSION_ID="7"
[2026-02-22 18:03:48] PRETTY_NAME="CentOS Linux 7 (Core)"
[2026-02-22 18:03:48] ANSI_COLOR="0;31"
[2026-02-22 18:03:48] CPE_NAME="cpe:/o:centos:centos:7"
[2026-02-22 18:03:48] HOME_URL="https://www.centos.org/"
[2026-02-22 18:03:48] BUG_REPORT_URL="https://bugs.centos.org/"
[2026-02-22 18:03:48] 
[2026-02-22 18:03:48] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2026-02-22 18:03:48] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2026-02-22 18:03:48] REDHAT_SUPPORT_PRODUCT="centos"
[2026-02-22 18:03:48] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2026-02-22 18:03:48] 
[2026-02-22 18:03:48] 2026-02-22 22:16:26,558 | INFO     | **************************************
[2026-02-22 18:03:48] 2026-02-22 22:16:27,068 | INFO     | executing command: df -mP /tmp/boinchome/slots/2
[2026-02-22 18:03:48] 2026-02-22 22:16:27,141 | INFO     | sufficient remaining disk space (49369055232 B)
[2026-02-22 18:03:48] 2026-02-22 22:16:27,141 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2026-02-22 18:03:48] 2026-02-22 22:16:27,142 | INFO     | current server update state: UPDATING_FINAL
[2026-02-22 18:03:48] 2026-02-22 22:16:27,142 | INFO     | update_server=False
[2026-02-22 18:03:48] 2026-02-22 22:16:27,142 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2026-02-22 18:03:48] 2026-02-22 22:16:27,142 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2026-02-22 18:03:48] 2026-02-22 22:16:27,143 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2026-02-22 18:03:48] 2026-02-22 22:16:27,302 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2026-02-22 18:03:48] 2026-02-22 22:16:27,302 | INFO     | aborting loop
[2026-02-22 18:03:48] 2026-02-22 22:16:27,468 | INFO     | all payload control threads have been joined
[2026-02-22 18:03:48] 2026-02-22 22:16:27,800 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2026-02-22 18:03:48] 2026-02-22 22:16:27,954 | INFO     | all data control threads have been joined
[2026-02-22 18:03:48] 2026-02-22 22:16:28,148 | INFO     | [job] retrieve thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,158 | INFO     | [job] queue monitor thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,180 | INFO     | all job control threads have been joined
[2026-02-22 18:03:48] 2026-02-22 22:16:28,244 | INFO     | [payload] execute_payloads thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,307 | INFO     | [job] create_data_payload thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,308 | INFO     | [job] job monitor thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,492 | INFO     | [payload] control thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,828 | INFO     | [payload] run_realtimelog thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,961 | INFO     | [data] control thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:28,969 | INFO     | [data] copytool_in thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,150 | INFO     | [data] copytool_out thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,188 | INFO     | [job] control thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,229 | INFO     | [job] validate thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,258 | INFO     | [payload] validate_post thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,398 | INFO     | [payload] validate_pre thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:29,608 | INFO     | [payload] failed_post thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:31,841 | INFO     | [data] queue_monitor thread has finished
[2026-02-22 18:03:48] 2026-02-22 22:16:55,932 | INFO     | [monitor] cgroup control has ended
[2026-02-22 18:03:48] 2026-02-22 22:16:56,991 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139885373736768)>', '<ExcThread(monitor, started 139884643731200)>']
[2026-02-22 18:03:48] 2026-02-22 22:16:59,497 | INFO     | PID=2235872 has CPU usage=6.6% 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-02-22 18:03:48] 2026-02-22 22:16:59,497 | INFO     | .. there are 43 such processes running
[2026-02-22 18:03:48] 2026-02-22 22:16:59,546 | INFO     | found 0 job(s) in 20 queues
[2026-02-22 18:03:48] 2026-02-22 22:16:59,546 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2026-02-22 18:03:48] 2026-02-22 22:16:59,546 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2026-02-22 18:03:48] 2026-02-22 22:16:59,546 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2026-02-22 18:03:48] 2026-02-22 22:16:59,546 | INFO     | [monitor] control thread has ended
[2026-02-22 18:03:48] 2026-02-22 22:17:02,023 | INFO     | all workflow threads have been joined
[2026-02-22 18:03:48] 2026-02-22 22:17:02,023 | INFO     | end of generic workflow (traces error code: 0)
[2026-02-22 18:03:48] 2026-02-22 22:17:02,023 | INFO     | traces error code: 0
[2026-02-22 18:03:48] 2026-02-22 22:17:02,024 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2026-02-22 18:03:48] 2026-02-22 22:17:03,540 [wrapper] ==== pilot stdout END ====
[2026-02-22 18:03:48] 2026-02-22 22:17:03,544 [wrapper] ==== wrapper stdout RESUME ====
[2026-02-22 18:03:48] 2026-02-22 22:17:03,547 [wrapper] pilotpid: 2235872
[2026-02-22 18:03:48] 2026-02-22 22:17:03,550 [wrapper] Pilot exit status: 0
[2026-02-22 18:03:48] 2026-02-22 22:17:03,571 [wrapper] pandaids: 7021129885 7021129885
[2026-02-22 18:03:48] 2026-02-22 22:17:03,675 [wrapper] cleanup supervisor_pilot 2089509 2235873
[2026-02-22 18:03:48] 2026-02-22 22:17:03,681 [wrapper] Test setup, not cleaning
[2026-02-22 18:03:48] 2026-02-22 22:17:03,684 [wrapper] apfmon messages muted
[2026-02-22 18:03:48] 2026-02-22 22:17:03,687 [wrapper] ==== wrapper stdout END ====
[2026-02-22 18:03:48] 2026-02-22 22:17:03,690 [wrapper] ==== wrapper stderr END ====
[2026-02-22 18:03:48]  *** Error codes and diagnostics ***
[2026-02-22 18:03:48]     "exeErrorCode": 0,
[2026-02-22 18:03:48]     "exeErrorDiag": "",
[2026-02-22 18:03:48]     "pilotErrorCode": 0,
[2026-02-22 18:03:48]     "pilotErrorDiag": "",
[2026-02-22 18:03:48]  *** Listing of results directory ***
[2026-02-22 18:03:48] total 1646980
[2026-02-22 18:03:48] drwx------. 5 boincer umatlas      4096 Feb  2 10:00 pilot3
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas      5111 Feb 19 16:53 queuedata.json
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas    584627 Feb 19 16:53 pilot3.tar.gz
[2026-02-22 18:03:48] -rwx------. 1 boincer umatlas     36322 Feb 19 16:54 runpilot2-wrapper.sh
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas       100 Feb 20 00:03 wrapper_26015_x86_64-pc-linux-gnu
[2026-02-22 18:03:48] -rwxr-xr-x. 1 boincer umatlas      7986 Feb 20 00:03 run_atlas
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas       105 Feb 20 00:03 job.xml
[2026-02-22 18:03:48] -rw-r--r--. 3 boincer umatlas 675984462 Feb 20 00:03 EVNT.48508760._000975.pool.root.1
[2026-02-22 18:03:48] -rw-r--r--. 3 boincer umatlas 675984462 Feb 20 00:03 ATLAS.root_0
[2026-02-22 18:03:48] -rw-r--r--. 2 boincer umatlas     15845 Feb 20 00:03 start_atlas.sh
[2026-02-22 18:03:48] drwxrwx--x. 2 boincer umatlas      4096 Feb 20 00:03 shared
[2026-02-22 18:03:48] -rw-r--r--. 2 boincer umatlas    597951 Feb 20 00:03 input.tar.gz
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas         0 Feb 20 00:03 boinc_lockfile
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas      2552 Feb 20 00:31 pandaJob.out
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas        57 Feb 20 00:31 setup.sh.local
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas   1001567 Feb 20 00:33 agis_schedconf.cvmfs.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas       434 Feb 20 00:33 workernode_map.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas 278197489 Feb 22 17:13 HITS.48508763._050997.pool.root.1
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas       532 Feb 22 17:13 boinc_task_state.xml
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas      1044 Feb 22 17:15 memory_monitor_summary.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas   1513015 Feb 22 17:15 agis_ddmendpoints.agis.ALL.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas   2772398 Feb 22 17:15 log.48508763._050997.job.log.tgz.1
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas      6391 Feb 22 17:16 heartbeat.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas        96 Feb 22 17:16 pilot_heartbeat.json
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas      4820 Feb 22 17:17 pilotlog.txt
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas  23426267 Feb 22 17:17 log.48508763._050997.job.log.1
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas       357 Feb 22 17:17 output.list
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas       620 Feb 22 17:17 runtime_log
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas  26214400 Feb 22 17:17 result.tar.gz
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas      9423 Feb 22 17:17 runtime_log.err
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas       785 Feb 22 17:17 mTENDmFARD9nsSi4ap6QjLDmwznN0nGgGQJmIVkRDmFfyKDmwKZi4m.diag
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas      6524 Feb 22 18:02 init_data.xml
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas        28 Feb 22 18:03 wrapper_checkpoint.txt
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas      8192 Feb 22 18:03 boinc_mmap_file
[2026-02-22 18:03:48] -rw-r--r--. 1 boincer umatlas     24003 Feb 22 18:03 stderr.txt
[2026-02-22 18:03:48] HITS file was successfully produced:
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas 278197489 Feb 22 17:13 shared/HITS.pool.root.1
[2026-02-22 18:03:48]  *** Contents of shared directory: ***
[2026-02-22 18:03:48] total 958032
[2026-02-22 18:03:48] -rw-r--r--. 3 boincer umatlas 675984462 Feb 20 00:03 ATLAS.root_0
[2026-02-22 18:03:48] -rw-r--r--. 2 boincer umatlas     15845 Feb 20 00:03 start_atlas.sh
[2026-02-22 18:03:48] -rw-r--r--. 2 boincer umatlas    597951 Feb 20 00:03 input.tar.gz
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas 278197489 Feb 22 17:13 HITS.pool.root.1
[2026-02-22 18:03:48] -rw-------. 1 boincer umatlas  26214400 Feb 22 17:17 result.tar.gz
18:03:50 (2217856): run_atlas exited; CPU time 131211.022102
18:03:50 (2217856): called boinc_finish(0)

</stderr_txt>
]]>

©2026 CERN