Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
22:33:31 (14812): wrapper (7.7.26015): starting
22:33:31 (14812): wrapper: running run_atlas (--nthreads 8)
[2025-10-23 22:33:31] Arguments: --nthreads 8
[2025-10-23 22:33:31] Threads: 8
[2025-10-23 22:33:31] Checking for CVMFS
[2025-10-23 22:33:32] Probing /cvmfs/atlas.cern.ch... OK
[2025-10-23 22:33:33] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-10-23 22:33:33] Running cvmfs_config stat atlas.cern.ch
[2025-10-23 22:33:34] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2025-10-23 22:33:34] 2.11.2.0 28846 236899 138164 152048 0 155 18169624 25165825 4632 130560 0 129807460 99.889 69050376 3999 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.73.11:3128/ 1
[2025-10-23 22:33:34] CVMFS is ok
[2025-10-23 22:33:34] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-10-23 22:33:34] Checking for apptainer binary...
[2025-10-23 22:33:34] Using apptainer found in PATH at /usr/bin/apptainer
[2025-10-23 22:33:34] Running /usr/bin/apptainer --version
[2025-10-23 22:33:34] apptainer version 1.3.2-1.el7
[2025-10-23 22:33:34] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-10-23 22:34:01] cg-vwn318.simple-grid.lan
[2025-10-23 22:34:01] apptainer works
[2025-10-23 22:34:01] Set ATHENA_PROC_NUMBER=8
[2025-10-23 22:34:01] Set ATHENA_CORE_NUMBER=8
[2025-10-23 22:34:01] Starting ATLAS job with PandaID=6854097774
[2025-10-23 22:34:01] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/12 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-10-24 03:21:19]  *** The last 200 lines of the pilot log: ***
[2025-10-24 03:21:19] 2025-10-24 01:20:19,034 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-10-24 03:21:19] 2025-10-24 01:20:19,041 | INFO     | fitting pss+swap vs Time
[2025-10-24 03:21:19] 2025-10-24 01:20:19,041 | INFO     | sum of square deviations: 6035722470.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,044 | INFO     | sum of deviations: 108359282663.00002
[2025-10-24 03:21:19] 2025-10-24 01:20:19,044 | INFO     | mean x: 1761260489.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,044 | INFO     | mean y: 2449065.6059479555
[2025-10-24 03:21:19] 2025-10-24 01:20:19,044 | INFO     | -- intersect: -31617447992.17322
[2025-10-24 03:21:19] 2025-10-24 01:20:19,044 | INFO     | intersect: -31617447992.17322
[2025-10-24 03:21:19] 2025-10-24 01:20:19,045 | INFO     | chi2: 6.939498012642357
[2025-10-24 03:21:19] 2025-10-24 01:20:19,045 | INFO     | sum of square deviations: 5705372090.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,048 | INFO     | sum of deviations: 123983631214.5
[2025-10-24 03:21:19] 2025-10-24 01:20:19,048 | INFO     | mean x: 1761260336.5
[2025-10-24 03:21:19] 2025-10-24 01:20:19,048 | INFO     | mean y: 2456153.632575758
[2025-10-24 03:21:19] 2025-10-24 01:20:19,048 | INFO     | -- intersect: -38271550973.10369
[2025-10-24 03:21:19] 2025-10-24 01:20:19,048 | INFO     | intersect: -38271550973.10369
[2025-10-24 03:21:19] 2025-10-24 01:20:19,049 | INFO     | chi2: 6.2211388671903185
[2025-10-24 03:21:19] 2025-10-24 01:20:19,049 | INFO     | current chi2=6.2211388671903185 (change=10.351745099477423 %)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,049 | INFO     | right removable region: 263
[2025-10-24 03:21:19] 2025-10-24 01:20:19,050 | INFO     | sum of square deviations: 5705372090.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,052 | INFO     | sum of deviations: 15291969952.000008
[2025-10-24 03:21:19] 2025-10-24 01:20:19,052 | INFO     | mean x: 1761260641.5
[2025-10-24 03:21:19] 2025-10-24 01:20:19,052 | INFO     | mean y: 2491996.742424242
[2025-10-24 03:21:19] 2025-10-24 01:20:19,052 | INFO     | -- intersect: -4718172034.03392
[2025-10-24 03:21:19] 2025-10-24 01:20:19,053 | INFO     | intersect: -4718172034.03392
[2025-10-24 03:21:19] 2025-10-24 01:20:19,053 | INFO     | chi2: 2.2144389613244204
[2025-10-24 03:21:19] 2025-10-24 01:20:19,053 | INFO     | current chi2=2.2144389613244204 (change=68.08934944155669 %)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,061 | INFO     | sum of square deviations: 5387301010.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,063 | INFO     | sum of deviations: -28698714957.000004
[2025-10-24 03:21:19] 2025-10-24 01:20:19,064 | INFO     | mean x: 1761260794.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,064 | INFO     | mean y: 2512965.115830116
[2025-10-24 03:21:19] 2025-10-24 01:20:19,064 | INFO     | -- intersect: 9384933104.276663
[2025-10-24 03:21:19] 2025-10-24 01:20:19,064 | INFO     | intersect: 9384933104.276663
[2025-10-24 03:21:19] 2025-10-24 01:20:19,064 | INFO     | chi2: 0.9238719204747614
[2025-10-24 03:21:19] 2025-10-24 01:20:19,065 | INFO     | current chi2=0.9238719204747614 (change=58.27963937546472 %)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,065 | INFO     | sum of square deviations: 5081276667.5
[2025-10-24 03:21:19] 2025-10-24 01:20:19,067 | INFO     | sum of deviations: -32312823833.500008
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | mean x: 1761260946.5
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | mean y: 2514765.6102362205
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | -- intersect: 11202714717.934124
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | intersect: 11202714717.934124
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | chi2: 0.9118291007463883
[2025-10-24 03:21:19] 2025-10-24 01:20:19,068 | INFO     | current chi2=0.9118291007463883 (change=1.3035161542938198 %)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,069 | INFO     | left removable region: 30
[2025-10-24 03:21:19] 2025-10-24 01:20:19,069 | INFO     | sum of square deviations: 3922276332.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,071 | INFO     | sum of deviations: 4356417479.999999
[2025-10-24 03:21:19] 2025-10-24 01:20:19,071 | INFO     | mean x: 1761261221.0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,071 | INFO     | mean y: 2512461.9785407726
[2025-10-24 03:21:19] 2025-10-24 01:20:19,071 | INFO     | -- intersect: -1953695749.924297
[2025-10-24 03:21:19] 2025-10-24 01:20:19,071 | INFO     | intersect: -1953695749.924297
[2025-10-24 03:21:19] 2025-10-24 01:20:19,072 | INFO     | chi2: 0.03187386433148521
[2025-10-24 03:21:19] 2025-10-24 01:20:19,072 | INFO     | -- intersect: -1953695749.924297
[2025-10-24 03:21:19] 2025-10-24 01:20:19,072 | INFO     | current memory leak: 1.11 B/s (using 233 data points, chi2=0.03)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,073 | INFO     | could have reported an average CPU frequency of 1999 MHz (12 samples)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,073 | INFO     | ..............................
[2025-10-24 03:21:19] 2025-10-24 01:20:19,073 | INFO     | . Timing measurements:
[2025-10-24 03:21:19] 2025-10-24 01:20:19,073 | INFO     | . get job = 0 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,073 | INFO     | . initial setup = 7 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | . payload setup = 116 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | . stage-in = 0 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | . payload execution = 16553 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | . stage-out = 4 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | . log creation = 1 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,074 | INFO     | ..............................
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | 
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | job summary report
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | --------------------------------------------------
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | PanDA job id: 6854097774
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | task id: 46771637
[2025-10-24 03:21:19] 2025-10-24 01:20:19,462 | INFO     | errors: (none)
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | status: LOG_TRANSFER = DONE 
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | pilot state: finished 
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | transexitcode: 0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | exeerrorcode: 0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | exeerrordiag: 
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | exitcode: 0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | exitmsg: OK
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | cpuconsumptiontime: 61987 s
[2025-10-24 03:21:19] 2025-10-24 01:20:19,463 | INFO     | nevents: 400
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | neventsw: 0
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | pid: 25167
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | pgrp: 25167
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | corecount: 8
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | event service: False
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | sizes: {0: 2348761, 1: 2348960, 12: 2348960, 23: 2348988, 34: 2349016, 44: 2349044, 55: 2349200, 66: 2349228, 77: 2349256, 85: 2349574, 87: 2349602, 16674: 2381051
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | --------------------------------------------------
[2025-10-24 03:21:19] 2025-10-24 01:20:19,464 | INFO     | 
[2025-10-24 03:21:19] 2025-10-24 01:20:19,465 | INFO     | executing command: ls -lF /var/lib/boinc/slots/12
[2025-10-24 03:21:19] 2025-10-24 01:20:19,557 | INFO     | time since job start (16960s) is within the limit (172800.0s)
[2025-10-24 03:21:19] 2025-10-24 01:20:20,043 | INFO     | queue jobs had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,043 | INFO     | queue payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue data_in had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue data_out had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,044 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue completed_jobids has 1 job(s)
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | queue messages had 0 job(s) [purged]
[2025-10-24 03:21:19] 2025-10-24 01:20:20,045 | INFO     | job 6854097774 has completed (purged errors)
[2025-10-24 03:21:19] 2025-10-24 01:20:20,046 | INFO     | overall cleanup function is called
[2025-10-24 03:21:19] 2025-10-24 01:20:21,055 | INFO     | --- collectZombieJob: --- 10, [25167]
[2025-10-24 03:21:19] 2025-10-24 01:20:21,055 | INFO     | zombie collector waiting for pid 25167
[2025-10-24 03:21:19] 2025-10-24 01:20:21,055 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-10-24 03:21:19] 2025-10-24 01:20:21,055 | INFO     | collected zombie processes
[2025-10-24 03:21:19] 2025-10-24 01:20:21,055 | INFO     | will attempt to kill all subprocesses of pid=25167
[2025-10-24 03:21:19] 2025-10-24 01:20:21,197 | INFO     | process IDs to be killed: [25167] (in reverse order)
[2025-10-24 03:21:19] 2025-10-24 01:20:22,081 | WARNING  | found no corresponding commands to process id(s)
[2025-10-24 03:21:19] 2025-10-24 01:20:22,082 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-10-24 03:21:19] 2025-10-24 01:20:22,085 | INFO     | did not find any defunct processes belonging to 25167
[2025-10-24 03:21:19] 2025-10-24 01:20:22,089 | INFO     | did not find any defunct processes belonging to 25167
[2025-10-24 03:21:19] 2025-10-24 01:20:22,089 | INFO     | ready for new job
[2025-10-24 03:21:19] 2025-10-24 01:20:22,090 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-10-24 03:21:19] 2025-10-24 01:20:22,092 | INFO     | ***************************************
[2025-10-24 03:21:19] 2025-10-24 01:20:22,092 | INFO     | ***  PanDA Pilot version 3.11.0.29  ***
[2025-10-24 03:21:19] 2025-10-24 01:20:22,092 | INFO     | ***************************************
[2025-10-24 03:21:19] 2025-10-24 01:20:22,092 | INFO     | 
[2025-10-24 03:21:19] 2025-10-24 01:20:22,093 | INFO     | pilot is running in a VM
[2025-10-24 03:21:19] 2025-10-24 01:20:22,093 | INFO     | architecture information:
[2025-10-24 03:21:19] 2025-10-24 01:20:22,101 | INFO     | executing command: cat /etc/os-release
[2025-10-24 03:21:19] 2025-10-24 01:20:22,277 | INFO     | cat /etc/os-release:
[2025-10-24 03:21:19] NAME="CentOS Linux"
[2025-10-24 03:21:19] VERSION="7 (Core)"
[2025-10-24 03:21:19] ID="centos"
[2025-10-24 03:21:19] ID_LIKE="rhel fedora"
[2025-10-24 03:21:19] VERSION_ID="7"
[2025-10-24 03:21:19] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-10-24 03:21:19] ANSI_COLOR="0;31"
[2025-10-24 03:21:19] CPE_NAME="cpe:/o:centos:centos:7"
[2025-10-24 03:21:19] HOME_URL="https://www.centos.org/"
[2025-10-24 03:21:19] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-10-24 03:21:19] 
[2025-10-24 03:21:19] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-10-24 03:21:19] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-10-24 03:21:19] REDHAT_SUPPORT_PRODUCT="centos"
[2025-10-24 03:21:19] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-10-24 03:21:19] 
[2025-10-24 03:21:19] 2025-10-24 01:20:22,277 | INFO     | ***************************************
[2025-10-24 03:21:19] 2025-10-24 01:20:22,781 | INFO     | executing command: df -mP /var/lib/boinc/slots/12
[2025-10-24 03:21:19] 2025-10-24 01:20:22,923 | INFO     | sufficient remaining disk space (496539533312 B)
[2025-10-24 03:21:19] 2025-10-24 01:20:22,924 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-10-24 03:21:19] 2025-10-24 01:20:22,924 | INFO     | current server update state: UPDATING_FINAL
[2025-10-24 03:21:19] 2025-10-24 01:20:22,924 | INFO     | update_server=False
[2025-10-24 03:21:19] 2025-10-24 01:20:22,924 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-10-24 03:21:19] 2025-10-24 01:20:22,932 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-10-24 03:21:19] 2025-10-24 01:20:23,283 | INFO     | all data control threads have been joined
[2025-10-24 03:21:19] 2025-10-24 01:20:23,342 | INFO     | all payload control threads have been joined
[2025-10-24 03:21:19] 2025-10-24 01:20:23,440 | INFO     | all job control threads have been joined
[2025-10-24 03:21:19] 2025-10-24 01:20:23,714 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-10-24 03:21:19] 2025-10-24 01:20:23,714 | INFO     | aborting loop
[2025-10-24 03:21:19] 2025-10-24 01:20:23,930 | INFO     | [job] retrieve thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,273 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-10-24 03:21:19] 2025-10-24 01:20:24,289 | INFO     | [data] control thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,348 | INFO     | [payload] control thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,439 | INFO     | [job] create_data_payload thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,446 | INFO     | [job] control thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,607 | INFO     | [payload] validate_post thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,658 | INFO     | [data] copytool_in thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,720 | INFO     | [job] job monitor thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,735 | INFO     | [payload] run_realtimelog thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,775 | INFO     | [payload] execute_payloads thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,803 | INFO     | [job] validate thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,815 | INFO     | [payload] validate_pre thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:24,939 | INFO     | [data] copytool_out thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:25,279 | INFO     | [job] queue monitor thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:25,294 | INFO     | [payload] failed_post thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:26,332 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-10-24 03:21:19] 2025-10-24 01:20:30,341 | INFO     | [data] queue_monitor thread has finished
[2025-10-24 03:21:19] 2025-10-24 01:20:52,722 | INFO     | PID=18609 has CPU usage=1.3% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR 
[2025-10-24 03:21:19] 2025-10-24 01:20:52,723 | INFO     | .. there are 9 such processes running
[2025-10-24 03:21:19] 2025-10-24 01:20:52,723 | INFO     | found 0 job(s) in 20 queues
[2025-10-24 03:21:19] 2025-10-24 01:20:52,724 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-10-24 03:21:19] 2025-10-24 01:20:52,724 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-10-24 03:21:19] 2025-10-24 01:21:08,315 | INFO     | [monitor] cgroup control has ended
[2025-10-24 03:21:19] 2025-10-24 01:21:09,521 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139725823358784)>', '<ExcThread(monitor, started 139725386004224)>']
[2025-10-24 03:21:19] 2025-10-24 01:21:09,824 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-10-24 03:21:19] 2025-10-24 01:21:09,824 | INFO     | [monitor] control thread has ended
[2025-10-24 03:21:19] 2025-10-24 01:21:14,547 | INFO     | all workflow threads have been joined
[2025-10-24 03:21:19] 2025-10-24 01:21:14,547 | INFO     | end of generic workflow (traces error code: 0)
[2025-10-24 03:21:19] 2025-10-24 01:21:14,547 | INFO     | traces error code: 0
[2025-10-24 03:21:19] 2025-10-24 01:21:14,548 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-10-24 03:21:19] 2025-10-24 01:21:14,994 [wrapper] ==== pilot stdout END ====
[2025-10-24 03:21:19] 2025-10-24 01:21:15,105 [wrapper] ==== wrapper stdout RESUME ====
[2025-10-24 03:21:19] 2025-10-24 01:21:15,226 [wrapper] pilotpid: 18609
[2025-10-24 03:21:19] 2025-10-24 01:21:15,356 [wrapper] Pilot exit status: 0
[2025-10-24 03:21:19] 2025-10-24 01:21:15,804 [wrapper] pandaids: 6854097774
[2025-10-24 03:21:19] 2025-10-24 01:21:16,356 [wrapper] cleanup supervisor_pilot 22332 18610
[2025-10-24 03:21:19] 2025-10-24 01:21:16,435 [wrapper] Test setup, not cleaning
[2025-10-24 03:21:19] 2025-10-24 01:21:16,498 [wrapper] apfmon messages muted
[2025-10-24 03:21:19] 2025-10-24 01:21:16,585 [wrapper] ==== wrapper stdout END ====
[2025-10-24 03:21:19] 2025-10-24 01:21:16,704 [wrapper] ==== wrapper stderr END ====
[2025-10-24 03:21:19]  *** Error codes and diagnostics ***
[2025-10-24 03:21:19]     "exeErrorCode": 0,
[2025-10-24 03:21:19]     "exeErrorDiag": "",
[2025-10-24 03:21:19]     "pilotErrorCode": 0,
[2025-10-24 03:21:19]     "pilotErrorDiag": "",
[2025-10-24 03:21:19]  *** Listing of results directory ***
[2025-10-24 03:21:19] total 435116
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc    557409 Oct 23 02:46 pilot3.tar.gz
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc      5112 Oct 23 02:50 queuedata.json
[2025-10-24 03:21:19] -rwx------. 1 boinc boinc     36292 Oct 23 02:54 runpilot2-wrapper.sh
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc       100 Oct 23 22:33 wrapper_26015_x86_64-pc-linux-gnu
[2025-10-24 03:21:19] -rwxr-xr-x. 1 boinc boinc      7986 Oct 23 22:33 run_atlas
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc       105 Oct 23 22:33 job.xml
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc 227067888 Oct 23 22:33 EVNT.46771634._003944.pool.root.1
[2025-10-24 03:21:19] drwxrwx--x. 2 boinc boinc        68 Oct 23 22:33 shared
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc    569680 Oct 23 22:33 input.tar.gz
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc      6390 Oct 23 22:33 init_data.xml
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc     15120 Oct 23 22:33 start_atlas.sh
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc         0 Oct 23 22:33 boinc_lockfile
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc      2560 Oct 23 22:34 pandaJob.out
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc    978508 Oct 23 22:37 agis_schedconf.cvmfs.json
[2025-10-24 03:21:19] drwx------. 5 boinc boinc      4096 Oct 23 22:37 pilot3
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc 209090824 Oct 24 03:17 HITS.46771637._097106.pool.root.1
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc       531 Oct 24 03:17 boinc_task_state.xml
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc      1016 Oct 24 03:18 memory_monitor_summary.json
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc   1560740 Oct 24 03:18 agis_ddmendpoints.agis.ALL.json
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc    490928 Oct 24 03:18 log.46771637._097106.job.log.tgz.1
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc      7778 Oct 24 03:20 heartbeat.json
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc        28 Oct 24 03:20 wrapper_checkpoint.txt
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc      8192 Oct 24 03:20 boinc_mmap_file
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc        95 Oct 24 03:20 pilot_heartbeat.json
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc      4885 Oct 24 03:21 pilotlog.txt
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc   2261652 Oct 24 03:21 log.46771637._097106.job.log.1
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc       357 Oct 24 03:21 output.list
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc       620 Oct 24 03:21 runtime_log
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc   2775040 Oct 24 03:21 result.tar.gz
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc      8717 Oct 24 03:21 runtime_log.err
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc       656 Oct 24 03:21 razKDmcmyV8nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmpJ7NDmje1Fon.diag
[2025-10-24 03:21:19] -rw-r--r--. 1 boinc boinc     20642 Oct 24 03:21 stderr.txt
[2025-10-24 03:21:19] HITS file was successfully produced:
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc 209090824 Oct 24 03:17 shared/HITS.pool.root.1
[2025-10-24 03:21:19]  *** Contents of shared directory: ***
[2025-10-24 03:21:19] total 429228
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc 227067888 Oct 23 22:33 ATLAS.root_0
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc    569680 Oct 23 22:33 input.tar.gz
[2025-10-24 03:21:19] -rw-r--r--. 2 boinc boinc     15120 Oct 23 22:33 start_atlas.sh
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc 209090824 Oct 24 03:17 HITS.pool.root.1
[2025-10-24 03:21:19] -rw-------. 1 boinc boinc   2775040 Oct 24 03:21 result.tar.gz
03:21:20 (14812): run_atlas exited; CPU time 62225.917631
03:21:20 (14812): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN