Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
23:25:51 (809917): wrapper (7.7.26015): starting
23:25:51 (809917): wrapper: running run_atlas (--nthreads 8)
[2025-10-12 23:25:51] Arguments: --nthreads 8
[2025-10-12 23:25:51] Threads: 8
[2025-10-12 23:25:51] Checking for CVMFS
[2025-10-12 23:25:52] Probing /cvmfs/atlas.cern.ch... OK
[2025-10-12 23:25:52] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-10-12 23:25:52] Running cvmfs_config stat atlas.cern.ch
[2025-10-12 23:25:54] 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-10-12 23:25:54] 2.13.2.0 2754702 130142 429724 151647 3 600 27704254 32935937 63664 16776704 0 854068987 99.693 691119489 33192 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2025-10-12 23:25:54] CVMFS is ok
[2025-10-12 23:25:54] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-10-12 23:25:54] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-10-12 23:25:54] Further information can be found at the LHC@home message board.
[2025-10-12 23:25:54] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-10-12 23:25:54] Checking for apptainer binary...
[2025-10-12 23:25:54] Using apptainer found in PATH at /usr/bin/apptainer
[2025-10-12 23:25:54] Running /usr/bin/apptainer --version
[2025-10-12 23:25:54] apptainer version 1.4.3-1.el9
[2025-10-12 23:25:54] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-10-12 23:25:54] c7-9-14.aglt2.org
[2025-10-12 23:25:54] apptainer works
[2025-10-12 23:25:55] Set ATHENA_PROC_NUMBER=8
[2025-10-12 23:25:55] Set ATHENA_CORE_NUMBER=8
[2025-10-12 23:25:55] Starting ATLAS job with PandaID=6840749795
[2025-10-12 23:25:55] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/8 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
00:20:12 (809917): BOINC client no longer exists - exiting
00:20:12 (809917): timer handler: client dead, exiting
00:22:33 (1696395): wrapper (7.7.26015): starting
00:22:33 (1696395): wrapper: running run_atlas (--nthreads 9)
[2025-10-13 00:22:33] Arguments: --nthreads 9
[2025-10-13 00:22:33] Threads: 9
[2025-10-13 00:22:33] This job has been restarted, cleaning up previous attempt
[2025-10-13 00:22:33] Checking for CVMFS
[2025-10-13 00:22:33] Probing /cvmfs/atlas.cern.ch... OK
[2025-10-13 00:22:33] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-10-13 00:22:33] Running cvmfs_config stat atlas.cern.ch
[2025-10-13 00:22:34] 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-10-13 00:22:34] 2.13.2.0 2754702 130199 398128 151649 3 238 17268812 32935937 60041 16776704 0 855109879 99.693 692865840 33183 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1
[2025-10-13 00:22:34] CVMFS is ok
[2025-10-13 00:22:34] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-10-13 00:22:34] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-10-13 00:22:34] Further information can be found at the LHC@home message board.
[2025-10-13 00:22:34] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-10-13 00:22:34] Checking for apptainer binary...
[2025-10-13 00:22:34] Using apptainer found in PATH at /usr/bin/apptainer
[2025-10-13 00:22:34] Running /usr/bin/apptainer --version
[2025-10-13 00:22:34] apptainer version 1.4.3-1.el9
[2025-10-13 00:22:34] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-10-13 00:22:34] c7-9-14.aglt2.org
[2025-10-13 00:22:34] apptainer works
[2025-10-13 00:22:34] Set ATHENA_PROC_NUMBER=9
[2025-10-13 00:22:34] Set ATHENA_CORE_NUMBER=9
[2025-10-13 00:22:34] Starting ATLAS job with PandaID=6840749795
[2025-10-13 00:22:34] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/8 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-10-13 03:25:16]  *** The last 200 lines of the pilot log: ***
[2025-10-13 03:25:17] 2025-10-13 07:24:21,577 | WARNING  | GPU info not found in prmon json: 'gpu'
[2025-10-13 03:25:17] 2025-10-13 07:24:21,577 | WARNING  | format EVNTtoHITS has no such key: dbData
[2025-10-13 03:25:17] 2025-10-13 07:24:21,577 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-10-13 03:25:17] 2025-10-13 07:24:21,581 | INFO     | fitting pss+swap vs Time
[2025-10-13 03:25:17] 2025-10-13 07:24:21,581 | INFO     | sum of square deviations: 1748719546.449437
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | sum of deviations: 17465952383.764038
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | mean x: 1760334810.516854
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | mean y: 2155283.0786516853
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | -- intersect: -17579808641.551537
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | intersect: -17579808641.551537
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | chi2: 2.233437631234586
[2025-10-13 03:25:17] 2025-10-13 07:24:21,582 | INFO     | sum of square deviations: 1605452658.9479809
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | sum of deviations: 28473192353.578026
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | mean x: 1760334658.0173411
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | mean y: 2166753.4739884394
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | -- intersect: -31217905071.778
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | intersect: -31217905071.778
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | chi2: 1.4532687976862706
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | current chi2=1.4532687976862706 (change=34.931301534355285 %)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,583 | INFO     | sum of square deviations: 1470232433.9464278
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | sum of deviations: 27676345088.357147
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | mean x: 1760334505.517857
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | mean y: 2165857.214285714
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | -- intersect: -33135196726.25188
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | intersect: -33135196726.25188
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | chi2: 1.452450370745755
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | current chi2=1.452450370745755 (change=0.056316281049906214 %)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | right removable region: 167
[2025-10-13 03:25:17] 2025-10-13 07:24:21,584 | INFO     | sum of square deviations: 1605461441.9768791
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | sum of deviations: -7369966988.890173
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | mean x: 1760334963.0115607
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | mean y: 2181478.445086705
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | -- intersect: 8083104649.548715
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | intersect: 8083104649.548715
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | chi2: 0.8633680011734072
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | current chi2=0.8633680011734072 (change=61.34353656895447 %)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,585 | INFO     | sum of square deviations: 1470239691.9761908
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | sum of deviations: -10392974845.047619
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | mean x: 1760335115.5119047
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | mean y: 2184889.523809524
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | -- intersect: 12445814778.04779
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | intersect: 12445814778.04779
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | chi2: 0.8468465442050416
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | current chi2=0.8468465442050416 (change=1.9136054319723705 %)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,590 | INFO     | left removable region: 20
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | sum of square deviations: 984932109.9727925
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | sum of deviations: -1572657578.7551014
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | mean x: 1760335085.0136054
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | mean y: 2201053.8775510206
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | -- intersect: 2812957536.039175
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | intersect: 2812957536.039175
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | chi2: 0.04095483544898637
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | -- intersect: 2812957536.039175
[2025-10-13 03:25:17] 2025-10-13 07:24:21,591 | INFO     | current memory leak: -1.60 B/s (using 147 data points, chi2=0.04)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | could have reported an average CPU frequency of 3794 MHz (9 samples)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | ..............................
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . Timing measurements:
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . get job = 0 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . initial setup = 1 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . payload setup = 9 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . stage-in = 0 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . payload execution = 10821 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . stage-out = 4 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | . log creation = 0 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,592 | INFO     | ..............................
[2025-10-13 03:25:17] 2025-10-13 07:24:21,742 | INFO     | 
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | job summary report
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | --------------------------------------------------
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | PanDA job id: 6840749795
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | task id: 46676269
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | errors: (none)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | status: LOG_TRANSFER = DONE 
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | pilot state: finished 
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | transexitcode: 0
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | exeerrorcode: 0
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | exeerrordiag: 
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | exitcode: 0
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | exitmsg: OK
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | cpuconsumptiontime: 23163 s
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | nevents: 400
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | neventsw: 0
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | pid: 1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | pgrp: 1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | corecount: 9
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | event service: False
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | sizes: {0: 2348855, 7: 2349117, 11: 2349145, 10836: 2378122, 10841: 2387120, 10842: 2387176, 10874: 2387562}
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | --------------------------------------------------
[2025-10-13 03:25:17] 2025-10-13 07:24:21,743 | INFO     | 
[2025-10-13 03:25:17] 2025-10-13 07:24:21,744 | INFO     | executing command: ls -lF /tmp/boinchome/slots/8
[2025-10-13 03:25:17] 2025-10-13 07:24:21,793 | INFO     | queue jobs had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue data_in had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue data_out had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue completed_jobids has 1 job(s)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | queue messages had 0 job(s) [purged]
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | job 6840749795 has completed (purged errors)
[2025-10-13 03:25:17] 2025-10-13 07:24:21,794 | INFO     | overall cleanup function is called
[2025-10-13 03:25:17] 2025-10-13 07:24:22,804 | INFO     | --- collectZombieJob: --- 10, [1848601]
[2025-10-13 03:25:17] 2025-10-13 07:24:22,805 | INFO     | zombie collector waiting for pid 1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:22,805 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-10-13 03:25:17] 2025-10-13 07:24:22,805 | INFO     | collected zombie processes
[2025-10-13 03:25:17] 2025-10-13 07:24:22,805 | INFO     | will attempt to kill all subprocesses of pid=1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:24,009 | INFO     | process IDs to be killed: [1848601] (in reverse order)
[2025-10-13 03:25:17] 2025-10-13 07:24:24,341 | WARNING  | found no corresponding commands to process id(s)
[2025-10-13 03:25:17] 2025-10-13 07:24:24,341 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-10-13 03:25:17] 2025-10-13 07:24:24,481 | INFO     | did not find any defunct processes belonging to 1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:24,622 | INFO     | did not find any defunct processes belonging to 1848601
[2025-10-13 03:25:17] 2025-10-13 07:24:24,622 | INFO     | ready for new job
[2025-10-13 03:25:17] 2025-10-13 07:24:24,622 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-10-13 03:25:17] 2025-10-13 07:24:24,624 | INFO     | ***************************************
[2025-10-13 03:25:17] 2025-10-13 07:24:24,624 | INFO     | ***  PanDA Pilot version 3.11.0.29  ***
[2025-10-13 03:25:17] 2025-10-13 07:24:24,624 | INFO     | ***************************************
[2025-10-13 03:25:17] 2025-10-13 07:24:24,624 | INFO     | 
[2025-10-13 03:25:17] 2025-10-13 07:24:24,658 | INFO     | architecture information:
[2025-10-13 03:25:17] 2025-10-13 07:24:24,665 | INFO     | executing command: cat /etc/os-release
[2025-10-13 03:25:17] 2025-10-13 07:24:24,699 | INFO     | cat /etc/os-release:
[2025-10-13 03:25:17] NAME="CentOS Linux"
[2025-10-13 03:25:17] VERSION="7 (Core)"
[2025-10-13 03:25:17] ID="centos"
[2025-10-13 03:25:17] ID_LIKE="rhel fedora"
[2025-10-13 03:25:17] VERSION_ID="7"
[2025-10-13 03:25:17] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-10-13 03:25:17] ANSI_COLOR="0;31"
[2025-10-13 03:25:17] CPE_NAME="cpe:/o:centos:centos:7"
[2025-10-13 03:25:17] HOME_URL="https://www.centos.org/"
[2025-10-13 03:25:17] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-10-13 03:25:17] 
[2025-10-13 03:25:17] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-10-13 03:25:17] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-10-13 03:25:17] REDHAT_SUPPORT_PRODUCT="centos"
[2025-10-13 03:25:17] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-10-13 03:25:17] 
[2025-10-13 03:25:17] 2025-10-13 07:24:24,700 | INFO     | ***************************************
[2025-10-13 03:25:17] 2025-10-13 07:24:25,204 | INFO     | executing command: df -mP /tmp/boinchome/slots/8
[2025-10-13 03:25:17] 2025-10-13 07:24:25,320 | INFO     | sufficient remaining disk space (67205332992 B)
[2025-10-13 03:25:17] 2025-10-13 07:24:25,320 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-10-13 03:25:17] 2025-10-13 07:24:25,320 | INFO     | current server update state: UPDATING_FINAL
[2025-10-13 03:25:17] 2025-10-13 07:24:25,320 | INFO     | update_server=False
[2025-10-13 03:25:17] 2025-10-13 07:24:25,320 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-10-13 03:25:17] 2025-10-13 07:24:25,321 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-10-13 03:25:17] 2025-10-13 07:24:25,322 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-10-13 03:25:17] 2025-10-13 07:24:25,323 | INFO     | aborting loop
[2025-10-13 03:25:17] 2025-10-13 07:24:25,841 | INFO     | all data control threads have been joined
[2025-10-13 03:25:17] 2025-10-13 07:24:26,327 | INFO     | [job] retrieve thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:26,329 | INFO     | [job] job monitor thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:26,578 | INFO     | [payload] run_realtimelog thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:26,691 | INFO     | [payload] failed_post thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:26,761 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-10-13 03:25:17] 2025-10-13 07:24:26,793 | INFO     | all payload control threads have been joined
[2025-10-13 03:25:17] 2025-10-13 07:24:26,848 | INFO     | [data] control thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:26,988 | INFO     | all job control threads have been joined
[2025-10-13 03:25:17] 2025-10-13 07:24:27,050 | INFO     | [payload] validate_pre thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,050 | INFO     | [job] validate thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,080 | INFO     | [payload] execute_payloads thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,103 | INFO     | [payload] validate_post thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,293 | INFO     | [data] copytool_in thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,328 | INFO     | [data] copytool_out thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,363 | INFO     | [job] create_data_payload thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,638 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-10-13 03:25:17] 2025-10-13 07:24:27,767 | INFO     | [job] queue monitor thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,801 | INFO     | [payload] control thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:27,994 | INFO     | [job] control thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:31,646 | INFO     | [data] queue_monitor thread has finished
[2025-10-13 03:25:17] 2025-10-13 07:24:54,993 | INFO     | PID=1751939 has CPU usage=3.3% 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-10-13 03:25:17] 2025-10-13 07:24:54,994 | INFO     | .. there are 71 such processes running
[2025-10-13 03:25:17] 2025-10-13 07:24:54,994 | INFO     | found 0 job(s) in 20 queues
[2025-10-13 03:25:17] 2025-10-13 07:24:54,994 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-10-13 03:25:17] 2025-10-13 07:24:54,994 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-10-13 03:25:17] 2025-10-13 07:25:09,983 | INFO     | [monitor] cgroup control has ended
[2025-10-13 03:25:17] 2025-10-13 07:25:10,621 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139862173353792)>', '<ExcThread(monitor, started 139861105305344)>']
[2025-10-13 03:25:17] 2025-10-13 07:25:11,115 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-10-13 03:25:17] 2025-10-13 07:25:11,116 | INFO     | [monitor] control thread has ended
[2025-10-13 03:25:17] 2025-10-13 07:25:15,646 | INFO     | all workflow threads have been joined
[2025-10-13 03:25:17] 2025-10-13 07:25:15,647 | INFO     | end of generic workflow (traces error code: 0)
[2025-10-13 03:25:17] 2025-10-13 07:25:15,649 | INFO     | traces error code: 0
[2025-10-13 03:25:17] 2025-10-13 07:25:15,649 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-10-13 03:25:17] 2025-10-13 07:25:16,118 [wrapper] ==== pilot stdout END ====
[2025-10-13 03:25:17] 2025-10-13 07:25:16,121 [wrapper] ==== wrapper stdout RESUME ====
[2025-10-13 03:25:17] 2025-10-13 07:25:16,123 [wrapper] pilotpid: 1751939
[2025-10-13 03:25:17] 2025-10-13 07:25:16,125 [wrapper] Pilot exit status: 0
[2025-10-13 03:25:17] 2025-10-13 07:25:16,169 [wrapper] pandaids: 6840749795 6840749795
[2025-10-13 03:25:17] 2025-10-13 07:25:16,343 [wrapper] cleanup supervisor_pilot  692721 1751940
[2025-10-13 03:25:17] 2025-10-13 07:25:16,361 [wrapper] Test setup, not cleaning
[2025-10-13 03:25:17] 2025-10-13 07:25:16,381 [wrapper] apfmon messages muted
[2025-10-13 03:25:17] 2025-10-13 07:25:16,426 [wrapper] ==== wrapper stdout END ====
[2025-10-13 03:25:17] 2025-10-13 07:25:16,437 [wrapper] ==== wrapper stderr END ====
[2025-10-13 03:25:17]  *** Error codes and diagnostics ***
[2025-10-13 03:25:17]     "exeErrorCode": 0,
[2025-10-13 03:25:17]     "exeErrorDiag": "",
[2025-10-13 03:25:17]     "pilotErrorCode": 0,
[2025-10-13 03:25:17]     "pilotErrorDiag": "",
[2025-10-13 03:25:17]  *** Listing of results directory ***
[2025-10-13 03:25:17] total 635528
[2025-10-13 03:25:17] drwx------. 5 boincer umatlas      4096 Oct  7 03:00 pilot3
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas    557409 Oct 12 16:55 pilot3.tar.gz
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      5112 Oct 12 16:56 queuedata.json
[2025-10-13 03:25:17] -rwx------. 1 boincer umatlas     36292 Oct 12 16:56 runpilot2-wrapper.sh
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas       100 Oct 12 23:25 wrapper_26015_x86_64-pc-linux-gnu
[2025-10-13 03:25:17] -rwxr-xr-x. 1 boincer umatlas      7986 Oct 12 23:25 run_atlas
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas       105 Oct 12 23:25 job.xml
[2025-10-13 03:25:17] -rw-r--r--. 3 boincer umatlas 223462713 Oct 12 23:25 EVNT.46676267._004759.pool.root.1
[2025-10-13 03:25:17] -rw-r--r--. 3 boincer umatlas 223462713 Oct 12 23:25 ATLAS.root_0
[2025-10-13 03:25:17] -rw-r--r--. 2 boincer umatlas     15120 Oct 12 23:25 start_atlas.sh
[2025-10-13 03:25:17] drwxrwx--x. 2 boincer umatlas      4096 Oct 12 23:25 shared
[2025-10-13 03:25:17] -rw-r--r--. 2 boincer umatlas    569682 Oct 12 23:25 input.tar.gz
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas         0 Oct 12 23:25 boinc_lockfile
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      2549 Oct 13 00:22 pandaJob.out
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas    974365 Oct 13 00:22 agis_schedconf.cvmfs.json
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      7161 Oct 13 03:21 init_data.xml
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas 196540334 Oct 13 03:22 HITS.46676269._089223.pool.root.1
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas       530 Oct 13 03:22 boinc_task_state.xml
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas      1041 Oct 13 03:23 memory_monitor_summary.json
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas   1560580 Oct 13 03:23 agis_ddmendpoints.agis.ALL.json
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas    406871 Oct 13 03:23 log.46676269._089223.job.log.tgz.1
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas      7788 Oct 13 03:24 heartbeat.json
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas        96 Oct 13 03:24 pilot_heartbeat.json
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      8192 Oct 13 03:25 boinc_mmap_file
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas        28 Oct 13 03:25 wrapper_checkpoint.txt
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas      4824 Oct 13 03:25 pilotlog.txt
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas   1307451 Oct 13 03:25 log.46676269._089223.job.log.1
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas       357 Oct 13 03:25 output.list
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas       620 Oct 13 03:25 runtime_log
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas   1730560 Oct 13 03:25 result.tar.gz
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      8784 Oct 13 03:25 runtime_log.err
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas       781 Oct 13 03:25 MU2NDmjIIS8n9Rq4apOajLDm4fhM0noT9bVof3QYDmp1UMDmlnkUkm.diag
[2025-10-13 03:25:17] -rw-r--r--. 1 boincer umatlas      4416 Oct 13 03:25 stderr.txt
[2025-10-13 03:25:17] HITS file was successfully produced:
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas 196540334 Oct 13 03:22 shared/HITS.pool.root.1
[2025-10-13 03:25:17]  *** Contents of shared directory: ***
[2025-10-13 03:25:17] total 412436
[2025-10-13 03:25:17] -rw-r--r--. 3 boincer umatlas 223462713 Oct 12 23:25 ATLAS.root_0
[2025-10-13 03:25:17] -rw-r--r--. 2 boincer umatlas     15120 Oct 12 23:25 start_atlas.sh
[2025-10-13 03:25:17] -rw-r--r--. 2 boincer umatlas    569682 Oct 12 23:25 input.tar.gz
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas 196540334 Oct 13 03:22 HITS.pool.root.1
[2025-10-13 03:25:17] -rw-------. 1 boincer umatlas   1730560 Oct 13 03:25 result.tar.gz
03:25:19 (1696395): run_atlas exited; CPU time 23510.551806
03:25:19 (1696395): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN