Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
23:47:04 (3068963): wrapper (7.7.26015): starting
23:47:04 (3068963): wrapper: running run_atlas (--nthreads 8)
[2025-02-25 23:47:04] Arguments: --nthreads 8
[2025-02-25 23:47:04] Threads: 8
[2025-02-25 23:47:04] Checking for CVMFS
[2025-02-25 23:47:04] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-25 23:47:04] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-25 23:47:04] Running cvmfs_config stat atlas.cern.ch
[2025-02-25 23:47:05] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2025-02-25 23:47:05] 2.11.3.0 21283 261186 201724 143067 3 388 23775546 45568000 11134 130560 0 1032661014 99.760 774516771 19263 http://cvmfs-s1bnl.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://206.12.9.162:3129 1
[2025-02-25 23:47:05] CVMFS is ok
[2025-02-25 23:47:05] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-25 23:47:05] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-25 23:47:05] Further information can be found at the LHC@home message board.
[2025-02-25 23:47:05] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-25 23:47:05] Checking for apptainer binary...
[2025-02-25 23:47:05] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-25 23:47:05] Running /usr/bin/apptainer --version
[2025-02-25 23:47:05] apptainer version 1.3.3-1.el9
[2025-02-25 23:47:05] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-25 23:47:05] WARNING: Environment variable TMPDIR already has value [/home/boinc/slots/0/.apptainertmp], will not forward new value [/home/boinc] from parent process environment wns0010.triumf.lcg
[2025-02-25 23:47:05] apptainer works
[2025-02-25 23:47:05] Set ATHENA_PROC_NUMBER=8
[2025-02-25 23:47:05] Set ATHENA_CORE_NUMBER=8
[2025-02-25 23:47:05] Starting ATLAS job with PandaID=6530792963
[2025-02-25 23:47:05] Running command: /usr/bin/apptainer exec -B /cvmfs,/home/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-26 04:25:07]  *** The last 200 lines of the pilot log: ***
[2025-02-26 04:25:07] 2025-02-26 12:24:49,560 | INFO     | intersect: -35229587778.000084
[2025-02-26 04:25:07] 2025-02-26 12:24:49,560 | INFO     | chi2: 4.633560159085074
[2025-02-26 04:25:07] 2025-02-26 12:24:49,560 | INFO     | model: linear, x: [1740556069.0, 1740556130.0, 1740556191.0, 1740556252.0, 1740556313.0, 1740556374.0, 1740556435.0, 1740556496.0, 1740556557.0, 1740556618.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,584 | INFO     | sum of square deviations: 5902258850.074898
[2025-02-26 04:25:07] 2025-02-26 12:24:49,586 | INFO     | sum of deviations: 140941586812.44577
[2025-02-26 04:25:07] 2025-02-26 12:24:49,586 | INFO     | mean x: 1740564183.1610487
[2025-02-26 04:25:07] 2025-02-26 12:24:49,594 | INFO     | mean y: 2363701.4082397004
[2025-02-26 04:25:07] 2025-02-26 12:24:49,594 | INFO     | -- intersect: -41561024851.18188
[2025-02-26 04:25:07] 2025-02-26 12:24:49,594 | INFO     | intersect: -41561024851.18188
[2025-02-26 04:25:07] 2025-02-26 12:24:49,595 | INFO     | chi2: 3.9529198112972908
[2025-02-26 04:25:07] 2025-02-26 12:24:49,595 | INFO     | current chi2=3.9529198112972908 (change=14.689360328110645 %)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,600 | INFO     | right removable region: 266
[2025-02-26 04:25:07] 2025-02-26 12:24:49,600 | INFO     | model: linear, x: [1740556374.0, 1740556435.0, 1740556496.0, 1740556557.0, 1740556618.0, 1740556679.0, 1740556740.0, 1740556801.0, 1740556862.0, 1740556923.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,600 | INFO     | sum of square deviations: 5902117326.074944
[2025-02-26 04:25:07] 2025-02-26 12:24:49,606 | INFO     | sum of deviations: 63976641894.51306
[2025-02-26 04:25:07] 2025-02-26 12:24:49,606 | INFO     | mean x: 1740564488.1722846
[2025-02-26 04:25:07] 2025-02-26 12:24:49,606 | INFO     | mean y: 2385262.880149813
[2025-02-26 04:25:07] 2025-02-26 12:24:49,606 | INFO     | -- intersect: -18864652581.682465
[2025-02-26 04:25:07] 2025-02-26 12:24:49,606 | INFO     | intersect: -18864652581.682465
[2025-02-26 04:25:07] 2025-02-26 12:24:49,607 | INFO     | chi2: 2.3371849948815955
[2025-02-26 04:25:07] 2025-02-26 12:24:49,607 | INFO     | current chi2=2.3371849948815955 (change=49.559627702274454 %)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,611 | INFO     | model: linear, x: [1740556679.0, 1740556740.0, 1740556801.0, 1740556862.0, 1740556923.0, 1740556984.0, 1740557045.0, 1740557106.0, 1740557168.0, 1740557228.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,611 | INFO     | sum of square deviations: 5576611101.572492
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | sum of deviations: 22164996420.51908
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | mean x: 1740564640.6946564
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | mean y: 2404845.1564885494
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | -- intersect: -6915705155.341927
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | intersect: -6915705155.341927
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | chi2: 1.4170746595545558
[2025-02-26 04:25:07] 2025-02-26 12:24:49,613 | INFO     | current chi2=1.4170746595545558 (change=39.36831433292911 %)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,614 | INFO     | model: linear, x: [1740556984.0, 1740557045.0, 1740557106.0, 1740557168.0, 1740557228.0, 1740557289.0, 1740557350.0, 1740557411.0, 1740557474.0, 1740557536.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,614 | INFO     | sum of square deviations: 5263291151.797695
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | sum of deviations: -10628982656.996113
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | mean x: 1740564793.2178988
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | mean y: 2420767.3035019455
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | -- intersect: 3517414041.838996
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | intersect: 3517414041.838996
[2025-02-26 04:25:07] 2025-02-26 12:24:49,621 | INFO     | chi2: 0.7869025085702446
[2025-02-26 04:25:07] 2025-02-26 12:24:49,622 | INFO     | current chi2=0.7869025085702446 (change=44.469932952043614 %)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,622 | INFO     | model: linear, x: [1740557289.0, 1740557350.0, 1740557411.0, 1740557474.0, 1740557536.0, 1740557594.0, 1740557655.0, 1740557716.0, 1740557780.0, 1740557840.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,622 | INFO     | sum of square deviations: 4961940470.714263
[2025-02-26 04:25:07] 2025-02-26 12:24:49,623 | INFO     | sum of deviations: -19074146738.97619
[2025-02-26 04:25:07] 2025-02-26 12:24:49,623 | INFO     | mean x: 1740564945.7380953
[2025-02-26 04:25:07] 2025-02-26 12:24:49,624 | INFO     | mean y: 2425033.757936508
[2025-02-26 04:25:07] 2025-02-26 12:24:49,624 | INFO     | -- intersect: 6693313685.01729
[2025-02-26 04:25:07] 2025-02-26 12:24:49,624 | INFO     | intersect: 6693313685.01729
[2025-02-26 04:25:07] 2025-02-26 12:24:49,638 | INFO     | chi2: 0.7409914403576952
[2025-02-26 04:25:07] 2025-02-26 12:24:49,638 | INFO     | current chi2=0.7409914403576952 (change=5.83440359034655 %)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,638 | INFO     | left removable region: 40
[2025-02-26 04:25:07] 2025-02-26 12:24:49,639 | INFO     | model: linear, x: [1740558509.0, 1740558572.0, 1740558633.0, 1740558694.0, 1740558755.0, 1740558816.0, 1740558877.0, 1740558938.0, 1740558999.0, 1740559059.0, 1740
[2025-02-26 04:25:07] 2025-02-26 12:24:49,639 | INFO     | sum of square deviations: 3579005376.5707984
[2025-02-26 04:25:07] 2025-02-26 12:24:49,640 | INFO     | sum of deviations: -437278975.50885
[2025-02-26 04:25:07] 2025-02-26 12:24:49,640 | INFO     | mean x: 1740565372.7654867
[2025-02-26 04:25:07] 2025-02-26 12:24:49,640 | INFO     | mean y: 2432240.2168141594
[2025-02-26 04:25:07] 2025-02-26 12:24:49,640 | INFO     | -- intersect: 215092620.10658312
[2025-02-26 04:25:07] 2025-02-26 12:24:49,640 | INFO     | intersect: 215092620.10658312
[2025-02-26 04:25:07] 2025-02-26 12:24:49,641 | INFO     | chi2: 0.007304258058408009
[2025-02-26 04:25:07] 2025-02-26 12:24:49,641 | INFO     | -- intersect: 215092620.10658312
[2025-02-26 04:25:07] 2025-02-26 12:24:49,641 | INFO     | current memory leak: -0.12 B/s (using 226 data points, chi2=0.01)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,641 | INFO     | ..............................
[2025-02-26 04:25:07] 2025-02-26 12:24:49,641 | INFO     | . Timing measurements:
[2025-02-26 04:25:07] 2025-02-26 12:24:49,642 | INFO     | . get job = 0 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,642 | INFO     | . initial setup = 3 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,642 | INFO     | . payload setup = 8 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,647 | INFO     | . stage-in = 0 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,647 | INFO     | . payload execution = 16590 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,647 | INFO     | . stage-out = 5 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,647 | INFO     | . log creation = 0 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,647 | INFO     | ..............................
[2025-02-26 04:25:07] 2025-02-26 12:24:49,890 | INFO     | 
[2025-02-26 04:25:07] 2025-02-26 12:24:49,890 | INFO     | job summary report
[2025-02-26 04:25:07] 2025-02-26 12:24:49,890 | INFO     | --------------------------------------------------
[2025-02-26 04:25:07] 2025-02-26 12:24:49,890 | INFO     | PanDA job id: 6530792963
[2025-02-26 04:25:07] 2025-02-26 12:24:49,890 | INFO     | task id: 43401137
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | errors: (none)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | pilot state: finished 
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | transexitcode: 0
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | exeerrorcode: 0
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | exeerrordiag: 
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | exitcode: 0
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | exitmsg: OK
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | cpuconsumptiontime: 35812 s
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | nevents: 400
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | neventsw: 0
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | pid: 3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | pgrp: 3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:49,891 | INFO     | corecount: 8
[2025-02-26 04:25:07] 2025-02-26 12:24:49,892 | INFO     | event service: False
[2025-02-26 04:25:07] 2025-02-26 12:24:49,892 | INFO     | sizes: {0: 2363829, 5: 2364035, 11: 2364091, 16603: 2395744, 16604: 2395743, 16610: 2404918, 16635: 2405032}
[2025-02-26 04:25:07] 2025-02-26 12:24:49,892 | INFO     | --------------------------------------------------
[2025-02-26 04:25:07] 2025-02-26 12:24:49,892 | INFO     | 
[2025-02-26 04:25:07] 2025-02-26 12:24:49,892 | INFO     | executing command: ls -lF /home/boinc/slots/0
[2025-02-26 04:25:07] 2025-02-26 12:24:49,957 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,957 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,958 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | job 6530792963 has completed (purged errors)
[2025-02-26 04:25:07] 2025-02-26 12:24:49,959 | INFO     | overall cleanup function is called
[2025-02-26 04:25:07] 2025-02-26 12:24:50,974 | INFO     | --- collectZombieJob: --- 10, [3079168]
[2025-02-26 04:25:07] 2025-02-26 12:24:50,974 | INFO     | zombie collector waiting for pid 3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:50,974 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-26 04:25:07] 2025-02-26 12:24:50,974 | INFO     | collected zombie processes
[2025-02-26 04:25:07] 2025-02-26 12:24:50,974 | INFO     | will attempt to kill all subprocesses of pid=3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:51,593 | INFO     | process IDs to be killed: [3079168] (in reverse order)
[2025-02-26 04:25:07] 2025-02-26 12:24:52,135 | WARNING  | found no corresponding commands to process id(s)
[2025-02-26 04:25:07] 2025-02-26 12:24:52,136 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-26 04:25:07] 2025-02-26 12:24:52,165 | INFO     | did not find any defunct processes belonging to 3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:52,187 | INFO     | did not find any defunct processes belonging to 3079168
[2025-02-26 04:25:07] 2025-02-26 12:24:52,187 | INFO     | ready for new job
[2025-02-26 04:25:07] 2025-02-26 12:24:52,188 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-26 04:25:07] 2025-02-26 12:24:52,189 | INFO     | **************************************
[2025-02-26 04:25:07] 2025-02-26 12:24:52,190 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-26 04:25:07] 2025-02-26 12:24:52,190 | INFO     | **************************************
[2025-02-26 04:25:07] 2025-02-26 12:24:52,194 | INFO     | 
[2025-02-26 04:25:07] 2025-02-26 12:24:52,211 | INFO     | architecture information:
[2025-02-26 04:25:07] 2025-02-26 12:24:52,215 | INFO     | executing command: cat /etc/os-release
[2025-02-26 04:25:07] 2025-02-26 12:24:52,264 | INFO     | cat /etc/os-release:
[2025-02-26 04:25:07] NAME="CentOS Linux"
[2025-02-26 04:25:07] VERSION="7 (Core)"
[2025-02-26 04:25:07] ID="centos"
[2025-02-26 04:25:07] ID_LIKE="rhel fedora"
[2025-02-26 04:25:07] VERSION_ID="7"
[2025-02-26 04:25:07] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-26 04:25:07] ANSI_COLOR="0;31"
[2025-02-26 04:25:07] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-26 04:25:07] HOME_URL="https://www.centos.org/"
[2025-02-26 04:25:07] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-26 04:25:07] 
[2025-02-26 04:25:07] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-26 04:25:07] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-26 04:25:07] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-26 04:25:07] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-26 04:25:07] 
[2025-02-26 04:25:07] 2025-02-26 12:24:52,264 | INFO     | **************************************
[2025-02-26 04:25:07] 2025-02-26 12:24:52,769 | INFO     | executing command: df -mP /home/boinc/slots/0
[2025-02-26 04:25:07] 2025-02-26 12:24:52,930 | INFO     | sufficient remaining disk space (1212051095552 B)
[2025-02-26 04:25:07] 2025-02-26 12:24:52,931 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-26 04:25:07] 2025-02-26 12:24:52,931 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-26 04:25:07] 2025-02-26 12:24:52,950 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-02-26 04:25:07] 2025-02-26 12:24:52,950 | INFO     | found 0 job(s) in 20 queues
[2025-02-26 04:25:07] 2025-02-26 12:24:52,950 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-26 04:25:07] 2025-02-26 12:24:52,950 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-26 04:25:07] 2025-02-26 12:24:53,217 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-26 04:25:07] 2025-02-26 12:24:53,254 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-26 04:25:07] 2025-02-26 12:24:53,254 | INFO     | aborting loop
[2025-02-26 04:25:07] 2025-02-26 12:24:53,765 | INFO     | all data control threads have been joined
[2025-02-26 04:25:07] 2025-02-26 12:24:53,869 | INFO     | all job control threads have been joined
[2025-02-26 04:25:07] 2025-02-26 12:24:53,937 | INFO     | [job] retrieve thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,175 | INFO     | all payload control threads have been joined
[2025-02-26 04:25:07] 2025-02-26 12:24:54,256 | INFO     | [job] create_data_payload thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,260 | INFO     | [job] job monitor thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,277 | INFO     | [payload] validate_pre thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,383 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-26 04:25:07] 2025-02-26 12:24:54,402 | INFO     | [job] validate thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,517 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,759 | INFO     | [payload] execute_payloads thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,771 | INFO     | [data] control thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,875 | INFO     | [job] control thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:54,911 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-26 04:25:07] 2025-02-26 12:24:54,927 | INFO     | [data] copytool_in thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:55,132 | INFO     | [payload] failed_post thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:55,181 | INFO     | [payload] control thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:55,224 | INFO     | [data] copytool_out thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:55,276 | INFO     | [payload] validate_post thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:55,917 | INFO     | [job] queue monitor thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:24:58,404 | INFO     | [data] queue_monitor thread has finished
[2025-02-26 04:25:07] 2025-02-26 12:25:00,497 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140200861669184)>', '<ExcThread(monitor, started 140200307042048)>']
[2025-02-26 04:25:07] 2025-02-26 12:25:01,029 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-26 04:25:07] 2025-02-26 12:25:01,029 | INFO     | [monitor] control thread has ended
[2025-02-26 04:25:07] 2025-02-26 12:25:05,523 | INFO     | all workflow threads have been joined
[2025-02-26 04:25:07] 2025-02-26 12:25:05,523 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-26 04:25:07] 2025-02-26 12:25:05,523 | INFO     | traces error code: 0
[2025-02-26 04:25:07] 2025-02-26 12:25:05,524 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-26 04:25:07] 2025-02-26 12:25:06,102 [wrapper] ==== pilot stdout END ====
[2025-02-26 04:25:07] 2025-02-26 12:25:06,136 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-26 04:25:07] 2025-02-26 12:25:06,184 [wrapper] pilotpid: 3072595
[2025-02-26 04:25:07] 2025-02-26 12:25:06,242 [wrapper] Pilot exit status: 0
[2025-02-26 04:25:07] 2025-02-26 12:25:06,438 [wrapper] pandaids: 6530792963
[2025-02-26 04:25:07] 2025-02-26 12:25:06,689 [wrapper] cleanup supervisor_pilot  131163 3072596
[2025-02-26 04:25:07] 2025-02-26 12:25:06,722 [wrapper] Test setup, not cleaning
[2025-02-26 04:25:07] 2025-02-26 12:25:06,808 [wrapper] apfmon messages muted
[2025-02-26 04:25:07] 2025-02-26 12:25:06,886 [wrapper] ==== wrapper stdout END ====
[2025-02-26 04:25:07] 2025-02-26 12:25:06,952 [wrapper] ==== wrapper stderr END ====
[2025-02-26 04:25:07]  *** Error codes and diagnostics ***
[2025-02-26 04:25:07]     "exeErrorCode": 0,
[2025-02-26 04:25:07]     "exeErrorDiag": "",
[2025-02-26 04:25:07]     "pilotErrorCode": 0,
[2025-02-26 04:25:07]     "pilotErrorDiag": "",
[2025-02-26 04:25:07]  *** Listing of results directory ***
[2025-02-26 04:25:07] total 430100
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc    491065 Feb 25 11:07 pilot3.tar.gz
[2025-02-26 04:25:07] -rwx------. 1 boinc boinc     35865 Feb 25 11:20 runpilot2-wrapper.sh
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc      5118 Feb 25 11:20 queuedata.json
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc       100 Feb 25 23:47 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-26 04:25:07] -rwxr-xr-x. 1 boinc boinc      7986 Feb 25 23:47 run_atlas
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc       105 Feb 25 23:47 job.xml
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc      6454 Feb 25 23:47 init_data.xml
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc 250331539 Feb 25 23:47 EVNT.43401135._000078.pool.root.1
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc     17569 Feb 25 23:47 start_atlas.sh
[2025-02-26 04:25:07] drwxrwx--x. 2 boinc boinc      4096 Feb 25 23:47 shared
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc    503548 Feb 25 23:47 input.tar.gz
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc         0 Feb 25 23:47 boinc_lockfile
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc      2558 Feb 25 23:47 pandaJob.out
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc       424 Feb 25 23:47 setup.sh.local
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc    986668 Feb 25 23:47 agis_schedconf.cvmfs.json
[2025-02-26 04:25:07] drwx------. 4 boinc boinc      4096 Feb 25 23:47 pilot3
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc 181868230 Feb 26 04:22 HITS.43401137._001859.pool.root.1
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc       531 Feb 26 04:22 boinc_task_state.xml
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc      1050 Feb 26 04:24 memory_monitor_summary.json
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc   1569202 Feb 26 04:24 agis_ddmendpoints.agis.ALL.json
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc    442769 Feb 26 04:24 log.43401137._001859.job.log.tgz.1
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc        95 Feb 26 04:24 pilot_heartbeat.json
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc      7750 Feb 26 04:24 heartbeat.json
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc      8192 Feb 26 04:25 boinc_mmap_file
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc        28 Feb 26 04:25 wrapper_checkpoint.txt
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc      4337 Feb 26 04:25 pilotlog.txt
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc   1771613 Feb 26 04:25 log.43401137._001859.job.log.1
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc       357 Feb 26 04:25 output.list
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc       620 Feb 26 04:25 runtime_log
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc   2232320 Feb 26 04:25 result.tar.gz
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc     11143 Feb 26 04:25 runtime_log.err
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc       667 Feb 26 04:25 77uKDmgeF76n9Rq4apOajLDm4fhM0noT9bVoFjIUDmaAgKDmXm5vTn.diag
[2025-02-26 04:25:07] -rw-r--r--. 1 boinc boinc     21789 Feb 26 04:25 stderr.txt
[2025-02-26 04:25:07] HITS file was successfully produced:
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc 181868230 Feb 26 04:22 shared/HITS.pool.root.1
[2025-02-26 04:25:07]  *** Contents of shared directory: ***
[2025-02-26 04:25:07] total 424776
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc 250331539 Feb 25 23:47 ATLAS.root_0
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc     17569 Feb 25 23:47 start_atlas.sh
[2025-02-26 04:25:07] -rw-r--r--. 2 boinc boinc    503548 Feb 25 23:47 input.tar.gz
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc 181868230 Feb 26 04:22 HITS.pool.root.1
[2025-02-26 04:25:07] -rw-------. 1 boinc boinc   2232320 Feb 26 04:25 result.tar.gz
04:25:09 (3068963): run_atlas exited; CPU time 35671.419027
04:25:09 (3068963): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN