Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
21:13:30 (583839): wrapper (7.7.26015): starting
21:13:30 (583839): wrapper: running run_atlas (--nthreads 4)
[2025-02-23 21:13:30] Arguments: --nthreads 4
[2025-02-23 21:13:30] Threads: 4
[2025-02-23 21:13:30] Checking for CVMFS
[2025-02-23 21:13:30] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-23 21:13:30] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-23 21:13:30] Running cvmfs_config stat atlas.cern.ch
[2025-02-23 21:13:30] 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-02-23 21:13:30] 2.12.6.0 44169 3495 58880 142988 1 55 3444052 4096001 0 130560 0 2482973 99.991 729189 4371 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
[2025-02-23 21:13:30] CVMFS is ok
[2025-02-23 21:13:30] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-23 21:13:30] Small home clusters do not require a local http proxy but it is suggested if
[2025-02-23 21:13:30] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2025-02-23 21:13:30] Further information can be found at the LHC@home message board.
[2025-02-23 21:13:30] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-23 21:13:30] Checking for apptainer binary...
[2025-02-23 21:13:30] which: no apptainer in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin)
[2025-02-23 21:13:30] apptainer is not installed, using version from CVMFS
[2025-02-23 21:13:30] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-23 21:13:30] localhost.localdomain
[2025-02-23 21:13:30] apptainer works
[2025-02-23 21:13:30] Set ATHENA_PROC_NUMBER=4
[2025-02-23 21:13:30] Set ATHENA_CORE_NUMBER=4
[2025-02-23 21:13:30] Starting ATLAS job with PandaID=6523504577
[2025-02-23 21:13:30] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/246 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-24 01:43:16]  *** The last 200 lines of the pilot log: ***
[2025-02-24 01:43:16] 2025-02-24 00:42:56,061 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-02-24 01:43:16] 2025-02-24 00:42:56,064 | INFO     | fitting pss+swap vs Time
[2025-02-24 01:43:16] 2025-02-24 00:42:56,064 | INFO     | model: linear, x: [1740341642.0, 1740341703.0, 1740341764.0, 1740341825.0, 1740341886.0, 1740341947.0, 1740342008.0, 1740342069.0, 1740342130.0, 1740342191.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,065 | INFO     | sum of square deviations: 5770452380.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | sum of deviations: -25733639218.00001
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | mean x: 1740349694.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | mean y: 2449888.573584906
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | -- intersect: 7763631887.713958
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | intersect: 7763631887.713958
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | chi2: 4.331740706179578
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | model: linear, x: [1740341642.0, 1740341703.0, 1740341764.0, 1740341825.0, 1740341886.0, 1740341947.0, 1740342008.0, 1740342069.0, 1740342130.0, 1740342191.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,066 | INFO     | sum of square deviations: 5449944045.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,067 | INFO     | sum of deviations: -9044103847.499987
[2025-02-24 01:43:16] 2025-02-24 00:42:56,067 | INFO     | mean x: 1740349541.5
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | mean y: 2457715.1576923076
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | -- intersect: 2890542777.006247
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | intersect: 2890542777.006247
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | chi2: 3.701401049388169
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | current chi2=3.701401049388169 (change=14.55164792971515 %)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | right removable region: 259
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | model: linear, x: [1740341947.0, 1740342008.0, 1740342069.0, 1740342130.0, 1740342191.0, 1740342252.0, 1740342313.0, 1740342374.0, 1740342435.0, 1740342496.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,068 | INFO     | sum of square deviations: 5449944045.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,069 | INFO     | sum of deviations: -81958662430.00002
[2025-02-24 01:43:16] 2025-02-24 00:42:56,069 | INFO     | mean x: 1740349846.5
[2025-02-24 01:43:16] 2025-02-24 00:42:56,069 | INFO     | mean y: 2476555.2
[2025-02-24 01:43:16] 2025-02-24 00:42:56,069 | INFO     | -- intersect: 26174625186.75459
[2025-02-24 01:43:16] 2025-02-24 00:42:56,070 | INFO     | intersect: 26174625186.75459
[2025-02-24 01:43:16] 2025-02-24 00:42:56,070 | INFO     | chi2: 2.2343891260800537
[2025-02-24 01:43:16] 2025-02-24 00:42:56,070 | INFO     | current chi2=2.2343891260800537 (change=48.4182161944154 %)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,070 | INFO     | model: linear, x: [1740342252.0, 1740342313.0, 1740342374.0, 1740342435.0, 1740342496.0, 1740342557.0, 1740342618.0, 1740342679.0, 1740342740.0, 1740342801.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,070 | INFO     | sum of square deviations: 5141528960.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | sum of deviations: -122471109954.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | mean x: 1740349999.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | mean y: 2496587.011764706
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | -- intersect: 41457596372.343475
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | intersect: 41457596372.343475
[2025-02-24 01:43:16] 2025-02-24 00:42:56,071 | INFO     | chi2: 1.2003189267149206
[2025-02-24 01:43:16] 2025-02-24 00:42:56,072 | INFO     | current chi2=1.2003189267149206 (change=46.27977227848738 %)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,072 | INFO     | model: linear, x: [1740342557.0, 1740342618.0, 1740342679.0, 1740342740.0, 1740342801.0, 1740342862.0, 1740342923.0, 1740342984.0, 1740343045.0, 1740343106.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,072 | INFO     | sum of square deviations: 4844974562.5
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | sum of deviations: -119801970530.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | mean x: 1740350151.5
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | mean y: 2495181.92
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | -- intersect: 43036235580.816895
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | intersect: 43036235580.816895
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | chi2: 1.1724075947847266
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | current chi2=1.1724075947847266 (change=2.3253263202791303 %)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,073 | INFO     | left removable region: 30
[2025-02-24 01:43:16] 2025-02-24 00:42:56,074 | INFO     | model: linear, x: [1740343472.0, 1740343533.0, 1740343594.0, 1740343655.0, 1740343716.0, 1740343777.0, 1740343838.0, 1740343899.0, 1740343960.0, 1740344021.0, 1740
[2025-02-24 01:43:16] 2025-02-24 00:42:56,074 | INFO     | sum of square deviations: 3723716330.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,074 | INFO     | sum of deviations: -67845972171.99999
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | mean x: 1740350426.0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | mean y: 2484678.7205240177
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | -- intersect: 31711604307.584503
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | intersect: 31711604307.584503
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | chi2: 0.44524334252218933
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | -- intersect: 31711604307.584503
[2025-02-24 01:43:16] 2025-02-24 00:42:56,075 | INFO     | current memory leak: -18.22 B/s (using 229 data points, chi2=0.45)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | ..............................
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . Timing measurements:
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . get job = 0 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . initial setup = 1 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . payload setup = 3 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . stage-in = 0 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . payload execution = 16123 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . stage-out = 1 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | . log creation = 0 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,076 | INFO     | ..............................
[2025-02-24 01:43:16] 2025-02-24 00:42:56,123 | INFO     | 
[2025-02-24 01:43:16] 2025-02-24 00:42:56,123 | INFO     | job summary report
[2025-02-24 01:43:16] 2025-02-24 00:42:56,123 | INFO     | --------------------------------------------------
[2025-02-24 01:43:16] 2025-02-24 00:42:56,123 | INFO     | PanDA job id: 6523504577
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | task id: 43205075
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | errors: (none)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | pilot state: finished 
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | transexitcode: 0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | exeerrorcode: 0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | exeerrordiag: 
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | exitcode: 0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | exitmsg: OK
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | cpuconsumptiontime: 59651 s
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | nevents: 400
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | neventsw: 0
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | pid: 594040
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | pgrp: 594040
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | corecount: 4
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | event service: False
[2025-02-24 01:43:16] 2025-02-24 00:42:56,124 | INFO     | sizes: {0: 2383370, 3: 2383576, 11: 2383604, 16130: 2415219, 16131: 2415218, 16133: 2424403, 16143: 2424517}
[2025-02-24 01:43:16] 2025-02-24 00:42:56,125 | INFO     | --------------------------------------------------
[2025-02-24 01:43:16] 2025-02-24 00:42:56,125 | INFO     | 
[2025-02-24 01:43:16] 2025-02-24 00:42:56,125 | INFO     | executing command: ls -lF /var/lib/boinc/slots/246
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,137 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | job 6523504577 has completed (purged errors)
[2025-02-24 01:43:16] 2025-02-24 00:42:56,138 | INFO     | overall cleanup function is called
[2025-02-24 01:43:16] 2025-02-24 00:42:57,144 | INFO     | --- collectZombieJob: --- 10, [594040]
[2025-02-24 01:43:16] 2025-02-24 00:42:57,145 | INFO     | zombie collector waiting for pid 594040
[2025-02-24 01:43:16] 2025-02-24 00:42:57,145 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-24 01:43:16] 2025-02-24 00:42:57,145 | INFO     | collected zombie processes
[2025-02-24 01:43:16] 2025-02-24 00:42:57,145 | INFO     | will attempt to kill all subprocesses of pid=594040
[2025-02-24 01:43:16] 2025-02-24 00:42:57,182 | INFO     | process IDs to be killed: [594040] (in reverse order)
[2025-02-24 01:43:16] 2025-02-24 00:42:57,209 | WARNING  | found no corresponding commands to process id(s)
[2025-02-24 01:43:16] 2025-02-24 00:42:57,209 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-24 01:43:16] 2025-02-24 00:42:57,211 | INFO     | did not find any defunct processes belonging to 594040
[2025-02-24 01:43:16] 2025-02-24 00:42:57,212 | INFO     | did not find any defunct processes belonging to 594040
[2025-02-24 01:43:16] 2025-02-24 00:42:57,212 | INFO     | ready for new job
[2025-02-24 01:43:16] 2025-02-24 00:42:57,212 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-24 01:43:16] 2025-02-24 00:42:57,213 | INFO     | **************************************
[2025-02-24 01:43:16] 2025-02-24 00:42:57,213 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-24 01:43:16] 2025-02-24 00:42:57,213 | INFO     | **************************************
[2025-02-24 01:43:16] 2025-02-24 00:42:57,213 | INFO     | 
[2025-02-24 01:43:16] 2025-02-24 00:42:57,214 | INFO     | pilot is running in a VM
[2025-02-24 01:43:16] 2025-02-24 00:42:57,214 | INFO     | architecture information:
[2025-02-24 01:43:16] 2025-02-24 00:42:57,214 | INFO     | executing command: cat /etc/os-release
[2025-02-24 01:43:16] 2025-02-24 00:42:57,221 | INFO     | cat /etc/os-release:
[2025-02-24 01:43:16] NAME="CentOS Linux"
[2025-02-24 01:43:16] VERSION="7 (Core)"
[2025-02-24 01:43:16] ID="centos"
[2025-02-24 01:43:16] ID_LIKE="rhel fedora"
[2025-02-24 01:43:16] VERSION_ID="7"
[2025-02-24 01:43:16] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-24 01:43:16] ANSI_COLOR="0;31"
[2025-02-24 01:43:16] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-24 01:43:16] HOME_URL="https://www.centos.org/"
[2025-02-24 01:43:16] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-24 01:43:16] 
[2025-02-24 01:43:16] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-24 01:43:16] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-24 01:43:16] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-24 01:43:16] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-24 01:43:16] 
[2025-02-24 01:43:16] 2025-02-24 00:42:57,222 | INFO     | **************************************
[2025-02-24 01:43:16] 2025-02-24 00:42:57,724 | INFO     | executing command: df -mP /var/lib/boinc/slots/246
[2025-02-24 01:43:16] 2025-02-24 00:42:57,735 | INFO     | sufficient remaining disk space (58159267840 B)
[2025-02-24 01:43:16] 2025-02-24 00:42:57,735 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-24 01:43:16] 2025-02-24 00:42:57,735 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-24 01:43:16] 2025-02-24 00:42:57,736 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-24 01:43:16] 2025-02-24 00:42:57,736 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-24 01:43:16] 2025-02-24 00:42:57,736 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-24 01:43:16] 2025-02-24 00:42:57,736 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-24 01:43:16] 2025-02-24 00:42:57,736 | INFO     | aborting loop
[2025-02-24 01:43:16] 2025-02-24 00:42:57,808 | INFO     | all job control threads have been joined
[2025-02-24 01:43:16] 2025-02-24 00:42:57,823 | INFO     | all data control threads have been joined
[2025-02-24 01:43:16] 2025-02-24 00:42:58,211 | INFO     | all payload control threads have been joined
[2025-02-24 01:43:16] 2025-02-24 00:42:58,384 | INFO     | found 0 job(s) in 20 queues
[2025-02-24 01:43:16] 2025-02-24 00:42:58,384 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-24 01:43:16] 2025-02-24 00:42:58,384 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-24 01:43:16] 2025-02-24 00:42:58,737 | INFO     | [job] queue monitor thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,737 | INFO     | [job] job monitor thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,741 | INFO     | [job] retrieve thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,743 | INFO     | [job] create_data_payload thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,812 | INFO     | [job] control thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,829 | INFO     | [data] control thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,970 | INFO     | [payload] validate_pre thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:58,979 | INFO     | [payload] failed_post thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:59,216 | INFO     | [payload] control thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:59,522 | INFO     | [payload] validate_post thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:59,606 | INFO     | [payload] execute_payloads thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:59,742 | INFO     | [data] copytool_out thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:42:59,978 | INFO     | [data] copytool_in thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:43:00,187 | INFO     | [job] validate thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:43:01,742 | INFO     | [data] queue_monitor thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:43:08,611 | INFO     | job.realtimelogging is not enabled
[2025-02-24 01:43:16] 2025-02-24 00:43:09,616 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-24 01:43:16] 2025-02-24 00:43:11,478 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140389300283200)>', '<ExcThread(monitor, started 140388320933632)>']
[2025-02-24 01:43:16] 2025-02-24 00:43:12,454 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-24 01:43:16] 2025-02-24 00:43:12,454 | INFO     | [monitor] control thread has ended
[2025-02-24 01:43:16] 2025-02-24 00:43:16,504 | INFO     | all workflow threads have been joined
[2025-02-24 01:43:16] 2025-02-24 00:43:16,504 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-24 01:43:16] 2025-02-24 00:43:16,504 | INFO     | traces error code: 0
[2025-02-24 01:43:16] 2025-02-24 00:43:16,504 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-24 01:43:16] 2025-02-24 00:43:16,569 [wrapper] ==== pilot stdout END ====
[2025-02-24 01:43:16] 2025-02-24 00:43:16,572 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-24 01:43:16] 2025-02-24 00:43:16,574 [wrapper] pilotpid: 587523
[2025-02-24 01:43:16] 2025-02-24 00:43:16,576 [wrapper] Pilot exit status: 0
[2025-02-24 01:43:16] 2025-02-24 00:43:16,585 [wrapper] pandaids: 6523504577
[2025-02-24 01:43:16] 2025-02-24 00:43:16,604 [wrapper] cleanup supervisor_pilot  622193 587524
[2025-02-24 01:43:16] 2025-02-24 00:43:16,606 [wrapper] Test setup, not cleaning
[2025-02-24 01:43:16] 2025-02-24 00:43:16,611 [wrapper] apfmon messages muted
[2025-02-24 01:43:16] 2025-02-24 00:43:16,612 [wrapper] ==== wrapper stdout END ====
[2025-02-24 01:43:16] 2025-02-24 00:43:16,615 [wrapper] ==== wrapper stderr END ====
[2025-02-24 01:43:16]  *** Error codes and diagnostics ***
[2025-02-24 01:43:16]     "exeErrorCode": 0,
[2025-02-24 01:43:16]     "exeErrorDiag": "",
[2025-02-24 01:43:16]     "pilotErrorCode": 0,
[2025-02-24 01:43:16]     "pilotErrorDiag": "",
[2025-02-24 01:43:16]  *** Listing of results directory ***
[2025-02-24 01:43:16] total 661172
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc    491065 Feb 23 02:31 pilot3.tar.gz
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc      5118 Feb 23 02:37 queuedata.json
[2025-02-24 01:43:16] -rwx------. 1 boinc boinc     35865 Feb 23 02:38 runpilot2-wrapper.sh
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc       100 Feb 23 21:13 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-24 01:43:16] -rwxr-xr-x. 1 boinc boinc      7986 Feb 23 21:13 run_atlas
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc       105 Feb 23 21:13 job.xml
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc      6162 Feb 23 21:13 init_data.xml
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc 344646463 Feb 23 21:13 EVNT.43092757._001070.pool.root.1
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc     17569 Feb 23 21:13 start_atlas.sh
[2025-02-24 01:43:16] drwxrwx--x. 2 boinc boinc        68 Feb 23 21:13 shared
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc    503553 Feb 23 21:13 input.tar.gz
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc         0 Feb 23 21:13 boinc_lockfile
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc      2555 Feb 23 21:13 pandaJob.out
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc       424 Feb 23 21:13 setup.sh.local
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc    987744 Feb 23 21:13 agis_schedconf.cvmfs.json
[2025-02-24 01:43:16] drwx------. 4 boinc boinc      4096 Feb 23 21:13 pilot3
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc 324599961 Feb 24 01:42 HITS.43205075._059558.pool.root.1
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc       531 Feb 24 01:42 boinc_task_state.xml
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc        95 Feb 24 01:42 pilot_heartbeat.json
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc      1023 Feb 24 01:42 memory_monitor_summary.json
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc   1582569 Feb 24 01:42 agis_ddmendpoints.agis.ALL.json
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc    368958 Feb 24 01:42 log.43205075._059558.job.log.tgz.1
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc      8192 Feb 24 01:42 boinc_mmap_file
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc        28 Feb 24 01:42 wrapper_checkpoint.txt
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc      7726 Feb 24 01:42 heartbeat.json
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc      4351 Feb 24 01:43 pilotlog.txt
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc   1626462 Feb 24 01:43 log.43205075._059558.job.log.1
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc       357 Feb 24 01:43 output.list
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc       620 Feb 24 01:43 runtime_log
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc   2017280 Feb 24 01:43 result.tar.gz
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc       662 Feb 24 01:43 UsAODmh7F66nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm1ruKDmLrXW3n.diag
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc     11053 Feb 24 01:43 runtime_log.err
[2025-02-24 01:43:16] -rw-r--r--. 1 boinc boinc     21629 Feb 24 01:43 stderr.txt
[2025-02-24 01:43:16] HITS file was successfully produced:
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc 324599961 Feb 24 01:42 shared/HITS.pool.root.1
[2025-02-24 01:43:16]  *** Contents of shared directory: ***
[2025-02-24 01:43:16] total 656052
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc 344646463 Feb 23 21:13 ATLAS.root_0
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc     17569 Feb 23 21:13 start_atlas.sh
[2025-02-24 01:43:16] -rw-r--r--. 2 boinc boinc    503553 Feb 23 21:13 input.tar.gz
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc 324599961 Feb 24 01:42 HITS.pool.root.1
[2025-02-24 01:43:16] -rw-------. 1 boinc boinc   2017280 Feb 24 01:43 result.tar.gz
01:43:17 (583839): run_atlas exited; CPU time 59628.875208
01:43:17 (583839): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN