Stderr output

<core_client_version>8.0.4</core_client_version>
<![CDATA[
<stderr_txt>
01:45:14 (1132476): wrapper (7.7.26015): starting
01:45:14 (1132476): wrapper: running run_atlas (--nthreads 4)
[2025-02-15 01:45:14] Arguments: --nthreads 4
[2025-02-15 01:45:14] Threads: 4
[2025-02-15 01:45:14] Checking for CVMFS
[2025-02-15 01:45:14] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-15 01:45:14] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-15 01:45:14] Running cvmfs_config stat atlas.cern.ch
[2025-02-15 01:45:14] 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-15 01:45:14] 2.12.4.4 1868664 6102 68196 142660 0 56 9809702 10240000 1818 130560 0 13614602 99.996 1334870 375 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2025-02-15 01:45:14] CVMFS is ok
[2025-02-15 01:45:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-15 01:45:14] Checking for apptainer binary...
[2025-02-15 01:45:14] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-15 01:45:14] Running /usr/bin/apptainer --version
[2025-02-15 01:45:14] apptainer version 1.3.4
[2025-02-15 01:45:14] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-15 01:45:14] atlas6l2
[2025-02-15 01:45:14] apptainer works
[2025-02-15 01:45:14] Set ATHENA_PROC_NUMBER=4
[2025-02-15 01:45:14] Set ATHENA_CORE_NUMBER=4
[2025-02-15 01:45:14] Starting ATLAS job with PandaID=6513309778
[2025-02-15 01:45:14] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-15 04:57:52]  *** The last 200 lines of the pilot log: ***
[2025-02-15 04:57:52] 2025-02-15 03:57:33,516 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-02-15 04:57:52] 2025-02-15 03:57:33,518 | INFO     | fitting pss+swap vs Time
[2025-02-15 04:57:52] 2025-02-15 03:57:33,518 | INFO     | model: linear, x: [1739580342.0, 1739580403.0, 1739580464.0, 1739580525.0, 1739580586.0, 1739580647.0, 1739580708.0, 1739580769.0, 1739580830.0, 1739580891.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,518 | INFO     | sum of square deviations: 2093397390.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | sum of deviations: -14009871037.000004
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | mean x: 1739586076.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | mean y: 2377480.1587301586
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | -- intersect: 11644398578.94346
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | intersect: 11644398578.94346
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | chi2: 2.891753256809837
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | model: linear, x: [1739580342.0, 1739580403.0, 1739580464.0, 1739580525.0, 1739580586.0, 1739580647.0, 1739580708.0, 1739580769.0, 1739580830.0, 1739580891.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,519 | INFO     | sum of square deviations: 1931608310.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | sum of deviations: -1931770387.0000005
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | mean x: 1739585923.5
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | mean y: 2388627.717391304
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | -- intersect: 1742120516.0417628
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | intersect: 1742120516.0417628
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | chi2: 2.1514871952492602
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | current chi2=2.1514871952492602 (change=25.599212512938717 %)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | model: linear, x: [1739580342.0, 1739580403.0, 1739580464.0, 1739580525.0, 1739580586.0, 1739580647.0, 1739580708.0, 1739580769.0, 1739580830.0, 1739580891.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,520 | INFO     | sum of square deviations: 1778377530.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | sum of deviations: -1804587643.999999
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | mean x: 1739585771.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | mean y: 2388754.3631284917
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | -- intersect: 1767612917.9999754
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | intersect: 1767612917.9999754
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | chi2: 2.1513977428544053
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | current chi2=2.1513977428544053 (change=0.004157700545577865 %)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | right removable region: 178
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | model: linear, x: [1739580647.0, 1739580708.0, 1739580769.0, 1739580830.0, 1739580891.0, 1739580952.0, 1739581013.0, 1739581074.0, 1739581135.0, 1739581196.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,521 | INFO     | sum of square deviations: 1931608310.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | sum of deviations: -49084426408.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | mean x: 1739586228.5
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | mean y: 2410328.054347826
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | -- intersect: 44207331051.955414
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | intersect: 44207331051.955414
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | chi2: 1.1078790769515132
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | current chi2=1.1078790769515132 (change=61.688326127322554 %)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | model: linear, x: [1739580952.0, 1739581013.0, 1739581074.0, 1739581135.0, 1739581196.0, 1739581257.0, 1739581318.0, 1739581379.0, 1739581440.0, 1739581501.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | sum of square deviations: 1778377530.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,522 | INFO     | sum of deviations: -43094977928.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | mean x: 1739586381.0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | mean y: 2404323.7039106144
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | -- intersect: 42157366039.31016
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | intersect: 42157366039.31016
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | chi2: 1.092065677958786
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | current chi2=1.092065677958786 (change=1.4273578517467784 %)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | left removable region: 20
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | model: linear, x: [1739581562.0, 1739581623.0, 1739581684.0, 1739581745.0, 1739581806.0, 1739581867.0, 1739581928.0, 1739581989.0, 1739582050.0, 1739582111.0, 1739
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | sum of square deviations: 1223016419.5
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | sum of deviations: -12265478650.500002
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | mean x: 1739586350.5
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | mean y: 2396274.5632911394
[2025-02-15 04:57:52] 2025-02-15 03:57:33,523 | INFO     | -- intersect: 17448490131.162544
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | intersect: 17448490131.162544
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | chi2: 0.19456081860999638
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | -- intersect: 17448490131.162544
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | current memory leak: -10.03 B/s (using 158 data points, chi2=0.19)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | ..............................
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . Timing measurements:
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . get job = 0 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . initial setup = 2 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . payload setup = 3 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . stage-in = 0 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . payload execution = 11501 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . stage-out = 1 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | . log creation = 0 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,524 | INFO     | ..............................
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | 
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | job summary report
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | --------------------------------------------------
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | PanDA job id: 6513309778
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | task id: 43078919
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | errors: (none)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | pilot state: finished 
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | transexitcode: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | exeerrorcode: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | exeerrordiag: 
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | exitcode: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,905 | INFO     | exitmsg: OK
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | cpuconsumptiontime: 44416 s
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | nevents: 400
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | neventsw: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | pid: 1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | pgrp: 1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | corecount: 4
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | event service: False
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | sizes: {0: 2398947, 1: 2399202, 3: 2399408, 11: 2399436, 11508: 2428679, 11510: 2437648, 11513: 2437832, 11518: 2438002}
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | --------------------------------------------------
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | 
[2025-02-15 04:57:52] 2025-02-15 03:57:33,906 | INFO     | executing command: ls -lF /var/lib/boinc_data/boinc-01/slots/1
[2025-02-15 04:57:52] 2025-02-15 03:57:33,916 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,917 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,918 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-15 04:57:52] 2025-02-15 03:57:33,918 | INFO     | job 6513309778 has completed (purged errors)
[2025-02-15 04:57:52] 2025-02-15 03:57:33,918 | INFO     | overall cleanup function is called
[2025-02-15 04:57:52] 2025-02-15 03:57:34,925 | INFO     | --- collectZombieJob: --- 10, [1142733]
[2025-02-15 04:57:52] 2025-02-15 03:57:34,925 | INFO     | zombie collector waiting for pid 1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:34,925 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-15 04:57:52] 2025-02-15 03:57:34,925 | INFO     | collected zombie processes
[2025-02-15 04:57:52] 2025-02-15 03:57:34,925 | INFO     | will attempt to kill all subprocesses of pid=1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:34,960 | INFO     | process IDs to be killed: [1142733] (in reverse order)
[2025-02-15 04:57:52] 2025-02-15 03:57:34,990 | WARNING  | found no corresponding commands to process id(s)
[2025-02-15 04:57:52] 2025-02-15 03:57:34,990 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-15 04:57:52] 2025-02-15 03:57:34,993 | INFO     | did not find any defunct processes belonging to 1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:34,994 | INFO     | did not find any defunct processes belonging to 1142733
[2025-02-15 04:57:52] 2025-02-15 03:57:34,995 | INFO     | ready for new job
[2025-02-15 04:57:52] 2025-02-15 03:57:34,995 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | **************************************
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | **************************************
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | 
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | pilot is running in a VM
[2025-02-15 04:57:52] 2025-02-15 03:57:34,996 | INFO     | architecture information:
[2025-02-15 04:57:52] 2025-02-15 03:57:34,997 | INFO     | executing command: cat /etc/os-release
[2025-02-15 04:57:52] 2025-02-15 03:57:35,009 | INFO     | cat /etc/os-release:
[2025-02-15 04:57:52] NAME="CentOS Linux"
[2025-02-15 04:57:52] VERSION="7 (Core)"
[2025-02-15 04:57:52] ID="centos"
[2025-02-15 04:57:52] ID_LIKE="rhel fedora"
[2025-02-15 04:57:52] VERSION_ID="7"
[2025-02-15 04:57:52] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-15 04:57:52] ANSI_COLOR="0;31"
[2025-02-15 04:57:52] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-15 04:57:52] HOME_URL="https://www.centos.org/"
[2025-02-15 04:57:52] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-15 04:57:52] 
[2025-02-15 04:57:52] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-15 04:57:52] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-15 04:57:52] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-15 04:57:52] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-15 04:57:52] 
[2025-02-15 04:57:52] 2025-02-15 03:57:35,009 | INFO     | **************************************
[2025-02-15 04:57:52] 2025-02-15 03:57:35,512 | INFO     | executing command: df -mP /var/lib/boinc_data/boinc-01/slots/1
[2025-02-15 04:57:52] 2025-02-15 03:57:35,525 | INFO     | sufficient remaining disk space (23516413952 B)
[2025-02-15 04:57:52] 2025-02-15 03:57:35,525 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-15 04:57:52] 2025-02-15 03:57:35,525 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-15 04:57:52] 2025-02-15 03:57:35,525 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-15 04:57:52] 2025-02-15 03:57:35,526 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-15 04:57:52] 2025-02-15 03:57:35,526 | INFO     | aborting loop
[2025-02-15 04:57:52] 2025-02-15 03:57:35,526 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-15 04:57:52] 2025-02-15 03:57:35,841 | INFO     | all data control threads have been joined
[2025-02-15 04:57:52] 2025-02-15 03:57:36,187 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-15 04:57:52] 2025-02-15 03:57:36,342 | INFO     | all job control threads have been joined
[2025-02-15 04:57:52] 2025-02-15 03:57:36,394 | INFO     | found 0 job(s) in 20 queues
[2025-02-15 04:57:52] 2025-02-15 03:57:36,395 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-15 04:57:52] 2025-02-15 03:57:36,395 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-15 04:57:52] 2025-02-15 03:57:36,529 | INFO     | all payload control threads have been joined
[2025-02-15 04:57:52] 2025-02-15 03:57:36,529 | INFO     | [job] job monitor thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:36,529 | INFO     | [job] queue monitor thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:36,531 | INFO     | [job] retrieve thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:36,847 | INFO     | [data] control thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:36,887 | INFO     | [payload] failed_post thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:36,936 | INFO     | [job] validate thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,038 | INFO     | [data] copytool_in thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,123 | INFO     | [payload] validate_pre thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,192 | INFO     | [job] create_data_payload thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,238 | INFO     | [payload] execute_payloads thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,347 | INFO     | [job] control thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:37,532 | INFO     | [payload] control thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:38,093 | INFO     | [payload] validate_post thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:38,193 | INFO     | [data] copytool_out thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:39,532 | INFO     | [data] queue_monitor thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:45,618 | INFO     | job.realtimelogging is not enabled
[2025-02-15 04:57:52] 2025-02-15 03:57:46,624 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-15 04:57:52] 2025-02-15 03:57:47,059 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139875704538944)>', '<ExcThread(monitor, started 139875250603776)>']
[2025-02-15 04:57:52] 2025-02-15 03:57:47,445 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-15 04:57:52] 2025-02-15 03:57:47,446 | INFO     | [monitor] control thread has ended
[2025-02-15 04:57:52] 2025-02-15 03:57:52,085 | INFO     | all workflow threads have been joined
[2025-02-15 04:57:52] 2025-02-15 03:57:52,085 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-15 04:57:52] 2025-02-15 03:57:52,085 | INFO     | traces error code: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:52,086 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-15 04:57:52] 2025-02-15 03:57:52,154 [wrapper] ==== pilot stdout END ====
[2025-02-15 04:57:52] 2025-02-15 03:57:52,158 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-15 04:57:52] 2025-02-15 03:57:52,162 [wrapper] pilotpid: 1136199
[2025-02-15 04:57:52] 2025-02-15 03:57:52,165 [wrapper] Pilot exit status: 0
[2025-02-15 04:57:52] 2025-02-15 03:57:52,180 [wrapper] pandaids: 6513309778
[2025-02-15 04:57:52] 2025-02-15 03:57:52,205 [wrapper] cleanup supervisor_pilot 1234155 1136200
[2025-02-15 04:57:52] 2025-02-15 03:57:52,208 [wrapper] Test setup, not cleaning
[2025-02-15 04:57:52] 2025-02-15 03:57:52,213 [wrapper] apfmon messages muted
[2025-02-15 04:57:52] 2025-02-15 03:57:52,217 [wrapper] ==== wrapper stdout END ====
[2025-02-15 04:57:52] 2025-02-15 03:57:52,221 [wrapper] ==== wrapper stderr END ====
[2025-02-15 04:57:52]  *** Error codes and diagnostics ***
[2025-02-15 04:57:52]     "exeErrorCode": 0,
[2025-02-15 04:57:52]     "exeErrorDiag": "",
[2025-02-15 04:57:52]     "pilotErrorCode": 0,
[2025-02-15 04:57:52]     "pilotErrorDiag": "",
[2025-02-15 04:57:52]  *** Listing of results directory ***
[2025-02-15 04:57:52] insgesamt 662204
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc    491065 Feb 14 17:32 pilot3.tar.gz
[2025-02-15 04:57:52] -rwx------ 1 yeti boinc     34964 Feb 14 17:36 runpilot2-wrapper.sh
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc      5118 Feb 14 17:36 queuedata.json
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc       100 Feb 15 01:45 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-15 04:57:52] -rwxr-xr-x 1 yeti boinc      7986 Feb 15 01:45 run_atlas
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc       105 Feb 15 01:45 job.xml
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc      6676 Feb 15 01:45 init_data.xml
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc 342997392 Feb 15 01:45 EVNT.43078917._001505.pool.root.1
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc     17569 Feb 15 01:45 start_atlas.sh
[2025-02-15 04:57:52] drwxrwx--x 2 yeti boinc      4096 Feb 15 01:45 shared
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc    503494 Feb 15 01:45 input.tar.gz
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc         0 Feb 15 01:45 boinc_lockfile
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc      2548 Feb 15 01:45 pandaJob.out
[2025-02-15 04:57:52] -rw------- 1 yeti boinc       462 Feb 15 01:45 setup.sh.local
[2025-02-15 04:57:52] -rw------- 1 yeti boinc    986630 Feb 15 01:45 agis_schedconf.cvmfs.json
[2025-02-15 04:57:52] drwx------ 4 yeti boinc      4096 Feb 15 01:45 pilot3
[2025-02-15 04:57:52] -rw------- 1 yeti boinc        95 Feb 15 04:56 pilot_heartbeat.json
[2025-02-15 04:57:52] -rw------- 1 yeti boinc 328266654 Feb 15 04:56 HITS.43078919._042008.pool.root.1
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc       531 Feb 15 04:57 boinc_task_state.xml
[2025-02-15 04:57:52] -rw------- 1 yeti boinc      1040 Feb 15 04:57 memory_monitor_summary.json
[2025-02-15 04:57:52] -rw------- 1 yeti boinc   1593946 Feb 15 04:57 agis_ddmendpoints.agis.ALL.json
[2025-02-15 04:57:52] -rw------- 1 yeti boinc    320787 Feb 15 04:57 log.43078919._042008.job.log.tgz.1
[2025-02-15 04:57:52] -rw------- 1 yeti boinc      7693 Feb 15 04:57 heartbeat.json
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc      8192 Feb 15 04:57 boinc_mmap_file
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc        28 Feb 15 04:57 wrapper_checkpoint.txt
[2025-02-15 04:57:52] -rw------- 1 yeti boinc      4363 Feb 15 04:57 pilotlog.txt
[2025-02-15 04:57:52] -rw------- 1 yeti boinc   1186645 Feb 15 04:57 log.43078919._042008.job.log.1
[2025-02-15 04:57:52] -rw------- 1 yeti boinc       357 Feb 15 04:57 output.list
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc       620 Feb 15 04:57 runtime_log
[2025-02-15 04:57:52] -rw------- 1 yeti boinc   1525760 Feb 15 04:57 result.tar.gz
[2025-02-15 04:57:52] -rw------- 1 yeti boinc       643 Feb 15 04:57 SUEODmIrD36nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmASdKDmB8JiLn.diag
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc     11617 Feb 15 04:57 runtime_log.err
[2025-02-15 04:57:52] -rw-r--r-- 1 yeti boinc     21218 Feb 15 04:57 stderr.txt
[2025-02-15 04:57:52] HITS file was successfully produced:
[2025-02-15 04:57:52] -rw------- 1 yeti boinc 328266654 Feb 15 04:56 shared/HITS.pool.root.1
[2025-02-15 04:57:52]  *** Contents of shared directory: ***
[2025-02-15 04:57:52] insgesamt 657548
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc 342997392 Feb 15 01:45 ATLAS.root_0
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc     17569 Feb 15 01:45 start_atlas.sh
[2025-02-15 04:57:52] -rw-r--r-- 2 yeti boinc    503494 Feb 15 01:45 input.tar.gz
[2025-02-15 04:57:52] -rw------- 1 yeti boinc 328266654 Feb 15 04:56 HITS.pool.root.1
[2025-02-15 04:57:52] -rw------- 1 yeti boinc   1525760 Feb 15 04:57 result.tar.gz
04:57:53 (1132476): run_atlas exited; CPU time 44444.775347
04:57:53 (1132476): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN