Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
09:24:13 (17367): wrapper (7.7.26015): starting
09:24:13 (17367): wrapper: running run_atlas (--nthreads 10)
[2025-04-28 09:24:13] Arguments: --nthreads 10
[2025-04-28 09:24:13] Threads: 10
[2025-04-28 09:24:13] Checking for CVMFS
[2025-04-28 09:24:13] Probing /cvmfs/atlas.cern.ch... OK
[2025-04-28 09:24:13] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-04-28 09:24:13] Running cvmfs_config stat atlas.cern.ch
[2025-04-28 09:24:13] 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-04-28 09:24:13] 2.11.2.0 38461 230113 297036 145374 3 133 11211466 18432001 8599 130560 0 60724291 99.489 75753451 44011 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-04-28 09:24:13] CVMFS is ok
[2025-04-28 09:24:13] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-04-28 09:24:13] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-04-28 09:24:13] Further information can be found at the LHC@home message board.
[2025-04-28 09:24:13] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-04-28 09:24:13] Checking for apptainer binary...
[2025-04-28 09:24:13] Using apptainer found in PATH at /usr/bin/apptainer
[2025-04-28 09:24:13] Running /usr/bin/apptainer --version
[2025-04-28 09:24:14] apptainer version 1.3.2-1.el7
[2025-04-28 09:24:14] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-04-28 09:24:18] c-211-4.aglt2.org
[2025-04-28 09:24:18] apptainer works
[2025-04-28 09:24:18] Set ATHENA_PROC_NUMBER=10
[2025-04-28 09:24:18] Set ATHENA_CORE_NUMBER=10
[2025-04-28 09:24:18] Starting ATLAS job with PandaID=6618080187
[2025-04-28 09:24:18] 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-04-28 17:22:36]  *** The last 200 lines of the pilot log: ***
[2025-04-28 17:22:36] 2025-04-28 21:22:21,381 | INFO     | intersect: -23907628372.562695
[2025-04-28 17:22:36] 2025-04-28 21:22:21,447 | INFO     | chi2: 6.7376253693773185
[2025-04-28 17:22:36] 2025-04-28 21:22:21,447 | INFO     | current chi2=6.7376253693773185 (change=10.2141067775322 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:21,448 | INFO     | right removable region: 463
[2025-04-28 17:22:36] 2025-04-28 21:22:21,448 | INFO     | sum of square deviations: 30976047557.508606
[2025-04-28 17:22:36] 2025-04-28 21:22:21,510 | INFO     | sum of deviations: 258909495318.22827
[2025-04-28 17:22:36] 2025-04-28 21:22:21,510 | INFO     | mean x: 1745861135.3232758
[2025-04-28 17:22:36] 2025-04-28 21:22:21,510 | INFO     | mean y: 2534535.691810345
[2025-04-28 17:22:36] 2025-04-28 21:22:21,540 | INFO     | -- intersect: -14590031691.586226
[2025-04-28 17:22:36] 2025-04-28 21:22:21,540 | INFO     | intersect: -14590031691.586226
[2025-04-28 17:22:36] 2025-04-28 21:22:21,541 | INFO     | chi2: 4.311950383354153
[2025-04-28 17:22:36] 2025-04-28 21:22:21,541 | INFO     | current chi2=4.311950383354153 (change=42.53875876506397 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:21,542 | INFO     | sum of square deviations: 29985317762.745087
[2025-04-28 17:22:36] 2025-04-28 21:22:21,748 | INFO     | sum of deviations: 160597039334.7124
[2025-04-28 17:22:36] 2025-04-28 21:22:21,749 | INFO     | mean x: 1745861287.8300653
[2025-04-28 17:22:36] 2025-04-28 21:22:21,749 | INFO     | mean y: 2549664.2527233115
[2025-04-28 17:22:36] 2025-04-28 21:22:21,749 | INFO     | -- intersect: -9348031714.709742
[2025-04-28 17:22:36] 2025-04-28 21:22:21,749 | INFO     | intersect: -9348031714.709742
[2025-04-28 17:22:36] 2025-04-28 21:22:21,750 | INFO     | chi2: 2.8014349846643265
[2025-04-28 17:22:36] 2025-04-28 21:22:21,750 | INFO     | current chi2=2.8014349846643265 (change=35.03090862364785 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:21,781 | INFO     | sum of square deviations: 29015965083.11034
[2025-04-28 17:22:36] 2025-04-28 21:22:21,884 | INFO     | sum of deviations: 65932982801.33476
[2025-04-28 17:22:36] 2025-04-28 21:22:21,885 | INFO     | mean x: 1745861440.3348017
[2025-04-28 17:22:36] 2025-04-28 21:22:21,885 | INFO     | mean y: 2564559.497797357
[2025-04-28 17:22:36] 2025-04-28 21:22:21,885 | INFO     | -- intersect: -3964556712.856895
[2025-04-28 17:22:36] 2025-04-28 21:22:21,885 | INFO     | intersect: -3964556712.856895
[2025-04-28 17:22:36] 2025-04-28 21:22:21,913 | INFO     | chi2: 1.4030601621150873
[2025-04-28 17:22:36] 2025-04-28 21:22:21,913 | INFO     | current chi2=1.4030601621150873 (change=49.91637607884001 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:21,914 | INFO     | sum of square deviations: 28067673567.086906
[2025-04-28 17:22:36] 2025-04-28 21:22:22,042 | INFO     | sum of deviations: 12892554936.75499
[2025-04-28 17:22:36] 2025-04-28 21:22:22,043 | INFO     | mean x: 1745861592.844098
[2025-04-28 17:22:36] 2025-04-28 21:22:22,043 | INFO     | mean y: 2573073.5679287305
[2025-04-28 17:22:36] 2025-04-28 21:22:22,043 | INFO     | -- intersect: -799367865.4954166
[2025-04-28 17:22:36] 2025-04-28 21:22:22,043 | INFO     | intersect: -799367865.4954166
[2025-04-28 17:22:36] 2025-04-28 21:22:22,073 | INFO     | chi2: 0.9164438322509187
[2025-04-28 17:22:36] 2025-04-28 21:22:22,073 | INFO     | current chi2=0.9164438322509187 (change=34.682499225878054 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,074 | INFO     | sum of square deviations: 27140266163.48424
[2025-04-28 17:22:36] 2025-04-28 21:22:22,172 | INFO     | sum of deviations: -10125697925.630627
[2025-04-28 17:22:36] 2025-04-28 21:22:22,173 | INFO     | mean x: 1745861745.3536036
[2025-04-28 17:22:36] 2025-04-28 21:22:22,173 | INFO     | mean y: 2576856.1441441444
[2025-04-28 17:22:36] 2025-04-28 21:22:22,173 | INFO     | -- intersect: 653936299.2268996
[2025-04-28 17:22:36] 2025-04-28 21:22:22,173 | INFO     | intersect: 653936299.2268996
[2025-04-28 17:22:36] 2025-04-28 21:22:22,174 | INFO     | chi2: 0.8320271878388596
[2025-04-28 17:22:36] 2025-04-28 21:22:22,174 | INFO     | current chi2=0.8320271878388596 (change=9.211327682212623 %)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,174 | INFO     | left removable region: 50
[2025-04-28 17:22:36] 2025-04-28 21:22:22,175 | INFO     | sum of square deviations: 21843067991.990192
[2025-04-28 17:22:36] 2025-04-28 21:22:22,180 | INFO     | sum of deviations: 25452716616.13318
[2025-04-28 17:22:36] 2025-04-28 21:22:22,180 | INFO     | mean x: 1745862324.8523002
[2025-04-28 17:22:36] 2025-04-28 21:22:22,180 | INFO     | mean y: 2581017.2808716707
[2025-04-28 17:22:36] 2025-04-28 21:22:22,181 | INFO     | -- intersect: -2031791581.9137092
[2025-04-28 17:22:36] 2025-04-28 21:22:22,181 | INFO     | intersect: -2031791581.9137092
[2025-04-28 17:22:36] 2025-04-28 21:22:22,181 | INFO     | chi2: 0.003553225037969432
[2025-04-28 17:22:36] 2025-04-28 21:22:22,182 | INFO     | -- intersect: -2031791581.9137092
[2025-04-28 17:22:36] 2025-04-28 21:22:22,182 | INFO     | current memory leak: 1.17 B/s (using 413 data points, chi2=0.00)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | ..............................
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . Timing measurements:
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . get job = 0 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . initial setup = 2 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . payload setup = 10 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . stage-in = 0 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,183 | INFO     | . payload execution = 28599 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,184 | INFO     | . stage-out = 5 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,184 | INFO     | . log creation = 0 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,184 | INFO     | ..............................
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | 
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | job summary report
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | --------------------------------------------------
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | PanDA job id: 6618080187
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | task id: 44292257
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | errors: (none)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | status: LOG_TRANSFER = DONE 
[2025-04-28 17:22:36] 2025-04-28 21:22:22,450 | INFO     | pilot state: finished 
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | transexitcode: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | exeerrorcode: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | exeerrordiag: 
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | exitcode: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | exitmsg: OK
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | cpuconsumptiontime: 57829 s
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | nevents: 400
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | neventsw: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | pid: 28744
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | pgrp: 28744
[2025-04-28 17:22:36] 2025-04-28 21:22:22,451 | INFO     | corecount: 10
[2025-04-28 17:22:36] 2025-04-28 21:22:22,452 | INFO     | event service: False
[2025-04-28 17:22:36] 2025-04-28 21:22:22,452 | INFO     | sizes: {0: 2393682, 5: 2393888, 11: 2393944, 28615: 2430289, 28621: 2439258, 28623: 2439314, 28653: 2439612}
[2025-04-28 17:22:36] 2025-04-28 21:22:22,452 | INFO     | --------------------------------------------------
[2025-04-28 17:22:36] 2025-04-28 21:22:22,452 | INFO     | 
[2025-04-28 17:22:36] 2025-04-28 21:22:22,452 | INFO     | executing command: ls -lF /tmp/boinchome/slots/0
[2025-04-28 17:22:36] 2025-04-28 21:22:22,552 | INFO     | queue jobs had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue data_in had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue data_out had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,553 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,554 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,555 | INFO     | queue completed_jobids has 1 job(s)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,555 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,555 | INFO     | queue messages had 0 job(s) [purged]
[2025-04-28 17:22:36] 2025-04-28 21:22:22,555 | INFO     | job 6618080187 has completed (purged errors)
[2025-04-28 17:22:36] 2025-04-28 21:22:22,555 | INFO     | overall cleanup function is called
[2025-04-28 17:22:36] 2025-04-28 21:22:22,651 | INFO     | PID=22275 has CPU usage=2.4% 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-04-28 17:22:36] 2025-04-28 21:22:22,652 | INFO     | .. there are 7 such processes running
[2025-04-28 17:22:36] 2025-04-28 21:22:23,602 | INFO     | --- collectZombieJob: --- 10, [28744]
[2025-04-28 17:22:36] 2025-04-28 21:22:23,602 | INFO     | zombie collector waiting for pid 28744
[2025-04-28 17:22:36] 2025-04-28 21:22:23,602 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-04-28 17:22:36] 2025-04-28 21:22:23,602 | INFO     | collected zombie processes
[2025-04-28 17:22:36] 2025-04-28 21:22:23,602 | INFO     | will attempt to kill all subprocesses of pid=28744
[2025-04-28 17:22:36] 2025-04-28 21:22:25,065 | INFO     | process IDs to be killed: [28744] (in reverse order)
[2025-04-28 17:22:36] 2025-04-28 21:22:25,167 | WARNING  | found no corresponding commands to process id(s)
[2025-04-28 17:22:36] 2025-04-28 21:22:25,167 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-04-28 17:22:36] 2025-04-28 21:22:25,173 | INFO     | did not find any defunct processes belonging to 28744
[2025-04-28 17:22:36] 2025-04-28 21:22:25,179 | INFO     | did not find any defunct processes belonging to 28744
[2025-04-28 17:22:36] 2025-04-28 21:22:25,179 | INFO     | ready for new job
[2025-04-28 17:22:36] 2025-04-28 21:22:25,179 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-04-28 17:22:36] 2025-04-28 21:22:25,181 | INFO     | **************************************
[2025-04-28 17:22:36] 2025-04-28 21:22:25,182 | INFO     | ***  PanDA Pilot version 3.10.2.2  ***
[2025-04-28 17:22:36] 2025-04-28 21:22:25,182 | INFO     | **************************************
[2025-04-28 17:22:36] 2025-04-28 21:22:25,182 | INFO     | 
[2025-04-28 17:22:36] 2025-04-28 21:22:25,184 | INFO     | architecture information:
[2025-04-28 17:22:36] 2025-04-28 21:22:25,185 | INFO     | executing command: cat /etc/os-release
[2025-04-28 17:22:36] 2025-04-28 21:22:25,223 | INFO     | cat /etc/os-release:
[2025-04-28 17:22:36] NAME="CentOS Linux"
[2025-04-28 17:22:36] VERSION="7 (Core)"
[2025-04-28 17:22:36] ID="centos"
[2025-04-28 17:22:36] ID_LIKE="rhel fedora"
[2025-04-28 17:22:36] VERSION_ID="7"
[2025-04-28 17:22:36] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-04-28 17:22:36] ANSI_COLOR="0;31"
[2025-04-28 17:22:36] CPE_NAME="cpe:/o:centos:centos:7"
[2025-04-28 17:22:36] HOME_URL="https://www.centos.org/"
[2025-04-28 17:22:36] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-04-28 17:22:36] 
[2025-04-28 17:22:36] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-04-28 17:22:36] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-04-28 17:22:36] REDHAT_SUPPORT_PRODUCT="centos"
[2025-04-28 17:22:36] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-04-28 17:22:36] 
[2025-04-28 17:22:36] 2025-04-28 21:22:25,224 | INFO     | **************************************
[2025-04-28 17:22:36] 2025-04-28 21:22:25,725 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2025-04-28 17:22:36] 2025-04-28 21:22:25,747 | INFO     | sufficient remaining disk space (56892588032 B)
[2025-04-28 17:22:36] 2025-04-28 21:22:25,747 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-04-28 17:22:36] 2025-04-28 21:22:25,747 | INFO     | current server update state: UPDATING_FINAL
[2025-04-28 17:22:36] 2025-04-28 21:22:25,747 | INFO     | update_server=False
[2025-04-28 17:22:36] 2025-04-28 21:22:25,748 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-04-28 17:22:36] 2025-04-28 21:22:25,748 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-04-28 17:22:36] 2025-04-28 21:22:25,751 | WARNING  | job monitor detected an abort_job request (signal=args.signal)
[2025-04-28 17:22:36] 2025-04-28 21:22:25,751 | WARNING  | cannot recover job monitoring - aborting pilot
[2025-04-28 17:22:36] 2025-04-28 21:22:25,751 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-04-28 17:22:36] 2025-04-28 21:22:25,751 | INFO     | will abort loop
[2025-04-28 17:22:36] 2025-04-28 21:22:26,265 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-04-28 17:22:36] 2025-04-28 21:22:26,684 | INFO     | all job control threads have been joined
[2025-04-28 17:22:36] 2025-04-28 21:22:26,698 | INFO     | found 0 job(s) in 20 queues
[2025-04-28 17:22:36] 2025-04-28 21:22:26,698 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-04-28 17:22:36] 2025-04-28 21:22:26,698 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-04-28 17:22:36] 2025-04-28 21:22:26,736 | INFO     | all payload control threads have been joined
[2025-04-28 17:22:36] 2025-04-28 21:22:26,754 | INFO     | [job] retrieve thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:26,763 | INFO     | [job] job monitor thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:26,767 | INFO     | [payload] run_realtimelog thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:26,779 | INFO     | [payload] validate_pre thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:26,785 | INFO     | all data control threads have been joined
[2025-04-28 17:22:36] 2025-04-28 21:22:26,790 | INFO     | [job] validate thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:26,964 | INFO     | [job] create_data_payload thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,166 | INFO     | [data] copytool_in thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,334 | INFO     | [payload] execute_payloads thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,474 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-04-28 17:22:36] 2025-04-28 21:22:27,690 | INFO     | [job] control thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,742 | INFO     | [payload] control thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,757 | INFO     | [payload] validate_post thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:27,791 | INFO     | [data] control thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:28,135 | INFO     | [payload] failed_post thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:28,273 | INFO     | [data] copytool_out thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:28,479 | INFO     | [job] queue monitor thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:29,765 | INFO     | [data] queue_monitor thread has finished
[2025-04-28 17:22:36] 2025-04-28 21:22:29,780 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140012718253888)>', '<ExcThread(monitor, started 140012276397824)>']
[2025-04-28 17:22:36] 2025-04-28 21:22:30,722 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-04-28 17:22:36] 2025-04-28 21:22:30,722 | INFO     | [monitor] control thread has ended
[2025-04-28 17:22:36] 2025-04-28 21:22:34,806 | INFO     | all workflow threads have been joined
[2025-04-28 17:22:36] 2025-04-28 21:22:34,806 | INFO     | end of generic workflow (traces error code: 0)
[2025-04-28 17:22:36] 2025-04-28 21:22:34,806 | INFO     | traces error code: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:34,806 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-04-28 17:22:36] 2025-04-28 21:22:35,203 [wrapper] ==== pilot stdout END ====
[2025-04-28 17:22:36] 2025-04-28 21:22:35,208 [wrapper] ==== wrapper stdout RESUME ====
[2025-04-28 17:22:36] 2025-04-28 21:22:35,212 [wrapper] pilotpid: 22275
[2025-04-28 17:22:36] 2025-04-28 21:22:35,215 [wrapper] Pilot exit status: 0
[2025-04-28 17:22:36] 2025-04-28 21:22:35,257 [wrapper] pandaids: 6618080187
[2025-04-28 17:22:36] 2025-04-28 21:22:35,365 [wrapper] cleanup supervisor_pilot 13904 22276
[2025-04-28 17:22:36] 2025-04-28 21:22:35,433 [wrapper] Test setup, not cleaning
[2025-04-28 17:22:36] 2025-04-28 21:22:35,504 [wrapper] apfmon messages muted
[2025-04-28 17:22:36] 2025-04-28 21:22:35,540 [wrapper] ==== wrapper stdout END ====
[2025-04-28 17:22:36] 2025-04-28 21:22:35,584 [wrapper] ==== wrapper stderr END ====
[2025-04-28 17:22:36]  *** Error codes and diagnostics ***
[2025-04-28 17:22:36]     "exeErrorCode": 0,
[2025-04-28 17:22:36]     "exeErrorDiag": "",
[2025-04-28 17:22:36]     "pilotErrorCode": 0,
[2025-04-28 17:22:36]     "pilotErrorDiag": "",
[2025-04-28 17:22:36]  *** Listing of results directory ***
[2025-04-28 17:22:36] total 419908
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas    495897 Apr 27 22:42 pilot3.tar.gz
[2025-04-28 17:22:36] -rwx------ 1 boincer umatlas     37140 Apr 27 22:43 runpilot2-wrapper.sh
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas      5111 Apr 27 22:43 queuedata.json
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas       100 Apr 28 09:24 wrapper_26015_x86_64-pc-linux-gnu
[2025-04-28 17:22:36] -rwxr-xr-x 1 boincer umatlas      7986 Apr 28 09:24 run_atlas
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas       105 Apr 28 09:24 job.xml
[2025-04-28 17:22:36] -rw-r--r-- 2 boincer umatlas 223200578 Apr 28 09:24 EVNT.44292255._003084.pool.root.1
[2025-04-28 17:22:36] -rw-r--r-- 2 boincer umatlas     17569 Apr 28 09:24 start_atlas.sh
[2025-04-28 17:22:36] drwxrwx--x 2 boincer umatlas      4096 Apr 28 09:24 shared
[2025-04-28 17:22:36] -rw-r--r-- 2 boincer umatlas    508877 Apr 28 09:24 input.tar.gz
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas         0 Apr 28 09:24 boinc_lockfile
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas      2551 Apr 28 09:24 pandaJob.out
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas       467 Apr 28 09:24 setup.sh.local
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas    993826 Apr 28 09:24 agis_schedconf.cvmfs.json
[2025-04-28 17:22:36] drwx------ 4 boincer umatlas      4096 Apr 28 09:24 pilot3
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas      6228 Apr 28 17:19 init_data.xml
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas 197286823 Apr 28 17:19 HITS.44292257._027470.pool.root.1
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas       531 Apr 28 17:20 boinc_task_state.xml
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas      1066 Apr 28 17:21 memory_monitor_summary.json
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas   1596659 Apr 28 17:21 agis_ddmendpoints.agis.ALL.json
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas    539004 Apr 28 17:21 log.44292257._027470.job.log.tgz.1
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas      7762 Apr 28 17:22 heartbeat.json
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas        95 Apr 28 17:22 pilot_heartbeat.json
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas        28 Apr 28 17:22 wrapper_checkpoint.txt
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas      8192 Apr 28 17:22 boinc_mmap_file
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas      4539 Apr 28 17:22 pilotlog.txt
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas   2292746 Apr 28 17:22 log.44292257._027470.job.log.1
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas       357 Apr 28 17:22 output.list
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas       620 Apr 28 17:22 runtime_log
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas   2846720 Apr 28 17:22 result.tar.gz
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas     11416 Apr 28 17:22 runtime_log.err
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas       662 Apr 28 17:22 ogNODmrdTT7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmUOCLDmAswoLo.diag
[2025-04-28 17:22:36] -rw-r--r-- 1 boincer umatlas     20984 Apr 28 17:22 stderr.txt
[2025-04-28 17:22:36] HITS file was successfully produced:
[2025-04-28 17:22:36] -rw------- 1 boincer umatlas 197286823 Apr 28 17:19 shared/HITS.pool.root.1
[2025-04-28 17:22:36]  *** Contents of shared directory: ***
[2025-04-28 17:22:37] total 413940
[2025-04-28 17:22:37] -rw-r--r-- 2 boincer umatlas 223200578 Apr 28 09:24 ATLAS.root_0
[2025-04-28 17:22:37] -rw-r--r-- 2 boincer umatlas     17569 Apr 28 09:24 start_atlas.sh
[2025-04-28 17:22:37] -rw-r--r-- 2 boincer umatlas    508877 Apr 28 09:24 input.tar.gz
[2025-04-28 17:22:37] -rw------- 1 boincer umatlas 197286823 Apr 28 17:19 HITS.pool.root.1
[2025-04-28 17:22:37] -rw------- 1 boincer umatlas   2846720 Apr 28 17:22 result.tar.gz
17:22:38 (17367): run_atlas exited; CPU time 58323.477734
17:22:38 (17367): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN