Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
02:12:22 (30653): wrapper (7.7.26015): starting
02:12:22 (30653): wrapper: running run_atlas (--nthreads 8)
[2025-02-26 02:12:22] Arguments: --nthreads 8
[2025-02-26 02:12:22] Threads: 8
[2025-02-26 02:12:22] Checking for CVMFS
[2025-02-26 02:12:22] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-26 02:12:22] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-26 02:12:22] Running cvmfs_config stat atlas.cern.ch
[2025-02-26 02:12:22] 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-26 02:12:22] 2.11.2.0 2736 85074 110052 143065 2 1 10575619 20275200 1 130560 0 20870562 99.955 8047302 34412 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-02-26 02:12:22] CVMFS is ok
[2025-02-26 02:12:22] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-26 02:12:22] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-26 02:12:22] Further information can be found at the LHC@home message board.
[2025-02-26 02:12:22] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-26 02:12:22] Checking for apptainer binary...
[2025-02-26 02:12:22] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-26 02:12:22] Running /usr/bin/apptainer --version
[2025-02-26 02:12:22] apptainer version 1.3.2-1.el7
[2025-02-26 02:12:22] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-26 02:12:24] c-204-37.aglt2.org
[2025-02-26 02:12:24] apptainer works
[2025-02-26 02:12:24] Set ATHENA_PROC_NUMBER=8
[2025-02-26 02:12:24] Set ATHENA_CORE_NUMBER=8
[2025-02-26 02:12:24] Starting ATLAS job with PandaID=6530424312
[2025-02-26 02:12:24] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-26 04:23:53]  *** The last 200 lines of the pilot log: ***
[2025-02-26 04:23:53] 2025-02-26 09:23:33,877 | INFO     | chi2: 0.3785151187547688
[2025-02-26 04:23:53] 2025-02-26 09:23:33,877 | INFO     | current chi2=0.3785151187547688 (change=86.10339458531128 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,877 | INFO     | model: linear, x: [1740554604.0, 1740554665.0, 1740554726.0, 1740554787.0, 1740554848.0, 1740554909.0, 1740554970.0, 1740555031.0, 1740555092.0, 1740555153.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,877 | INFO     | sum of square deviations: 509440249.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,878 | INFO     | sum of deviations: -4723130417.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,878 | INFO     | mean x: 1740558172.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,878 | INFO     | mean y: 2538722.754237288
[2025-02-26 04:23:53] 2025-02-26 09:23:33,878 | INFO     | -- intersect: 16139628903.656725
[2025-02-26 04:23:53] 2025-02-26 09:23:33,879 | INFO     | intersect: 16139628903.656725
[2025-02-26 04:23:53] 2025-02-26 09:23:33,879 | INFO     | chi2: 0.057289817798368656
[2025-02-26 04:23:53] 2025-02-26 09:23:33,879 | INFO     | current chi2=0.057289817798368656 (change=84.86458929650168 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,879 | INFO     | model: linear, x: [1740554909.0, 1740554970.0, 1740555031.0, 1740555092.0, 1740555153.0, 1740555214.0, 1740555275.0, 1740555336.0, 1740555397.0, 1740555458.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,879 | INFO     | sum of square deviations: 447383272.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,880 | INFO     | sum of deviations: -991281231.9999998
[2025-02-26 04:23:53] 2025-02-26 09:23:33,880 | INFO     | mean x: 1740558325.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,880 | INFO     | mean y: 2529526.238938053
[2025-02-26 04:23:53] 2025-02-26 09:23:33,880 | INFO     | -- intersect: 3859139526.5651364
[2025-02-26 04:23:53] 2025-02-26 09:23:33,880 | INFO     | intersect: 3859139526.5651364
[2025-02-26 04:23:53] 2025-02-26 09:23:33,881 | INFO     | chi2: 0.029702827931312105
[2025-02-26 04:23:53] 2025-02-26 09:23:33,881 | INFO     | current chi2=0.029702827931312105 (change=48.153390824437395 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,881 | INFO     | model: linear, x: [1740555214.0, 1740555275.0, 1740555336.0, 1740555397.0, 1740555458.0, 1740555519.0, 1740555580.0, 1740555641.0, 1740555702.0, 1740555763.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,881 | INFO     | sum of square deviations: 390582207.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | sum of deviations: 1289744807.5000002
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | mean x: 1740558477.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | mean y: 2523538.824074074
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | -- intersect: -5744989323.44446
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | intersect: -5744989323.44446
[2025-02-26 04:23:53] 2025-02-26 09:23:33,882 | INFO     | chi2: 0.00030343328641504054
[2025-02-26 04:23:53] 2025-02-26 09:23:33,883 | INFO     | current chi2=0.00030343328641504054 (change=98.97843637273618 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,883 | INFO     | model: linear, x: [1740555519.0, 1740555580.0, 1740555641.0, 1740555702.0, 1740555763.0, 1740555824.0, 1740555885.0, 1740555946.0, 1740556007.0, 1740556068.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,883 | INFO     | sum of square deviations: 338804492.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,883 | INFO     | sum of deviations: 878122755.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | mean x: 1740558630.0
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | mean y: 2524748.5533980583
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | -- intersect: -4508702745.486514
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | intersect: -4508702745.486514
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | chi2: 9.136097646514102e-05
[2025-02-26 04:23:53] 2025-02-26 09:23:33,884 | INFO     | current chi2=9.136097646514102e-05 (change=69.89091818351922 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,885 | INFO     | model: linear, x: [1740555824.0, 1740555885.0, 1740555946.0, 1740556007.0, 1740556068.0, 1740556129.0, 1740556190.0, 1740556251.0, 1740556312.0, 1740556373.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,885 | INFO     | sum of square deviations: 291817564.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,885 | INFO     | sum of deviations: 729294314.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,885 | INFO     | mean x: 1740558782.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,885 | INFO     | mean y: 2525229.8061224488
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | -- intersect: -4347382995.578618
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | intersect: -4347382995.578618
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | chi2: 8.67984525860572e-05
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | current chi2=8.67984525860572e-05 (change=4.993952621363083 %)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | left removable region: 60
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | model: linear, x: [1740557654.0, 1740557715.0, 1740557776.0, 1740557837.0, 1740557898.0, 1740557959.0, 1740558020.0, 1740558081.0, 1740558142.0, 1740558203.0, 1740
[2025-02-26 04:23:53] 2025-02-26 09:23:33,886 | INFO     | sum of square deviations: 73882315.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | sum of deviations: 188592388.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | mean x: 1740559514.5
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | mean y: 2527509.2419354836
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | -- intersect: -4440433894.234318
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | intersect: -4440433894.234318
[2025-02-26 04:23:53] 2025-02-26 09:23:33,887 | INFO     | chi2: 7.613156406649771e-05
[2025-02-26 04:23:53] 2025-02-26 09:23:33,888 | INFO     | -- intersect: -4440433894.234318
[2025-02-26 04:23:53] 2025-02-26 09:23:33,888 | INFO     | current memory leak: 2.55 B/s (using 62 data points, chi2=0.00)
[2025-02-26 04:23:53] 2025-02-26 09:23:33,888 | INFO     | ..............................
[2025-02-26 04:23:53] 2025-02-26 09:23:33,888 | INFO     | . Timing measurements:
[2025-02-26 04:23:53] 2025-02-26 09:23:33,888 | INFO     | . get job = 0 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . initial setup = 2 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . payload setup = 9 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . stage-in = 0 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . payload execution = 7810 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . stage-out = 0 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | . log creation = 0 s
[2025-02-26 04:23:53] 2025-02-26 09:23:33,889 | INFO     | ..............................
[2025-02-26 04:23:53] 2025-02-26 09:23:34,057 | INFO     | 
[2025-02-26 04:23:53] 2025-02-26 09:23:34,057 | INFO     | job summary report
[2025-02-26 04:23:53] 2025-02-26 09:23:34,057 | INFO     | --------------------------------------------------
[2025-02-26 04:23:53] 2025-02-26 09:23:34,057 | INFO     | PanDA job id: 6530424312
[2025-02-26 04:23:53] 2025-02-26 09:23:34,058 | INFO     | task id: 43401137
[2025-02-26 04:23:53] 2025-02-26 09:23:34,058 | INFO     | errors: (none)
[2025-02-26 04:23:53] 2025-02-26 09:23:34,058 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-26 04:23:53] 2025-02-26 09:23:34,058 | INFO     | pilot state: finished 
[2025-02-26 04:23:53] 2025-02-26 09:23:34,058 | INFO     | transexitcode: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:34,059 | INFO     | exeerrorcode: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:34,059 | INFO     | exeerrordiag: 
[2025-02-26 04:23:53] 2025-02-26 09:23:34,059 | INFO     | exitcode: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:34,059 | INFO     | exitmsg: OK
[2025-02-26 04:23:53] 2025-02-26 09:23:34,060 | INFO     | cpuconsumptiontime: 56455 s
[2025-02-26 04:23:53] 2025-02-26 09:23:34,060 | INFO     | nevents: 400
[2025-02-26 04:23:53] 2025-02-26 09:23:34,060 | INFO     | neventsw: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:34,060 | INFO     | pid: 8528
[2025-02-26 04:23:53] 2025-02-26 09:23:34,061 | INFO     | pgrp: 8528
[2025-02-26 04:23:53] 2025-02-26 09:23:34,061 | INFO     | corecount: 8
[2025-02-26 04:23:53] 2025-02-26 09:23:34,061 | INFO     | event service: False
[2025-02-26 04:23:53] 2025-02-26 09:23:34,061 | INFO     | sizes: {0: 2370286, 1: 2370428, 7: 2370634, 11: 2370662, 7824: 2398050, 7825: 2406991, 7827: 2407175, 7835: 2407345}
[2025-02-26 04:23:53] 2025-02-26 09:23:34,062 | INFO     | --------------------------------------------------
[2025-02-26 04:23:53] 2025-02-26 09:23:34,062 | INFO     | 
[2025-02-26 04:23:53] 2025-02-26 09:23:34,062 | INFO     | executing command: ls -lF /tmp/boinchome/slots/0
[2025-02-26 04:23:53] 2025-02-26 09:23:34,088 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,089 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,089 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,089 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,089 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,090 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,090 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,090 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,090 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,090 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,091 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,091 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,091 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,091 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,091 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,092 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,092 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,092 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-26 04:23:53] 2025-02-26 09:23:34,092 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,092 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-26 04:23:53] 2025-02-26 09:23:34,093 | INFO     | job 6530424312 has completed (purged errors)
[2025-02-26 04:23:53] 2025-02-26 09:23:34,093 | INFO     | overall cleanup function is called
[2025-02-26 04:23:53] 2025-02-26 09:23:34,186 | INFO     | PID=1923 has CPU usage=6.9% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR -
[2025-02-26 04:23:53] 2025-02-26 09:23:35,102 | INFO     | --- collectZombieJob: --- 10, [8528]
[2025-02-26 04:23:53] 2025-02-26 09:23:35,102 | INFO     | zombie collector waiting for pid 8528
[2025-02-26 04:23:53] 2025-02-26 09:23:35,102 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-26 04:23:53] 2025-02-26 09:23:35,102 | INFO     | collected zombie processes
[2025-02-26 04:23:53] 2025-02-26 09:23:35,103 | INFO     | will attempt to kill all subprocesses of pid=8528
[2025-02-26 04:23:53] 2025-02-26 09:23:35,173 | INFO     | process IDs to be killed: [8528] (in reverse order)
[2025-02-26 04:23:53] 2025-02-26 09:23:35,228 | WARNING  | found no corresponding commands to process id(s)
[2025-02-26 04:23:53] 2025-02-26 09:23:35,228 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-26 04:23:53] 2025-02-26 09:23:35,232 | INFO     | did not find any defunct processes belonging to 8528
[2025-02-26 04:23:53] 2025-02-26 09:23:35,236 | INFO     | did not find any defunct processes belonging to 8528
[2025-02-26 04:23:53] 2025-02-26 09:23:35,237 | INFO     | ready for new job
[2025-02-26 04:23:53] 2025-02-26 09:23:35,237 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-26 04:23:53] 2025-02-26 09:23:35,239 | INFO     | **************************************
[2025-02-26 04:23:53] 2025-02-26 09:23:35,239 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-26 04:23:53] 2025-02-26 09:23:35,239 | INFO     | **************************************
[2025-02-26 04:23:53] 2025-02-26 09:23:35,239 | INFO     | 
[2025-02-26 04:23:53] 2025-02-26 09:23:35,240 | INFO     | architecture information:
[2025-02-26 04:23:53] 2025-02-26 09:23:35,241 | INFO     | executing command: cat /etc/os-release
[2025-02-26 04:23:53] 2025-02-26 09:23:35,257 | INFO     | cat /etc/os-release:
[2025-02-26 04:23:53] NAME="CentOS Linux"
[2025-02-26 04:23:53] VERSION="7 (Core)"
[2025-02-26 04:23:53] ID="centos"
[2025-02-26 04:23:53] ID_LIKE="rhel fedora"
[2025-02-26 04:23:53] VERSION_ID="7"
[2025-02-26 04:23:53] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-26 04:23:53] ANSI_COLOR="0;31"
[2025-02-26 04:23:53] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-26 04:23:53] HOME_URL="https://www.centos.org/"
[2025-02-26 04:23:53] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-26 04:23:53] 
[2025-02-26 04:23:53] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-26 04:23:53] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-26 04:23:53] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-26 04:23:53] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-26 04:23:53] 
[2025-02-26 04:23:53] 2025-02-26 09:23:35,258 | INFO     | **************************************
[2025-02-26 04:23:53] 2025-02-26 09:23:35,761 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2025-02-26 04:23:53] 2025-02-26 09:23:35,780 | INFO     | sufficient remaining disk space (18553503744 B)
[2025-02-26 04:23:53] 2025-02-26 09:23:35,780 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-26 04:23:53] 2025-02-26 09:23:35,781 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-26 04:23:53] 2025-02-26 09:23:35,781 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-26 04:23:53] 2025-02-26 09:23:35,990 | INFO     | all data control threads have been joined
[2025-02-26 04:23:53] 2025-02-26 09:23:36,187 | INFO     | found 0 job(s) in 20 queues
[2025-02-26 04:23:53] 2025-02-26 09:23:36,187 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-26 04:23:53] 2025-02-26 09:23:36,187 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-26 04:23:53] 2025-02-26 09:23:36,249 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-26 04:23:53] 2025-02-26 09:23:36,618 | INFO     | all payload control threads have been joined
[2025-02-26 04:23:53] 2025-02-26 09:23:36,630 | INFO     | all job control threads have been joined
[2025-02-26 04:23:53] 2025-02-26 09:23:36,667 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-26 04:23:53] 2025-02-26 09:23:36,667 | INFO     | aborting loop
[2025-02-26 04:23:53] 2025-02-26 09:23:36,786 | INFO     | [job] retrieve thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:36,787 | INFO     | [job] queue monitor thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:36,903 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-26 04:23:53] 2025-02-26 09:23:36,995 | INFO     | [data] control thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,054 | INFO     | [job] create_data_payload thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,441 | INFO     | [payload] validate_pre thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,579 | INFO     | [data] copytool_in thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,624 | INFO     | [payload] control thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,636 | INFO     | [job] control thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,673 | INFO     | [job] job monitor thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:37,741 | INFO     | [payload] failed_post thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:38,258 | INFO     | [job] validate thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:38,280 | INFO     | [payload] execute_payloads thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:38,308 | INFO     | [payload] validate_post thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:38,909 | INFO     | [data] copytool_out thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:40,256 | INFO     | [data] queue_monitor thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:45,916 | INFO     | job.realtimelogging is not enabled
[2025-02-26 04:23:53] 2025-02-26 09:23:46,918 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-26 04:23:53] 2025-02-26 09:23:47,890 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140650632734528)>', '<ExcThread(monitor, started 140649374414592)>']
[2025-02-26 04:23:53] 2025-02-26 09:23:48,233 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-26 04:23:53] 2025-02-26 09:23:48,233 | INFO     | [monitor] control thread has ended
[2025-02-26 04:23:53] 2025-02-26 09:23:52,891 | INFO     | all workflow threads have been joined
[2025-02-26 04:23:53] 2025-02-26 09:23:52,891 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-26 04:23:53] 2025-02-26 09:23:52,892 | INFO     | traces error code: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:52,892 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-26 04:23:53] 2025-02-26 09:23:53,010 [wrapper] ==== pilot stdout END ====
[2025-02-26 04:23:53] 2025-02-26 09:23:53,015 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-26 04:23:53] 2025-02-26 09:23:53,020 [wrapper] pilotpid: 1923
[2025-02-26 04:23:53] 2025-02-26 09:23:53,024 [wrapper] Pilot exit status: 0
[2025-02-26 04:23:53] 2025-02-26 09:23:53,044 [wrapper] pandaids: 6530424312
[2025-02-26 04:23:53] 2025-02-26 09:23:53,088 [wrapper] cleanup supervisor_pilot 28856 1924
[2025-02-26 04:23:53] 2025-02-26 09:23:53,093 [wrapper] Test setup, not cleaning
[2025-02-26 04:23:53] 2025-02-26 09:23:53,102 [wrapper] apfmon messages muted
[2025-02-26 04:23:53] 2025-02-26 09:23:53,107 [wrapper] ==== wrapper stdout END ====
[2025-02-26 04:23:53] 2025-02-26 09:23:53,111 [wrapper] ==== wrapper stderr END ====
[2025-02-26 04:23:53]  *** Error codes and diagnostics ***
[2025-02-26 04:23:53]     "exeErrorCode": 0,
[2025-02-26 04:23:53]     "exeErrorDiag": "",
[2025-02-26 04:23:53]     "pilotErrorCode": 0,
[2025-02-26 04:23:53]     "pilotErrorDiag": "",
[2025-02-26 04:23:53]  *** Listing of results directory ***
[2025-02-26 04:23:53] total 431588
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas    491065 Feb 25 09:02 pilot3.tar.gz
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas      5118 Feb 25 09:19 queuedata.json
[2025-02-26 04:23:53] -rwx------ 1 boincer umatlas     35865 Feb 25 09:19 runpilot2-wrapper.sh
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas       100 Feb 26 02:12 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-26 04:23:53] -rwxr-xr-x 1 boincer umatlas      7986 Feb 26 02:12 run_atlas
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas       105 Feb 26 02:12 job.xml
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas 251178618 Feb 26 02:12 EVNT.43401135._000059.pool.root.1
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas     17569 Feb 26 02:12 start_atlas.sh
[2025-02-26 04:23:53] drwxrwx--x 2 boincer umatlas      4096 Feb 26 02:12 shared
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas    503560 Feb 26 02:12 input.tar.gz
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas         0 Feb 26 02:12 boinc_lockfile
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas      2558 Feb 26 02:12 pandaJob.out
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas       462 Feb 26 02:12 setup.sh.local
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas    987490 Feb 26 02:12 agis_schedconf.cvmfs.json
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas   1573632 Feb 26 02:12 agis_ddmendpoints.agis.ALL.json
[2025-02-26 04:23:53] drwx------ 4 boincer umatlas      4096 Feb 26 02:12 pilot3
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas      5904 Feb 26 04:20 init_data.xml
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas 184779095 Feb 26 04:22 HITS.43401137._001167.pool.root.1
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas       529 Feb 26 04:23 boinc_task_state.xml
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas      1049 Feb 26 04:23 memory_monitor_summary.json
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas    339331 Feb 26 04:23 log.43401137._001167.job.log.tgz.1
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas        95 Feb 26 04:23 pilot_heartbeat.json
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas      7756 Feb 26 04:23 heartbeat.json
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas      8192 Feb 26 04:23 boinc_mmap_file
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas        27 Feb 26 04:23 wrapper_checkpoint.txt
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas      4287 Feb 26 04:23 pilotlog.txt
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas    754925 Feb 26 04:23 log.43401137._001167.job.log.1
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas       357 Feb 26 04:23 output.list
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas       620 Feb 26 04:23 runtime_log
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas   1116160 Feb 26 04:23 result.tar.gz
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas     11388 Feb 26 04:23 runtime_log.err
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas       660 Feb 26 04:23 qTpNDmRxA76nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmPcwKDmimrtqn.diag
[2025-02-26 04:23:53] -rw-r--r-- 1 boincer umatlas     21637 Feb 26 04:23 stderr.txt
[2025-02-26 04:23:53] HITS file was successfully produced:
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas 184779095 Feb 26 04:22 shared/HITS.pool.root.1
[2025-02-26 04:23:53]  *** Contents of shared directory: ***
[2025-02-26 04:23:53] total 427352
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas 251178618 Feb 26 02:12 ATLAS.root_0
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas     17569 Feb 26 02:12 start_atlas.sh
[2025-02-26 04:23:53] -rw-r--r-- 2 boincer umatlas    503560 Feb 26 02:12 input.tar.gz
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas 184779095 Feb 26 04:22 HITS.pool.root.1
[2025-02-26 04:23:53] -rw------- 1 boincer umatlas   1116160 Feb 26 04:23 result.tar.gz
04:23:55 (30653): run_atlas exited; CPU time 56305.760131
04:23:55 (30653): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN