Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
15:08:11 (5023): wrapper (7.7.26015): starting
15:08:11 (5023): wrapper: running run_atlas (--nthreads 8)
[2024-05-15 15:08:11] Arguments: --nthreads 8
[2024-05-15 15:08:11] Threads: 8
[2024-05-15 15:08:11] Checking for CVMFS
[2024-05-15 15:08:12] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-15 15:08:12] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-15 15:08:12] Running cvmfs_config stat atlas.cern.ch
[2024-05-15 15:08: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
[2024-05-15 15:08:13] 2.11.2.0 18811 2707 107368 132771 2 349 15901057 18432001 24303 130560 0 22138848 98.777 48573813 53923 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-15 15:08:13] CVMFS is ok
[2024-05-15 15:08:13] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-15 15:08:13] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-15 15:08:13] Further information can be found at the LHC@home message board.
[2024-05-15 15:08:13] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-15 15:08:13] Checking for apptainer binary...
[2024-05-15 15:08:13] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-15 15:08:13] Running /usr/bin/apptainer --version
[2024-05-15 15:08:13] apptainer version 1.3.0-1.el7
[2024-05-15 15:08:13] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-15 15:08:17] c-212-7.aglt2.org
[2024-05-15 15:08:17] apptainer works
[2024-05-15 15:08:17] Set ATHENA_PROC_NUMBER=8
[2024-05-15 15:08:17] Set ATHENA_CORE_NUMBER=8
[2024-05-15 15:08:17] Starting ATLAS job with PandaID=6206814469
[2024-05-15 15:08:17] 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
[2024-05-16 01:48:50]  *** The last 200 lines of the pilot log: ***
[2024-05-16 01:48:51] 2024-05-16 05:48:17,171 | INFO     | monitor loop #2705: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:17,172 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:19,693 | INFO     | monitor loop #2706: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:19,693 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:22,248 | INFO     | monitor loop #2707: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:22,248 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:24,770 | INFO     | monitor loop #2708: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:24,770 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:27,274 | INFO     | monitor loop #2709: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:27,294 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:29,806 | INFO     | monitor loop #2710: job 0:6206814469 is in state 'finished'
[2024-05-16 01:48:51] 2024-05-16 05:48:29,806 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,310 | INFO     | CPU arch script returned: x86-64-v3
[2024-05-16 01:48:51] 2024-05-16 05:48:31,311 | INFO     | using path: /tmp/boinchome/slots/0/PanDA_Pilot-6206814469/memory_monitor_summary.json (trf name=prmon)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,315 | INFO     | extracted standard info from prmon json
[2024-05-16 01:48:51] 2024-05-16 05:48:31,316 | INFO     | extracted standard memory fields from prmon json
[2024-05-16 01:48:51] 2024-05-16 05:48:31,316 | WARNING  | GPU info not found in prmon json
[2024-05-16 01:48:51] 2024-05-16 05:48:31,316 | WARNING  | format EVNTtoHITS has no such key: dbData
[2024-05-16 01:48:51] 2024-05-16 05:48:31,316 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2024-05-16 01:48:51] 2024-05-16 05:48:31,341 | INFO     | fitting pss+swap vs Time
[2024-05-16 01:48:51] 2024-05-16 05:48:31,342 | INFO     | model: linear, x: [1715800300.0, 1715800361.0, 1715800422.0, 1715800483.0, 1715800544.0, 1715800605.0, 1715800666.0, 1715800727.0, 1715800788.0, 1715800849.0, 1715
[2024-05-16 01:48:51] 2024-05-16 05:48:31,342 | INFO     | sum of square deviations: 76067761810.2698
[2024-05-16 01:48:51] 2024-05-16 05:48:31,383 | INFO     | sum of deviations: 1192353323814.8984
[2024-05-16 01:48:51] 2024-05-16 05:48:31,383 | INFO     | mean x: 1715819362.5191693
[2024-05-16 01:48:51] 2024-05-16 05:48:31,383 | INFO     | mean y: 2432289.341853035
[2024-05-16 01:48:51] 2024-05-16 05:48:31,383 | INFO     | -- intersect: -26892836761.278255
[2024-05-16 01:48:51] 2024-05-16 05:48:31,383 | INFO     | intersect: -26892836761.278255
[2024-05-16 01:48:51] 2024-05-16 05:48:31,387 | INFO     | chi2: 16.8132416019751
[2024-05-16 01:48:51] 2024-05-16 05:48:31,388 | INFO     | model: linear, x: [1715800300.0, 1715800361.0, 1715800422.0, 1715800483.0, 1715800544.0, 1715800605.0, 1715800666.0, 1715800727.0, 1715800788.0, 1715800849.0, 1715
[2024-05-16 01:48:51] 2024-05-16 05:48:31,388 | INFO     | sum of square deviations: 74259573427.76823
[2024-05-16 01:48:51] 2024-05-16 05:48:31,406 | INFO     | sum of deviations: 1266992866751.9658
[2024-05-16 01:48:51] 2024-05-16 05:48:31,406 | INFO     | mean x: 1715819210.0193236
[2024-05-16 01:48:51] 2024-05-16 05:48:31,406 | INFO     | mean y: 2438549.2528180354
[2024-05-16 01:48:51] 2024-05-16 05:48:31,406 | INFO     | -- intersect: -29272314851.33119
[2024-05-16 01:48:51] 2024-05-16 05:48:31,406 | INFO     | intersect: -29272314851.33119
[2024-05-16 01:48:51] 2024-05-16 05:48:31,419 | INFO     | chi2: 15.274154886794468
[2024-05-16 01:48:51] 2024-05-16 05:48:31,419 | INFO     | current chi2=15.274154886794468 (change=9.154015338718686 %)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,419 | INFO     | right removable region: 620
[2024-05-16 01:48:51] 2024-05-16 05:48:31,420 | INFO     | model: linear, x: [1715800605.0, 1715800666.0, 1715800727.0, 1715800788.0, 1715800849.0, 1715800910.0, 1715800971.0, 1715801032.0, 1715801093.0, 1715801154.0, 1715
[2024-05-16 01:48:51] 2024-05-16 05:48:31,420 | INFO     | sum of square deviations: 74259566107.76825
[2024-05-16 01:48:51] 2024-05-16 05:48:31,438 | INFO     | sum of deviations: 1001742856786.1406
[2024-05-16 01:48:51] 2024-05-16 05:48:31,445 | INFO     | mean x: 1715819515.0193236
[2024-05-16 01:48:51] 2024-05-16 05:48:31,445 | INFO     | mean y: 2448355.571658615
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | -- intersect: -23143525056.264153
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | intersect: -23143525056.264153
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | chi2: 13.10614106192493
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | current chi2=13.10614106192493 (change=22.04869606831015 %)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | left removable region: 10
[2024-05-16 01:48:51] 2024-05-16 05:48:31,446 | INFO     | model: linear, x: [1715800910.0, 1715800971.0, 1715801032.0, 1715801093.0, 1715801154.0, 1715801215.0, 1715801276.0, 1715801337.0, 1715801398.0, 1715801459.0, 1715
[2024-05-16 01:48:51] 2024-05-16 05:48:31,447 | INFO     | sum of square deviations: 70382889502.26407
[2024-05-16 01:48:51] 2024-05-16 05:48:31,452 | INFO     | sum of deviations: 930290206596.0365
[2024-05-16 01:48:51] 2024-05-16 05:48:31,452 | INFO     | mean x: 1715819484.5196722
[2024-05-16 01:48:51] 2024-05-16 05:48:31,452 | INFO     | mean y: 2467281.580327869
[2024-05-16 01:48:51] 2024-05-16 05:48:31,453 | INFO     | -- intersect: -22676483156.84923
[2024-05-16 01:48:51] 2024-05-16 05:48:31,453 | INFO     | intersect: -22676483156.84923
[2024-05-16 01:48:51] 2024-05-16 05:48:31,453 | INFO     | chi2: 9.551836816288647
[2024-05-16 01:48:51] 2024-05-16 05:48:31,453 | INFO     | -- intersect: -22676483156.84923
[2024-05-16 01:48:51] 2024-05-16 05:48:31,453 | INFO     | current memory leak: 13.22 B/s (using 610 data points, chi2=9.55)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,466 | INFO     | ..............................
[2024-05-16 01:48:51] 2024-05-16 05:48:31,466 | INFO     | . Timing measurements:
[2024-05-16 01:48:51] 2024-05-16 05:48:31,466 | INFO     | . get job = 0 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,466 | INFO     | . initial setup = 3 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | . payload setup = 37 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | . stage-in = 0 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | . payload execution = 38170 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | . stage-out = 9 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | . log creation = 2 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,467 | INFO     | ..............................
[2024-05-16 01:48:51] 2024-05-16 05:48:31,769 | INFO     | 
[2024-05-16 01:48:51] 2024-05-16 05:48:31,777 | INFO     | job summary report
[2024-05-16 01:48:51] 2024-05-16 05:48:31,777 | INFO     | --------------------------------------------------
[2024-05-16 01:48:51] 2024-05-16 05:48:31,777 | INFO     | PanDA job id: 6206814469
[2024-05-16 01:48:51] 2024-05-16 05:48:31,777 | INFO     | task id: 38921013
[2024-05-16 01:48:51] 2024-05-16 05:48:31,777 | INFO     | errors: (none)
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | status: LOG_TRANSFER = DONE 
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | pilot state: finished 
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | transexitcode: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | exeerrorcode: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | exeerrordiag: 
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | exitcode: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | exitmsg: OK
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | cpuconsumptiontime: 141391 s
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | nevents: 400
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | neventsw: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | pid: 45371
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | pgrp: 45371
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | corecount: 8
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | event service: False
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | sizes: {0: 2392029, 1: 2392228, 11: 2392228, 22: 2392256, 29: 2392490, 33: 2392518, 38210: 2433574, 38221: 2442534, 38224: 2442590, 38288: 2442760}
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | --------------------------------------------------
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | 
[2024-05-16 01:48:51] 2024-05-16 05:48:31,778 | INFO     | executing command: ls -lF /tmp/boinchome/slots/0
[2024-05-16 01:48:51] 2024-05-16 05:48:31,823 | INFO     | 38349s have passed since pilot start
[2024-05-16 01:48:51] 2024-05-16 05:48:32,319 | INFO     | queue jobs had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,319 | INFO     | queue payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,319 | INFO     | queue data_in had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,319 | INFO     | queue data_out had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue current_data_in had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue completed_jobids has 1 job(s)
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | queue messages had 0 job(s) [purged]
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | job 6206814469 has completed (purged errors)
[2024-05-16 01:48:51] 2024-05-16 05:48:32,320 | INFO     | overall cleanup function is called
[2024-05-16 01:48:51] 2024-05-16 05:48:33,329 | INFO     | --- collectZombieJob: --- 10, [45371]
[2024-05-16 01:48:51] 2024-05-16 05:48:33,329 | INFO     | zombie collector waiting for pid 45371
[2024-05-16 01:48:51] 2024-05-16 05:48:33,329 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2024-05-16 01:48:51] 2024-05-16 05:48:34,335 | INFO     | collected zombie processes
[2024-05-16 01:48:51] 2024-05-16 05:48:34,335 | INFO     | will now attempt to kill all subprocesses of pid=45371
[2024-05-16 01:48:51] 2024-05-16 05:48:35,583 | INFO     | process IDs to be killed: [45371] (in reverse order)
[2024-05-16 01:48:51] 2024-05-16 05:48:36,673 | WARNING  | found no corresponding commands to process id(s)
[2024-05-16 01:48:51] 2024-05-16 05:48:36,673 | INFO     | Do not look for orphan processes in BOINC jobs
[2024-05-16 01:48:51] 2024-05-16 05:48:36,713 | INFO     | did not find any defunct processes belonging to 45371
[2024-05-16 01:48:51] 2024-05-16 05:48:36,728 | INFO     | did not find any defunct processes belonging to 45371
[2024-05-16 01:48:51] 2024-05-16 05:48:36,728 | INFO     | ready for new job
[2024-05-16 01:48:51] 2024-05-16 05:48:36,729 | INFO     | pilot has finished with previous job - re-establishing logging
[2024-05-16 01:48:51] 2024-05-16 05:48:36,739 | INFO     | *************************************
[2024-05-16 01:48:51] 2024-05-16 05:48:36,739 | INFO     | ***  PanDA Pilot version 3.7.5.4  ***
[2024-05-16 01:48:51] 2024-05-16 05:48:36,739 | INFO     | *************************************
[2024-05-16 01:48:51] 2024-05-16 05:48:36,739 | INFO     | 
[2024-05-16 01:48:51] 2024-05-16 05:48:36,743 | INFO     | architecture information:
[2024-05-16 01:48:51] 2024-05-16 05:48:36,760 | INFO     | executing command: cat /etc/os-release
[2024-05-16 01:48:51] 2024-05-16 05:48:36,889 | INFO     | cat /etc/os-release:
[2024-05-16 01:48:51] NAME="CentOS Linux"
[2024-05-16 01:48:51] VERSION="7 (Core)"
[2024-05-16 01:48:51] ID="centos"
[2024-05-16 01:48:51] ID_LIKE="rhel fedora"
[2024-05-16 01:48:51] VERSION_ID="7"
[2024-05-16 01:48:51] PRETTY_NAME="CentOS Linux 7 (Core)"
[2024-05-16 01:48:51] ANSI_COLOR="0;31"
[2024-05-16 01:48:51] CPE_NAME="cpe:/o:centos:centos:7"
[2024-05-16 01:48:51] HOME_URL="https://www.centos.org/"
[2024-05-16 01:48:51] BUG_REPORT_URL="https://bugs.centos.org/"
[2024-05-16 01:48:51] 
[2024-05-16 01:48:51] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2024-05-16 01:48:51] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2024-05-16 01:48:51] REDHAT_SUPPORT_PRODUCT="centos"
[2024-05-16 01:48:51] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2024-05-16 01:48:51] 
[2024-05-16 01:48:51] 2024-05-16 05:48:36,889 | INFO     | *************************************
[2024-05-16 01:48:51] 2024-05-16 05:48:37,391 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2024-05-16 01:48:51] 2024-05-16 05:48:37,491 | INFO     | sufficient remaining disk space (99172220928 B)
[2024-05-16 01:48:51] 2024-05-16 05:48:37,491 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2024-05-16 01:48:51] 2024-05-16 05:48:37,491 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2024-05-16 01:48:51] 2024-05-16 05:48:37,491 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2024-05-16 01:48:51] 2024-05-16 05:48:37,492 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2024-05-16 01:48:51] 2024-05-16 05:48:37,492 | INFO     | found 0 job(s) in 20 queues
[2024-05-16 01:48:51] 2024-05-16 05:48:37,492 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2024-05-16 01:48:51] 2024-05-16 05:48:37,492 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2024-05-16 01:48:51] 2024-05-16 05:48:37,687 | INFO     | all data control threads have been joined
[2024-05-16 01:48:51] 2024-05-16 05:48:37,931 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2024-05-16 01:48:51] 2024-05-16 05:48:37,943 | INFO     | all job control threads have been joined
[2024-05-16 01:48:51] 2024-05-16 05:48:38,043 | INFO     | all payload control threads have been joined
[2024-05-16 01:48:51] 2024-05-16 05:48:38,342 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2024-05-16 01:48:51] 2024-05-16 05:48:38,342 | INFO     | aborting loop
[2024-05-16 01:48:51] 2024-05-16 05:48:38,497 | INFO     | [job] retrieve thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:38,498 | INFO     | [job] queue monitor thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:38,639 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2024-05-16 01:48:51] 2024-05-16 05:48:38,694 | INFO     | [data] control thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:38,949 | INFO     | [job] control thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,048 | INFO     | [payload] control thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,297 | INFO     | [payload] validate_pre thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,317 | INFO     | [job] create_data_payload thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,323 | INFO     | [payload] run_realtimelog thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,326 | INFO     | [job] validate thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,343 | INFO     | [data] copytool_in thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,349 | INFO     | [job] job monitor thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,399 | INFO     | [payload] execute_payloads thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,900 | INFO     | [payload] validate_post thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:39,910 | INFO     | [payload] failed_post thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:40,645 | INFO     | [data] copytool_out thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:41,940 | INFO     | [data] queue_monitor thread has finished
[2024-05-16 01:48:51] 2024-05-16 05:48:42,373 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140480475866944)>', '<ExcThread(monitor, started 140479924532992)>']
[2024-05-16 01:48:51] 2024-05-16 05:48:42,527 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2024-05-16 01:48:51] 2024-05-16 05:48:42,527 | INFO     | [monitor] control thread has ended
[2024-05-16 01:48:51] 2024-05-16 05:48:47,406 | INFO     | all workflow threads have been joined
[2024-05-16 01:48:51] 2024-05-16 05:48:47,424 | INFO     | end of generic workflow (traces error code: 0)
[2024-05-16 01:48:51] 2024-05-16 05:48:47,428 | INFO     | traces error code: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:47,428 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2024-05-16 01:48:51] 2024-05-16 05:48:48,047 [wrapper] ==== pilot stdout END ====
[2024-05-16 01:48:51] 2024-05-16 05:48:48,076 [wrapper] ==== wrapper stdout RESUME ====
[2024-05-16 01:48:51] 2024-05-16 05:48:48,121 [wrapper] pilotpid: 24351
[2024-05-16 01:48:51] 2024-05-16 05:48:48,165 [wrapper] Pilot exit status: 0
[2024-05-16 01:48:51] 2024-05-16 05:48:48,427 [wrapper] pandaids: 6206814469
[2024-05-16 01:48:51] 2024-05-16 05:48:49,000 [wrapper] cleanup: SIGTERM to supervisor_pilot 39599 24353
[2024-05-16 01:48:51] 2024-05-16 05:48:49,034 [wrapper] Test setup, not cleaning
[2024-05-16 01:48:51] 2024-05-16 05:48:49,099 [wrapper] ==== wrapper stdout END ====
[2024-05-16 01:48:51] 2024-05-16 05:48:49,148 [wrapper] ==== wrapper stderr END ====
[2024-05-16 01:48:51] 2024-05-16 05:48:49,274 [wrapper] apfmon messages muted
[2024-05-16 01:48:51]  *** Error codes and diagnostics ***
[2024-05-16 01:48:51]     "exeErrorCode": 0,
[2024-05-16 01:48:51]     "exeErrorDiag": "",
[2024-05-16 01:48:51]     "pilotErrorCode": 0,
[2024-05-16 01:48:51]     "pilotErrorDiag": "",
[2024-05-16 01:48:51]  *** Listing of results directory ***
[2024-05-16 01:48:51] total 882632
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas    467845 May 15 10:23 pilot3.tar.gz
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas      5633 May 15 10:37 queuedata.json
[2024-05-16 01:48:51] -rwx------ 1 boincer umatlas     32251 May 15 10:38 runpilot2-wrapper.sh
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas       100 May 15 15:08 wrapper_26015_x86_64-pc-linux-gnu
[2024-05-16 01:48:51] -rwxr-xr-x 1 boincer umatlas      7986 May 15 15:08 run_atlas
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas       105 May 15 15:08 job.xml
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas 543939270 May 15 15:08 EVNT.38776210._000001.pool.root.1
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas     17537 May 15 15:08 start_atlas.sh
[2024-05-16 01:48:51] drwxrwx--x 2 boincer umatlas      4096 May 15 15:08 shared
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas    479992 May 15 15:08 input.tar.gz
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas         0 May 15 15:08 boinc_lockfile
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas      2638 May 15 15:08 pandaJob.out
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas       467 May 15 15:08 setup.sh.local
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas   1011265 May 15 15:09 agis_schedconf.cvmfs.json
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas   1324701 May 15 15:09 cric_ddmendpoints.json
[2024-05-16 01:48:51] drwx------ 4 boincer umatlas      4096 May 15 15:09 pilot3
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas 347206693 May 16 01:44 HITS.38921013._000019.pool.root.1
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas       533 May 16 01:45 boinc_task_state.xml
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas      6388 May 16 01:46 init_data.xml
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas      1089 May 16 01:47 memory_monitor_summary.json
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas         0 May 16 01:47 agis_ddmendpoints.agis.ALL.json
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas    685585 May 16 01:47 log.38921013._000019.job.log.tgz.1
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas        95 May 16 01:48 pilot_heartbeat.json
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas      7763 May 16 01:48 heartbeat.json
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas      4334 May 16 01:48 pilotlog.txt
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas      8192 May 16 01:48 boinc_mmap_file
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas        29 May 16 01:48 wrapper_checkpoint.txt
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas   3887535 May 16 01:48 log.38921013._000019.job.log.1
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas       357 May 16 01:48 output.list
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas       620 May 16 01:48 runtime_log
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas   4587520 May 16 01:48 result.tar.gz
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas     11400 May 16 01:48 runtime_log.err
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas       654 May 16 01:48 0UtKDmwwUR5nsSi4apGgGQJmABFKDmABFKDm4ySLDmMSOKDmLHilWo.diag
[2024-05-16 01:48:51] -rw-r--r-- 1 boincer umatlas     21884 May 16 01:48 stderr.txt
[2024-05-16 01:48:51] HITS file was successfully produced:
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas 347206693 May 16 01:44 shared/HITS.pool.root.1
[2024-05-16 01:48:51]  *** Contents of shared directory: ***
[2024-05-16 01:48:51] total 875244
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas 543939270 May 15 15:08 ATLAS.root_0
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas     17537 May 15 15:08 start_atlas.sh
[2024-05-16 01:48:51] -rw-r--r-- 2 boincer umatlas    479992 May 15 15:08 input.tar.gz
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas 347206693 May 16 01:44 HITS.pool.root.1
[2024-05-16 01:48:51] -rw------- 1 boincer umatlas   4587520 May 16 01:48 result.tar.gz
01:48:52 (5023): run_atlas exited; CPU time 138655.645135
01:48:52 (5023): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN