Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
18:42:15 (28232): wrapper (7.7.26015): starting
18:42:15 (28232): wrapper: running run_atlas (--nthreads 12)
[2025-02-22 18:42:15] Arguments: --nthreads 12
[2025-02-22 18:42:15] Threads: 12
[2025-02-22 18:42:15] Checking for CVMFS
[2025-02-22 18:42:16] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-22 18:42:17] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-22 18:42:17] Running cvmfs_config stat atlas.cern.ch
[2025-02-22 18:42:18] 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-22 18:42:18] 2.11.2.0 2080 168763 82356 142956 3 91 16084887 18432001 4855 130560 0 22565016 99.305 43116690 38402 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-02-22 18:42:18] CVMFS is ok
[2025-02-22 18:42:18] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-22 18:42:18] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-22 18:42:18] Further information can be found at the LHC@home message board.
[2025-02-22 18:42:18] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-22 18:42:18] Checking for apptainer binary...
[2025-02-22 18:42:18] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-22 18:42:18] Running /usr/bin/apptainer --version
[2025-02-22 18:42:20] apptainer version 1.3.2-1.el7
[2025-02-22 18:42:20] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-22 18:42:39] c-206-5.aglt2.org
[2025-02-22 18:42:39] apptainer works
[2025-02-22 18:42:39] Set ATHENA_PROC_NUMBER=12
[2025-02-22 18:42:39] Set ATHENA_CORE_NUMBER=12
[2025-02-22 18:42:39] Starting ATLAS job with PandaID=6523276511
[2025-02-22 18:42:39] 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-23 10:14:28]  *** The last 200 lines of the pilot log: ***
[2025-02-23 10:14:28] 2025-02-23 15:14:12,565 | INFO     | model: linear, x: [1740268401.0, 1740268462.0, 1740268523.0, 1740268584.0, 1740268645.0, 1740268706.0, 1740268767.0, 1740268828.0, 1740268889.0, 1740268950.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,565 | INFO     | sum of square deviations: 230599321181.5851
[2025-02-23 10:14:28] 2025-02-23 15:14:12,596 | INFO     | sum of deviations: 820641152203.9437
[2025-02-23 10:14:28] 2025-02-23 15:14:12,596 | INFO     | mean x: 1740296004.1501105
[2025-02-23 10:14:28] 2025-02-23 15:14:12,596 | INFO     | mean y: 2723965.573951435
[2025-02-23 10:14:28] 2025-02-23 15:14:12,596 | INFO     | -- intersect: -6190522877.928525
[2025-02-23 10:14:28] 2025-02-23 15:14:12,597 | INFO     | intersect: -6190522877.928525
[2025-02-23 10:14:28] 2025-02-23 15:14:12,598 | INFO     | chi2: 6.226295700982619
[2025-02-23 10:14:28] 2025-02-23 15:14:12,598 | INFO     | current chi2=6.226295700982619 (change=39.65939240307783 %)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,599 | INFO     | model: linear, x: [1740268706.0, 1740268767.0, 1740268828.0, 1740268889.0, 1740268950.0, 1740269011.0, 1740269072.0, 1740269133.0, 1740269194.0, 1740269255.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,600 | INFO     | sum of square deviations: 226802261041.96075
[2025-02-23 10:14:28] 2025-02-23 15:14:12,628 | INFO     | sum of deviations: 585221295080.2275
[2025-02-23 10:14:28] 2025-02-23 15:14:12,629 | INFO     | mean x: 1740296156.653718
[2025-02-23 10:14:28] 2025-02-23 15:14:12,629 | INFO     | mean y: 2733419.648168701
[2025-02-23 10:14:28] 2025-02-23 15:14:12,629 | INFO     | -- intersect: -4487779002.6755495
[2025-02-23 10:14:28] 2025-02-23 15:14:12,629 | INFO     | intersect: -4487779002.6755495
[2025-02-23 10:14:28] 2025-02-23 15:14:12,631 | INFO     | chi2: 4.270892434741007
[2025-02-23 10:14:28] 2025-02-23 15:14:12,631 | INFO     | current chi2=4.270892434741007 (change=31.405563759733017 %)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,632 | INFO     | model: linear, x: [1740269011.0, 1740269072.0, 1740269133.0, 1740269194.0, 1740269255.0, 1740269316.0, 1740269377.0, 1740269438.0, 1740269499.0, 1740269560.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,632 | INFO     | sum of square deviations: 223047108664.8116
[2025-02-23 10:14:28] 2025-02-23 15:14:12,655 | INFO     | sum of deviations: 382267721533.5333
[2025-02-23 10:14:28] 2025-02-23 15:14:12,655 | INFO     | mean x: 1740296309.157366
[2025-02-23 10:14:28] 2025-02-23 15:14:12,656 | INFO     | mean y: 2741661.9040178573
[2025-02-23 10:14:28] 2025-02-23 15:14:12,656 | INFO     | -- intersect: -2979852951.750154
[2025-02-23 10:14:28] 2025-02-23 15:14:12,656 | INFO     | intersect: -2979852951.750154
[2025-02-23 10:14:28] 2025-02-23 15:14:12,657 | INFO     | chi2: 2.8406930825917938
[2025-02-23 10:14:28] 2025-02-23 15:14:12,657 | INFO     | current chi2=2.8406930825917938 (change=33.48713117931621 %)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,657 | INFO     | model: linear, x: [1740269316.0, 1740269377.0, 1740269438.0, 1740269499.0, 1740269560.0, 1740269621.0, 1740269682.0, 1740269743.0, 1740269804.0, 1740269865.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,658 | INFO     | sum of square deviations: 219333631487.63892
[2025-02-23 10:14:28] 2025-02-23 15:14:12,672 | INFO     | sum of deviations: 227679496631.66162
[2025-02-23 10:14:28] 2025-02-23 15:14:12,672 | INFO     | mean x: 1740296461.661055
[2025-02-23 10:14:28] 2025-02-23 15:14:12,672 | INFO     | mean y: 2748004.465768799
[2025-02-23 10:14:28] 2025-02-23 15:14:12,672 | INFO     | -- intersect: -1803768486.8420465
[2025-02-23 10:14:28] 2025-02-23 15:14:12,672 | INFO     | intersect: -1803768486.8420465
[2025-02-23 10:14:28] 2025-02-23 15:14:12,673 | INFO     | chi2: 1.9332815622237085
[2025-02-23 10:14:28] 2025-02-23 15:14:12,673 | INFO     | current chi2=1.9332815622237085 (change=31.9433143245514 %)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,674 | INFO     | model: linear, x: [1740269621.0, 1740269682.0, 1740269743.0, 1740269804.0, 1740269865.0, 1740269926.0, 1740269987.0, 1740270048.0, 1740270109.0, 1740270170.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,674 | INFO     | sum of square deviations: 215661596947.94104
[2025-02-23 10:14:28] 2025-02-23 15:14:12,688 | INFO     | sum of deviations: 178203439882.06052
[2025-02-23 10:14:28] 2025-02-23 15:14:12,688 | INFO     | mean x: 1740296614.1647856
[2025-02-23 10:14:28] 2025-02-23 15:14:12,688 | INFO     | mean y: 2750058.636568849
[2025-02-23 10:14:28] 2025-02-23 15:14:12,689 | INFO     | -- intersect: -1435275289.6322281
[2025-02-23 10:14:28] 2025-02-23 15:14:12,689 | INFO     | intersect: -1435275289.6322281
[2025-02-23 10:14:28] 2025-02-23 15:14:12,690 | INFO     | chi2: 1.857411549303224
[2025-02-23 10:14:28] 2025-02-23 15:14:12,690 | INFO     | current chi2=1.857411549303224 (change=3.9244161017713837 %)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,690 | INFO     | left removable region: 50
[2025-02-23 10:14:28] 2025-02-23 15:14:12,690 | INFO     | model: linear, x: [1740271146.0, 1740271207.0, 1740271271.0, 1740271330.0, 1740271391.0, 1740271459.0, 1740271513.0, 1740271576.0, 1740271638.0, 1740271697.0, 1740
[2025-02-23 10:14:28] 2025-02-23 15:14:12,691 | INFO     | sum of square deviations: 193807013904.64835
[2025-02-23 10:14:28] 2025-02-23 15:14:12,707 | INFO     | sum of deviations: 222174044634.3322
[2025-02-23 10:14:28] 2025-02-23 15:14:12,707 | INFO     | mean x: 1740297193.671345
[2025-02-23 10:14:28] 2025-02-23 15:14:12,707 | INFO     | mean y: 2759454.2502923976
[2025-02-23 10:14:28] 2025-02-23 15:14:12,708 | INFO     | -- intersect: -1992260532.8693118
[2025-02-23 10:14:28] 2025-02-23 15:14:12,708 | INFO     | intersect: -1992260532.8693118
[2025-02-23 10:14:28] 2025-02-23 15:14:12,709 | INFO     | chi2: 0.013221902569455855
[2025-02-23 10:14:28] 2025-02-23 15:14:12,709 | INFO     | -- intersect: -1992260532.8693118
[2025-02-23 10:14:28] 2025-02-23 15:14:12,710 | INFO     | current memory leak: 1.15 B/s (using 855 data points, chi2=0.01)
[2025-02-23 10:14:28] 2025-02-23 15:14:12,711 | INFO     | ..............................
[2025-02-23 10:14:28] 2025-02-23 15:14:12,711 | INFO     | . Timing measurements:
[2025-02-23 10:14:28] 2025-02-23 15:14:12,711 | INFO     | . get job = 1 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,711 | INFO     | . initial setup = 7 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,711 | INFO     | . payload setup = 67 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,712 | INFO     | . stage-in = 0 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,712 | INFO     | . payload execution = 55599 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,712 | INFO     | . stage-out = 11 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,712 | INFO     | . log creation = 1 s
[2025-02-23 10:14:28] 2025-02-23 15:14:12,712 | INFO     | ..............................
[2025-02-23 10:14:28] 2025-02-23 15:14:13,175 | INFO     | 
[2025-02-23 10:14:28] 2025-02-23 15:14:13,190 | INFO     | job summary report
[2025-02-23 10:14:28] 2025-02-23 15:14:13,190 | INFO     | --------------------------------------------------
[2025-02-23 10:14:28] 2025-02-23 15:14:13,190 | INFO     | PanDA job id: 6523276511
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | task id: 43205094
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | errors: (none)
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | pilot state: finished 
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | transexitcode: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:13,191 | INFO     | exeerrorcode: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:13,192 | INFO     | exeerrordiag: 
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | exitcode: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | exitmsg: OK
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | cpuconsumptiontime: 191210 s
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | nevents: 400
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | neventsw: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:13,195 | INFO     | pid: 11789
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | pgrp: 11789
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | corecount: 12
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | event service: False
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | sizes: {0: 2383188, 1: 2383216, 2: 2383387, 3: 2383415, 14: 2383443, 26: 2383471, 37: 2383627, 45: 2383861, 48: 2383889, 55673: 2431819, 55685: 2440760, 55687: 244
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | --------------------------------------------------
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | 
[2025-02-23 10:14:28] 2025-02-23 15:14:13,196 | INFO     | executing command: ls -lF /tmp/boinchome/slots/0
[2025-02-23 10:14:28] 2025-02-23 15:14:13,301 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,301 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,301 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,301 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,302 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | job 6523276511 has completed (purged errors)
[2025-02-23 10:14:28] 2025-02-23 15:14:13,303 | INFO     | overall cleanup function is called
[2025-02-23 10:14:28] 2025-02-23 15:14:14,321 | INFO     | --- collectZombieJob: --- 10, [11789]
[2025-02-23 10:14:28] 2025-02-23 15:14:14,321 | INFO     | zombie collector waiting for pid 11789
[2025-02-23 10:14:28] 2025-02-23 15:14:14,321 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-23 10:14:28] 2025-02-23 15:14:14,322 | INFO     | collected zombie processes
[2025-02-23 10:14:28] 2025-02-23 15:14:14,322 | INFO     | will attempt to kill all subprocesses of pid=11789
[2025-02-23 10:14:28] 2025-02-23 15:14:14,454 | INFO     | process IDs to be killed: [11789] (in reverse order)
[2025-02-23 10:14:28] 2025-02-23 15:14:14,532 | WARNING  | found no corresponding commands to process id(s)
[2025-02-23 10:14:28] 2025-02-23 15:14:14,532 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-23 10:14:28] 2025-02-23 15:14:14,668 | INFO     | did not find any defunct processes belonging to 11789
[2025-02-23 10:14:28] 2025-02-23 15:14:14,737 | INFO     | did not find any defunct processes belonging to 11789
[2025-02-23 10:14:28] 2025-02-23 15:14:14,737 | INFO     | ready for new job
[2025-02-23 10:14:28] 2025-02-23 15:14:14,737 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-23 10:14:28] 2025-02-23 15:14:14,775 | INFO     | **************************************
[2025-02-23 10:14:28] 2025-02-23 15:14:14,780 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-23 10:14:28] 2025-02-23 15:14:14,780 | INFO     | **************************************
[2025-02-23 10:14:28] 2025-02-23 15:14:14,780 | INFO     | 
[2025-02-23 10:14:28] 2025-02-23 15:14:14,781 | INFO     | architecture information:
[2025-02-23 10:14:28] 2025-02-23 15:14:14,783 | INFO     | executing command: cat /etc/os-release
[2025-02-23 10:14:28] 2025-02-23 15:14:14,795 | INFO     | PID=1113 has CPU usage=5.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-23 10:14:28] 2025-02-23 15:14:14,795 | INFO     | .. there are 4 such processes running
[2025-02-23 10:14:28] 2025-02-23 15:14:14,812 | INFO     | cat /etc/os-release:
[2025-02-23 10:14:28] NAME="CentOS Linux"
[2025-02-23 10:14:28] VERSION="7 (Core)"
[2025-02-23 10:14:28] ID="centos"
[2025-02-23 10:14:28] ID_LIKE="rhel fedora"
[2025-02-23 10:14:28] VERSION_ID="7"
[2025-02-23 10:14:28] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-23 10:14:28] ANSI_COLOR="0;31"
[2025-02-23 10:14:28] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-23 10:14:28] HOME_URL="https://www.centos.org/"
[2025-02-23 10:14:28] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-23 10:14:28] 
[2025-02-23 10:14:28] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-23 10:14:28] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-23 10:14:28] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-23 10:14:28] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-23 10:14:28] 
[2025-02-23 10:14:28] 2025-02-23 15:14:14,813 | INFO     | **************************************
[2025-02-23 10:14:28] 2025-02-23 15:14:15,316 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2025-02-23 10:14:28] 2025-02-23 15:14:15,483 | INFO     | sufficient remaining disk space (28842131456 B)
[2025-02-23 10:14:28] 2025-02-23 15:14:15,483 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-23 10:14:28] 2025-02-23 15:14:15,483 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-23 10:14:28] 2025-02-23 15:14:15,484 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-23 10:14:28] 2025-02-23 15:14:15,484 | INFO     | aborting loop
[2025-02-23 10:14:28] 2025-02-23 15:14:15,484 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-02-23 10:14:28] 2025-02-23 15:14:15,485 | INFO     | found 0 job(s) in 20 queues
[2025-02-23 10:14:28] 2025-02-23 15:14:15,485 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-23 10:14:28] 2025-02-23 15:14:15,485 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-23 10:14:28] 2025-02-23 15:14:15,486 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-23 10:14:28] 2025-02-23 15:14:15,707 | INFO     | all job control threads have been joined
[2025-02-23 10:14:28] 2025-02-23 15:14:16,180 | INFO     | all data control threads have been joined
[2025-02-23 10:14:28] 2025-02-23 15:14:16,219 | INFO     | all payload control threads have been joined
[2025-02-23 10:14:28] 2025-02-23 15:14:16,368 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-23 10:14:28] 2025-02-23 15:14:16,488 | INFO     | [job] retrieve thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:16,490 | INFO     | [job] job monitor thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:16,714 | INFO     | [job] control thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,186 | INFO     | [data] control thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,226 | INFO     | [payload] control thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,281 | INFO     | [data] copytool_in thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,295 | INFO     | [payload] validate_pre thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,305 | INFO     | [payload] execute_payloads thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,315 | INFO     | [job] create_data_payload thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,380 | INFO     | [job] validate thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,389 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,483 | INFO     | [payload] validate_post thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,483 | INFO     | [payload] failed_post thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:17,890 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-23 10:14:28] 2025-02-23 15:14:18,374 | INFO     | [data] copytool_out thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:18,895 | INFO     | [job] queue monitor thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:19,494 | INFO     | [data] queue_monitor thread has finished
[2025-02-23 10:14:28] 2025-02-23 15:14:20,370 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139887321163584)>', '<ExcThread(monitor, started 139887096432384)>']
[2025-02-23 10:14:28] 2025-02-23 15:14:20,534 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-23 10:14:28] 2025-02-23 15:14:20,534 | INFO     | [monitor] control thread has ended
[2025-02-23 10:14:28] 2025-02-23 15:14:21,931 [wrapper] supervise_pilot (15 min periods counter: 63)
[2025-02-23 10:14:28] 2025-02-23 15:14:25,389 | INFO     | all workflow threads have been joined
[2025-02-23 10:14:28] 2025-02-23 15:14:25,389 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-23 10:14:28] 2025-02-23 15:14:25,404 | INFO     | traces error code: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:25,404 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-23 10:14:28] 2025-02-23 15:14:25,909 [wrapper] ==== pilot stdout END ====
[2025-02-23 10:14:28] 2025-02-23 15:14:25,931 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-23 10:14:28] 2025-02-23 15:14:25,951 [wrapper] pilotpid: 1113
[2025-02-23 10:14:28] 2025-02-23 15:14:25,959 [wrapper] Pilot exit status: 0
[2025-02-23 10:14:28] 2025-02-23 15:14:26,108 [wrapper] pandaids: 6523276511
[2025-02-23 10:14:28] 2025-02-23 15:14:26,210 [wrapper] cleanup supervisor_pilot  2838 1114
[2025-02-23 10:14:28] 2025-02-23 15:14:26,284 [wrapper] Test setup, not cleaning
[2025-02-23 10:14:28] 2025-02-23 15:14:26,444 [wrapper] apfmon messages muted
[2025-02-23 10:14:28] 2025-02-23 15:14:26,524 [wrapper] ==== wrapper stdout END ====
[2025-02-23 10:14:28] 2025-02-23 15:14:26,604 [wrapper] ==== wrapper stderr END ====
[2025-02-23 10:14:28]  *** Error codes and diagnostics ***
[2025-02-23 10:14:28]     "exeErrorCode": 0,
[2025-02-23 10:14:28]     "exeErrorDiag": "",
[2025-02-23 10:14:28]     "pilotErrorCode": 0,
[2025-02-23 10:14:28]     "pilotErrorDiag": "",
[2025-02-23 10:14:28]  *** Listing of results directory ***
[2025-02-23 10:14:28] total 672916
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas    491065 Feb 22 12:29 pilot3.tar.gz
[2025-02-23 10:14:28] -rwx------ 1 boincer umatlas     35865 Feb 22 13:23 runpilot2-wrapper.sh
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas      5118 Feb 22 13:23 queuedata.json
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas       100 Feb 22 18:42 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-23 10:14:28] -rwxr-xr-x 1 boincer umatlas      7986 Feb 22 18:42 run_atlas
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas       105 Feb 22 18:42 job.xml
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas 346796232 Feb 22 18:42 EVNT.43092757._002131.pool.root.1
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas     17569 Feb 22 18:42 start_atlas.sh
[2025-02-23 10:14:28] drwxrwx--x 2 boincer umatlas      4096 Feb 22 18:42 shared
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas    503550 Feb 22 18:42 input.tar.gz
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas         0 Feb 22 18:42 boinc_lockfile
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas      2547 Feb 22 18:42 pandaJob.out
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas       467 Feb 22 18:42 setup.sh.local
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas    987744 Feb 22 18:44 agis_schedconf.cvmfs.json
[2025-02-23 10:14:28] drwx------ 4 boincer umatlas      4096 Feb 22 18:44 pilot3
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas 320599675 Feb 23 10:08 HITS.43205094._037417.pool.root.1
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas      5952 Feb 23 10:11 init_data.xml
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas       533 Feb 23 10:11 boinc_task_state.xml
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas      1072 Feb 23 10:13 memory_monitor_summary.json
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas   1582569 Feb 23 10:13 agis_ddmendpoints.agis.ALL.json
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas        95 Feb 23 10:13 pilot_heartbeat.json
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas   1014778 Feb 23 10:13 log.43205094._037417.job.log.tgz.1
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas      7814 Feb 23 10:14 heartbeat.json
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas        29 Feb 23 10:14 wrapper_checkpoint.txt
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas      8192 Feb 23 10:14 boinc_mmap_file
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas      4729 Feb 23 10:14 pilotlog.txt
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas   7915545 Feb 23 10:14 log.43205094._037417.job.log.1
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas       357 Feb 23 10:14 output.list
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas       620 Feb 23 10:14 runtime_log
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas   8949760 Feb 23 10:14 result.tar.gz
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas     11416 Feb 23 10:14 runtime_log.err
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas       666 Feb 23 10:14 DtrKDm3K956nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmGQuKDmKf89On.diag
[2025-02-23 10:14:28] -rw-r--r-- 1 boincer umatlas     21824 Feb 23 10:14 stderr.txt
[2025-02-23 10:14:28] HITS file was successfully produced:
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas 320599675 Feb 23 10:08 shared/HITS.pool.root.1
[2025-02-23 10:14:28]  *** Contents of shared directory: ***
[2025-02-23 10:14:28] total 661020
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas 346796232 Feb 22 18:42 ATLAS.root_0
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas     17569 Feb 22 18:42 start_atlas.sh
[2025-02-23 10:14:28] -rw-r--r-- 2 boincer umatlas    503550 Feb 22 18:42 input.tar.gz
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas 320599675 Feb 23 10:08 HITS.pool.root.1
[2025-02-23 10:14:28] -rw------- 1 boincer umatlas   8949760 Feb 23 10:14 result.tar.gz
10:14:30 (28232): run_atlas exited; CPU time 190884.632074
10:14:30 (28232): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN