Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
05:57:11 (49786): wrapper (7.7.26015): starting
05:57:11 (49786): wrapper: running run_atlas (--nthreads 9)
[2025-10-13 05:57:11] Arguments: --nthreads 9
[2025-10-13 05:57:11] Threads: 9
[2025-10-13 05:57:11] Checking for CVMFS
[2025-10-13 05:57:12] Probing /cvmfs/atlas.cern.ch... OK
[2025-10-13 05:57:12] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-10-13 05:57:12] Running cvmfs_config stat atlas.cern.ch
[2025-10-13 05:57:12] 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-13 05:57:12] 2.13.2.0 5035 114107 393580 151656 2 478 37339413 40960000 13476 16776704 1 193766154 99.676 166611274 37362 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-10-13 05:57:12] CVMFS is ok
[2025-10-13 05:57:12] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-10-13 05:57:12] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-10-13 05:57:12] Further information can be found at the LHC@home message board.
[2025-10-13 05:57:12] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-10-13 05:57:12] Checking for apptainer binary...
[2025-10-13 05:57:12] Using apptainer found in PATH at /usr/bin/apptainer
[2025-10-13 05:57:12] Running /usr/bin/apptainer --version
[2025-10-13 05:57:12] apptainer version 1.4.3-1.el9
[2025-10-13 05:57:12] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-10-13 05:57:12] c-206-41.aglt2.org
[2025-10-13 05:57:12] apptainer works
[2025-10-13 05:57:12] Set ATHENA_PROC_NUMBER=9
[2025-10-13 05:57:12] Set ATHENA_CORE_NUMBER=9
[2025-10-13 05:57:12] Starting ATLAS job with PandaID=6841354205
[2025-10-13 05:57:12] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-10-13 12:53:23]  *** The last 200 lines of the pilot log: ***
[2025-10-13 12:53:23] 2025-10-13 16:52:39,061 | INFO     | fitting pss+swap vs Time
[2025-10-13 12:53:23] 2025-10-13 16:52:39,062 | INFO     | sum of square deviations: 21060083386.9975
[2025-10-13 12:53:23] 2025-10-13 16:52:39,064 | INFO     | sum of deviations: 53139286558.16174
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | mean x: 1760361931.002451
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | mean y: 2556114.838235294
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | -- intersect: -4439229578.915119
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | intersect: -4439229578.915119
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | chi2: 2.139995710972074
[2025-10-13 12:53:23] 2025-10-13 16:52:39,065 | INFO     | sum of square deviations: 20295306926.734543
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | sum of deviations: 78955889600.90828
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | mean x: 1760361778.5062034
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | mean y: 2561209.436724566
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | -- intersect: -6845865904.434847
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | intersect: -6845865904.434847
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | chi2: 1.4173325954004055
[2025-10-13 12:53:23] 2025-10-13 16:52:39,068 | INFO     | current chi2=1.4173325954004055 (change=33.76937214717151 %)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,069 | INFO     | sum of square deviations: 19549226201.98987
[2025-10-13 12:53:23] 2025-10-13 16:52:39,071 | INFO     | sum of deviations: 77493215729.10548
[2025-10-13 12:53:23] 2025-10-13 16:52:39,071 | INFO     | mean x: 1760361626.0050251
[2025-10-13 12:53:23] 2025-10-13 16:52:39,071 | INFO     | mean y: 2560910.447236181
[2025-10-13 12:53:23] 2025-10-13 16:52:39,071 | INFO     | -- intersect: -6975520054.791217
[2025-10-13 12:53:23] 2025-10-13 16:52:39,071 | INFO     | intersect: -6975520054.791217
[2025-10-13 12:53:23] 2025-10-13 16:52:39,072 | INFO     | chi2: 1.4175407811204157
[2025-10-13 12:53:23] 2025-10-13 16:52:39,072 | INFO     | current chi2=1.4175407811204157 (change=-0.014688557977560074 %)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,072 | INFO     | right removable region: 397
[2025-10-13 12:53:23] 2025-10-13 16:52:39,072 | INFO     | sum of square deviations: 20295206520.71958
[2025-10-13 12:53:23] 2025-10-13 16:52:39,074 | INFO     | sum of deviations: -6586823622.875942
[2025-10-13 12:53:23] 2025-10-13 16:52:39,074 | INFO     | mean x: 1760362083.5086849
[2025-10-13 12:53:23] 2025-10-13 16:52:39,074 | INFO     | mean y: 2567949.5359801487
[2025-10-13 12:53:23] 2025-10-13 16:52:39,074 | INFO     | -- intersect: 573894708.1295656
[2025-10-13 12:53:23] 2025-10-13 16:52:39,074 | INFO     | intersect: 573894708.1295656
[2025-10-13 12:53:23] 2025-10-13 16:52:39,075 | INFO     | chi2: 0.7832669201426979
[2025-10-13 12:53:23] 2025-10-13 16:52:39,075 | INFO     | current chi2=0.7832669201426979 (change=63.39866869233557 %)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,075 | INFO     | sum of square deviations: 19549074191.90953
[2025-10-13 12:53:23] 2025-10-13 16:52:39,077 | INFO     | sum of deviations: 7967796611.165825
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | mean x: 1760362236.0150754
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | mean y: 2564972.972361809
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | -- intersect: -714922112.1372757
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | intersect: -714922112.1372757
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | chi2: 0.7365859411404186
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | current chi2=0.7365859411404186 (change=5.959779201932187 %)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,078 | INFO     | left removable region: 20
[2025-10-13 12:53:23] 2025-10-13 16:52:39,079 | INFO     | sum of square deviations: 16615036858.1379
[2025-10-13 12:53:23] 2025-10-13 16:52:39,080 | INFO     | sum of deviations: 26370005696.413788
[2025-10-13 12:53:23] 2025-10-13 16:52:39,080 | INFO     | mean x: 1760362205.5172415
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | mean y: 2571490.5517241377
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | -- intersect: -2791329105.8531957
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | intersect: -2791329105.8531957
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | chi2: 0.0019445812429535246
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | -- intersect: -2791329105.8531957
[2025-10-13 12:53:23] 2025-10-13 16:52:39,081 | INFO     | current memory leak: 1.59 B/s (using 377 data points, chi2=0.00)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | could have reported an average CPU frequency of 3199 MHz (17 samples)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | ..............................
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . Timing measurements:
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . get job = 0 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . initial setup = 3 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . payload setup = 17 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . stage-in = 0 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . payload execution = 24841 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . stage-out = 1 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | . log creation = 0 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,082 | INFO     | ..............................
[2025-10-13 12:53:23] 2025-10-13 16:52:39,352 | INFO     | 
[2025-10-13 12:53:23] 2025-10-13 16:52:39,352 | INFO     | job summary report
[2025-10-13 12:53:23] 2025-10-13 16:52:39,352 | INFO     | --------------------------------------------------
[2025-10-13 12:53:23] 2025-10-13 16:52:39,352 | INFO     | PanDA job id: 6841354205
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | task id: 46676269
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | errors: (none)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | status: LOG_TRANSFER = DONE 
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | pilot state: finished 
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | transexitcode: 0
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | exeerrorcode: 0
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | exeerrordiag: 
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | exitcode: 0
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | exitmsg: OK
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | cpuconsumptiontime: 36624 s
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | nevents: 400
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | neventsw: 0
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | pid: 60124
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | pgrp: 60124
[2025-10-13 12:53:23] 2025-10-13 16:52:39,353 | INFO     | corecount: 9
[2025-10-13 12:53:23] 2025-10-13 16:52:39,354 | INFO     | event service: False
[2025-10-13 12:53:23] 2025-10-13 16:52:39,354 | INFO     | sizes: {0: 2348807, 11: 2348807, 13: 2349097, 22: 2349153, 24862: 2385030, 24865: 2394028, 24866: 2394212, 24871: 2394470}
[2025-10-13 12:53:23] 2025-10-13 16:52:39,354 | INFO     | --------------------------------------------------
[2025-10-13 12:53:23] 2025-10-13 16:52:39,354 | INFO     | 
[2025-10-13 12:53:23] 2025-10-13 16:52:39,354 | INFO     | executing command: ls -lF /tmp/boinchome/slots/1
[2025-10-13 12:53:23] 2025-10-13 16:52:39,379 | INFO     | queue jobs had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue data_in had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue data_out had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,380 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue completed_jobids has 1 job(s)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | queue messages had 0 job(s) [purged]
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | job 6841354205 has completed (purged errors)
[2025-10-13 12:53:23] 2025-10-13 16:52:39,381 | INFO     | overall cleanup function is called
[2025-10-13 12:53:23] 2025-10-13 16:52:40,390 | INFO     | --- collectZombieJob: --- 10, [60124]
[2025-10-13 12:53:23] 2025-10-13 16:52:40,390 | INFO     | zombie collector waiting for pid 60124
[2025-10-13 12:53:23] 2025-10-13 16:52:40,390 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-10-13 12:53:23] 2025-10-13 16:52:40,390 | INFO     | collected zombie processes
[2025-10-13 12:53:23] 2025-10-13 16:52:40,390 | INFO     | will attempt to kill all subprocesses of pid=60124
[2025-10-13 12:53:23] 2025-10-13 16:52:40,628 | INFO     | process IDs to be killed: [60124] (in reverse order)
[2025-10-13 12:53:23] 2025-10-13 16:52:40,729 | WARNING  | found no corresponding commands to process id(s)
[2025-10-13 12:53:23] 2025-10-13 16:52:40,730 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-10-13 12:53:23] 2025-10-13 16:52:40,742 | INFO     | did not find any defunct processes belonging to 60124
[2025-10-13 12:53:23] 2025-10-13 16:52:40,754 | INFO     | did not find any defunct processes belonging to 60124
[2025-10-13 12:53:23] 2025-10-13 16:52:40,755 | INFO     | ready for new job
[2025-10-13 12:53:23] 2025-10-13 16:52:40,755 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-10-13 12:53:23] 2025-10-13 16:52:40,758 | INFO     | ***************************************
[2025-10-13 12:53:23] 2025-10-13 16:52:40,758 | INFO     | ***  PanDA Pilot version 3.11.0.29  ***
[2025-10-13 12:53:23] 2025-10-13 16:52:40,758 | INFO     | ***************************************
[2025-10-13 12:53:23] 2025-10-13 16:52:40,758 | INFO     | 
[2025-10-13 12:53:23] 2025-10-13 16:52:40,762 | INFO     | architecture information:
[2025-10-13 12:53:23] 2025-10-13 16:52:40,762 | INFO     | executing command: cat /etc/os-release
[2025-10-13 12:53:23] 2025-10-13 16:52:40,784 | INFO     | cat /etc/os-release:
[2025-10-13 12:53:23] NAME="CentOS Linux"
[2025-10-13 12:53:23] VERSION="7 (Core)"
[2025-10-13 12:53:23] ID="centos"
[2025-10-13 12:53:23] ID_LIKE="rhel fedora"
[2025-10-13 12:53:23] VERSION_ID="7"
[2025-10-13 12:53:23] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-10-13 12:53:23] ANSI_COLOR="0;31"
[2025-10-13 12:53:23] CPE_NAME="cpe:/o:centos:centos:7"
[2025-10-13 12:53:23] HOME_URL="https://www.centos.org/"
[2025-10-13 12:53:23] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-10-13 12:53:23] 
[2025-10-13 12:53:23] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-10-13 12:53:23] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-10-13 12:53:23] REDHAT_SUPPORT_PRODUCT="centos"
[2025-10-13 12:53:23] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-10-13 12:53:23] 
[2025-10-13 12:53:23] 2025-10-13 16:52:40,784 | INFO     | ***************************************
[2025-10-13 12:53:23] 2025-10-13 16:52:41,286 | INFO     | executing command: df -mP /tmp/boinchome/slots/1
[2025-10-13 12:53:23] 2025-10-13 16:52:41,304 | INFO     | sufficient remaining disk space (86008397824 B)
[2025-10-13 12:53:23] 2025-10-13 16:52:41,305 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-10-13 12:53:23] 2025-10-13 16:52:41,305 | INFO     | current server update state: UPDATING_FINAL
[2025-10-13 12:53:23] 2025-10-13 16:52:41,305 | INFO     | update_server=False
[2025-10-13 12:53:23] 2025-10-13 16:52:41,305 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-10-13 12:53:23] 2025-10-13 16:52:41,319 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-10-13 12:53:23] 2025-10-13 16:52:41,689 | INFO     | all payload control threads have been joined
[2025-10-13 12:53:23] 2025-10-13 16:52:41,761 | WARNING  | job monitor detected an abort_job request (signal=args.signal)
[2025-10-13 12:53:23] 2025-10-13 16:52:41,762 | WARNING  | cannot recover job monitoring - aborting pilot
[2025-10-13 12:53:23] 2025-10-13 16:52:41,762 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-10-13 12:53:23] 2025-10-13 16:52:41,762 | INFO     | will abort loop
[2025-10-13 12:53:23] 2025-10-13 16:52:42,084 | INFO     | all job control threads have been joined
[2025-10-13 12:53:23] 2025-10-13 16:52:42,310 | INFO     | [job] retrieve thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:42,377 | INFO     | all data control threads have been joined
[2025-10-13 12:53:23] 2025-10-13 16:52:42,462 | INFO     | [payload] failed_post thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:42,695 | INFO     | [payload] control thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:42,767 | INFO     | [job] job monitor thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:42,985 | INFO     | [payload] execute_payloads thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,089 | INFO     | [job] control thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,208 | INFO     | [payload] validate_pre thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,268 | INFO     | [job] validate thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,324 | INFO     | [data] copytool_out thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,382 | INFO     | [data] control thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,406 | INFO     | [job] create_data_payload thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,576 | INFO     | [data] copytool_in thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:43,877 | INFO     | [payload] validate_post thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:44,151 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-10-13 12:53:23] 2025-10-13 16:52:44,743 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-10-13 12:53:23] 2025-10-13 16:52:45,157 | INFO     | [job] queue monitor thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:48,750 | INFO     | [data] queue_monitor thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:52:51,906 | INFO     | job.realtimelogging is not enabled
[2025-10-13 12:53:23] 2025-10-13 16:52:52,907 | INFO     | [payload] run_realtimelog thread has finished
[2025-10-13 12:53:23] 2025-10-13 16:53:11,203 | INFO     | PID=53447 has CPU usage=2.0% 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-13 12:53:23] 2025-10-13 16:53:11,203 | INFO     | .. there are 10 such processes running
[2025-10-13 12:53:23] 2025-10-13 16:53:11,203 | INFO     | found 0 job(s) in 20 queues
[2025-10-13 12:53:23] 2025-10-13 16:53:11,203 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-10-13 12:53:23] 2025-10-13 16:53:11,203 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-10-13 12:53:23] 2025-10-13 16:53:16,378 | INFO     | [monitor] cgroup control has ended
[2025-10-13 12:53:23] 2025-10-13 16:53:18,331 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139975935956800)>', '<ExcThread(monitor, started 139975450416896)>']
[2025-10-13 12:53:23] 2025-10-13 16:53:19,249 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-10-13 12:53:23] 2025-10-13 16:53:19,249 | INFO     | [monitor] control thread has ended
[2025-10-13 12:53:23] 2025-10-13 16:53:23,356 | INFO     | all workflow threads have been joined
[2025-10-13 12:53:23] 2025-10-13 16:53:23,357 | INFO     | end of generic workflow (traces error code: 0)
[2025-10-13 12:53:23] 2025-10-13 16:53:23,357 | INFO     | traces error code: 0
[2025-10-13 12:53:23] 2025-10-13 16:53:23,357 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-10-13 12:53:23] 2025-10-13 16:53:23,508 [wrapper] ==== pilot stdout END ====
[2025-10-13 12:53:23] 2025-10-13 16:53:23,513 [wrapper] ==== wrapper stdout RESUME ====
[2025-10-13 12:53:23] 2025-10-13 16:53:23,522 [wrapper] pilotpid: 53447
[2025-10-13 12:53:23] 2025-10-13 16:53:23,528 [wrapper] Pilot exit status: 0
[2025-10-13 12:53:23] 2025-10-13 16:53:23,544 [wrapper] pandaids: 6841354205
[2025-10-13 12:53:23] 2025-10-13 16:53:23,631 [wrapper] cleanup supervisor_pilot  734919 53448
[2025-10-13 12:53:23] 2025-10-13 16:53:23,635 [wrapper] Test setup, not cleaning
[2025-10-13 12:53:23] 2025-10-13 16:53:23,639 [wrapper] apfmon messages muted
[2025-10-13 12:53:23] 2025-10-13 16:53:23,644 [wrapper] ==== wrapper stdout END ====
[2025-10-13 12:53:23] 2025-10-13 16:53:23,648 [wrapper] ==== wrapper stderr END ====
[2025-10-13 12:53:23]  *** Error codes and diagnostics ***
[2025-10-13 12:53:23]     "exeErrorCode": 0,
[2025-10-13 12:53:23]     "exeErrorDiag": "",
[2025-10-13 12:53:23]     "pilotErrorCode": 0,
[2025-10-13 12:53:23]     "pilotErrorDiag": "",
[2025-10-13 12:53:23]  *** Listing of results directory ***
[2025-10-13 12:53:23] total 419072
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas    557409 Oct 12 22:00 pilot3.tar.gz
[2025-10-13 12:53:23] -rwx------. 1 boincer umatlas     36292 Oct 12 22:33 runpilot2-wrapper.sh
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas      5112 Oct 12 22:33 queuedata.json
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas       100 Oct 13 05:57 wrapper_26015_x86_64-pc-linux-gnu
[2025-10-13 12:53:23] -rwxr-xr-x. 1 boincer umatlas      7986 Oct 13 05:57 run_atlas
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas       105 Oct 13 05:57 job.xml
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas 221061763 Oct 13 05:57 EVNT.46676267._001697.pool.root.1
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas     15120 Oct 13 05:57 start_atlas.sh
[2025-10-13 12:53:23] drwxrwx--x. 2 boincer umatlas      4096 Oct 13 05:57 shared
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas    569682 Oct 13 05:57 input.tar.gz
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas         0 Oct 13 05:57 boinc_lockfile
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas      2550 Oct 13 05:57 pandaJob.out
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas    972849 Oct 13 05:57 agis_schedconf.cvmfs.json
[2025-10-13 12:53:23] drwx------. 5 boincer umatlas      4096 Oct 13 05:57 pilot3
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas      6899 Oct 13 12:46 init_data.xml
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas 196587113 Oct 13 12:52 HITS.46676269._095065.pool.root.1
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas       531 Oct 13 12:52 boinc_task_state.xml
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas        95 Oct 13 12:52 pilot_heartbeat.json
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas      1042 Oct 13 12:52 memory_monitor_summary.json
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas   1560580 Oct 13 12:52 agis_ddmendpoints.agis.ALL.json
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas    607971 Oct 13 12:52 log.46676269._095065.job.log.tgz.1
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas      7794 Oct 13 12:52 heartbeat.json
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas      8192 Oct 13 12:53 boinc_mmap_file
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas        28 Oct 13 12:53 wrapper_checkpoint.txt
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas      5080 Oct 13 12:53 pilotlog.txt
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas   3185675 Oct 13 12:53 log.46676269._095065.job.log.1
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas       357 Oct 13 12:53 output.list
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas       620 Oct 13 12:53 runtime_log
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas   3809280 Oct 13 12:53 result.tar.gz
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas      8704 Oct 13 12:53 runtime_log.err
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas       659 Oct 13 12:53 jKBMDm3XNS8nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmMWmNDmn10bUn.diag
[2025-10-13 12:53:23] -rw-r--r--. 1 boincer umatlas     20987 Oct 13 12:53 stderr.txt
[2025-10-13 12:53:23] HITS file was successfully produced:
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas 196587113 Oct 13 12:52 shared/HITS.pool.root.1
[2025-10-13 12:53:23]  *** Contents of shared directory: ***
[2025-10-13 12:53:23] total 412164
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas 221061763 Oct 13 05:57 ATLAS.root_0
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas     15120 Oct 13 05:57 start_atlas.sh
[2025-10-13 12:53:23] -rw-r--r--. 2 boincer umatlas    569682 Oct 13 05:57 input.tar.gz
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas 196587113 Oct 13 12:52 HITS.pool.root.1
[2025-10-13 12:53:23] -rw-------. 1 boincer umatlas   3809280 Oct 13 12:53 result.tar.gz
12:53:24 (49786): run_atlas exited; CPU time 36900.020914
12:53:24 (49786): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN