Stderr output

<core_client_version>8.1.0</core_client_version>
<![CDATA[
<stderr_txt>
12:59:07 (3933346): wrapper (7.7.26015): starting
12:59:07 (3933346): wrapper: running run_atlas (--nthreads 9)
[2025-02-23 12:59:07] Arguments: --nthreads 9
[2025-02-23 12:59:07] Threads: 9
[2025-02-23 12:59:07] Checking for CVMFS
[2025-02-23 12:59:08] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-23 12:59:08] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-23 12:59:08] Running cvmfs_config stat atlas.cern.ch
[2025-02-23 12:59:10] 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-23 12:59:10] 2.11.5.0 2130797 27713 274008 142983 2 360 12746818 37641217 15660 130560 0 871812 97.590 4893907 34749 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1
[2025-02-23 12:59:10] CVMFS is ok
[2025-02-23 12:59:10] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-23 12:59:10] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-23 12:59:10] Further information can be found at the LHC@home message board.
[2025-02-23 12:59:10] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-23 12:59:10] Checking for apptainer binary...
[2025-02-23 12:59:10] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-23 12:59:10] Running /usr/bin/apptainer --version
[2025-02-23 12:59:10] apptainer version 1.3.6-1.el9
[2025-02-23 12:59:10] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-23 12:59:10] c6-1-26-1.aglt2.org
[2025-02-23 12:59:10] apptainer works
[2025-02-23 12:59:10] Set ATHENA_PROC_NUMBER=9
[2025-02-23 12:59:10] Set ATHENA_CORE_NUMBER=9
[2025-02-23 12:59:11] Starting ATLAS job with PandaID=6523020546
[2025-02-23 12:59:11] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-23 21:49:34]  *** The last 200 lines of the pilot log: ***
[2025-02-23 21:49:34] 2025-02-24 02:49:17,171 | INFO     | intersect: -12588585073.581108
[2025-02-23 21:49:34] 2025-02-24 02:49:17,171 | INFO     | chi2: 6.494464090302111
[2025-02-23 21:49:34] 2025-02-24 02:49:17,172 | INFO     | model: linear, x: [1740333704.0, 1740333765.0, 1740333826.0, 1740333887.0, 1740333948.0, 1740334009.0, 1740334070.0, 1740334131.0, 1740334192.0, 1740334253.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,177 | INFO     | sum of square deviations: 42109546265.13625
[2025-02-23 21:49:34] 2025-02-24 02:49:17,186 | INFO     | sum of deviations: 343460480629.4901
[2025-02-23 21:49:34] 2025-02-24 02:49:17,186 | INFO     | mean x: 1740349350.9027238
[2025-02-23 21:49:34] 2025-02-24 02:49:17,186 | INFO     | mean y: 2507714.1498054476
[2025-02-23 21:49:34] 2025-02-24 02:49:17,187 | INFO     | -- intersect: -14192402408.146107
[2025-02-23 21:49:34] 2025-02-24 02:49:17,187 | INFO     | intersect: -14192402408.146107
[2025-02-23 21:49:34] 2025-02-24 02:49:17,187 | INFO     | chi2: 5.811534636362795
[2025-02-23 21:49:34] 2025-02-24 02:49:17,187 | INFO     | current chi2=5.811534636362795 (change=10.515562861593208 %)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,187 | INFO     | right removable region: 513
[2025-02-23 21:49:34] 2025-02-24 02:49:17,188 | INFO     | model: linear, x: [1740334009.0, 1740334070.0, 1740334131.0, 1740334192.0, 1740334253.0, 1740334314.0, 1740334375.0, 1740334436.0, 1740334497.0, 1740334558.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,188 | INFO     | sum of square deviations: 42109419995.136284
[2025-02-23 21:49:34] 2025-02-24 02:49:17,201 | INFO     | sum of deviations: 172807443644.77402
[2025-02-23 21:49:34] 2025-02-24 02:49:17,202 | INFO     | mean x: 1740349655.9027238
[2025-02-23 21:49:34] 2025-02-24 02:49:17,202 | INFO     | mean y: 2521366.8754863814
[2025-02-23 21:49:34] 2025-02-24 02:49:17,202 | INFO     | -- intersect: -7139476198.499398
[2025-02-23 21:49:34] 2025-02-24 02:49:17,202 | INFO     | intersect: -7139476198.499398
[2025-02-23 21:49:34] 2025-02-24 02:49:17,202 | INFO     | chi2: 3.713098186878739
[2025-02-23 21:49:34] 2025-02-24 02:49:17,203 | INFO     | current chi2=3.713098186878739 (change=42.82671926043381 %)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,203 | INFO     | model: linear, x: [1740334314.0, 1740334375.0, 1740334436.0, 1740334497.0, 1740334558.0, 1740334619.0, 1740334680.0, 1740334741.0, 1740334802.0, 1740334863.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,204 | INFO     | sum of square deviations: 40892431716.81721
[2025-02-23 21:49:34] 2025-02-24 02:49:17,213 | INFO     | sum of deviations: 78109211011.25745
[2025-02-23 21:49:34] 2025-02-24 02:49:17,213 | INFO     | mean x: 1740349808.4066799
[2025-02-23 21:49:34] 2025-02-24 02:49:17,213 | INFO     | mean y: 2533230.394891945
[2025-02-23 21:49:34] 2025-02-24 02:49:17,213 | INFO     | -- intersect: -3321733503.3521733
[2025-02-23 21:49:34] 2025-02-24 02:49:17,213 | INFO     | intersect: -3321733503.3521733
[2025-02-23 21:49:34] 2025-02-24 02:49:17,214 | INFO     | chi2: 2.5358869678175466
[2025-02-23 21:49:34] 2025-02-24 02:49:17,214 | INFO     | current chi2=2.5358869678175466 (change=31.70428466505934 %)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,215 | INFO     | model: linear, x: [1740334619.0, 1740334680.0, 1740334741.0, 1740334802.0, 1740334863.0, 1740334924.0, 1740334985.0, 1740335046.0, 1740335107.0, 1740335168.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,215 | INFO     | sum of square deviations: 39699118300.98217
[2025-02-23 21:49:34] 2025-02-24 02:49:17,228 | INFO     | sum of deviations: -20553714242.071495
[2025-02-23 21:49:34] 2025-02-24 02:49:17,228 | INFO     | mean x: 1740349960.9107144
[2025-02-23 21:49:34] 2025-02-24 02:49:17,228 | INFO     | mean y: 2545840.6428571427
[2025-02-23 21:49:34] 2025-02-24 02:49:17,228 | INFO     | -- intersect: 903589926.976486
[2025-02-23 21:49:34] 2025-02-24 02:49:17,228 | INFO     | intersect: 903589926.976486
[2025-02-23 21:49:34] 2025-02-24 02:49:17,229 | INFO     | chi2: 1.2152285530348914
[2025-02-23 21:49:34] 2025-02-24 02:49:17,229 | INFO     | current chi2=1.2152285530348914 (change=52.078757119022924 %)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,229 | INFO     | model: linear, x: [1740334924.0, 1740334985.0, 1740335046.0, 1740335107.0, 1740335168.0, 1740335229.0, 1740335290.0, 1740335351.0, 1740335413.0, 1740335473.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,230 | INFO     | sum of square deviations: 38529247185.13013
[2025-02-23 21:49:34] 2025-02-24 02:49:17,239 | INFO     | sum of deviations: -65047985923.78957
[2025-02-23 21:49:34] 2025-02-24 02:49:17,239 | INFO     | mean x: 1740350113.4148297
[2025-02-23 21:49:34] 2025-02-24 02:49:17,239 | INFO     | mean y: 2551630.593186373
[2025-02-23 21:49:34] 2025-02-24 02:49:17,239 | INFO     | -- intersect: 2940742172.8564663
[2025-02-23 21:49:34] 2025-02-24 02:49:17,239 | INFO     | intersect: 2940742172.8564663
[2025-02-23 21:49:34] 2025-02-24 02:49:17,240 | INFO     | chi2: 0.9164338355605769
[2025-02-23 21:49:34] 2025-02-24 02:49:17,244 | INFO     | current chi2=0.9164338355605769 (change=24.587532668493477 %)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,244 | INFO     | left removable region: 40
[2025-02-23 21:49:34] 2025-02-24 02:49:17,245 | INFO     | model: linear, x: [1740336144.0, 1740336205.0, 1740336266.0, 1740336327.0, 1740336388.0, 1740336449.0, 1740336510.0, 1740336571.0, 1740336632.0, 1740336693.0, 1740
[2025-02-23 21:49:34] 2025-02-24 02:49:17,245 | INFO     | sum of square deviations: 32815051193.733624
[2025-02-23 21:49:34] 2025-02-24 02:49:17,254 | INFO     | sum of deviations: -56050671646.82029
[2025-02-23 21:49:34] 2025-02-24 02:49:17,254 | INFO     | mean x: 1740350540.4270613
[2025-02-23 21:49:34] 2025-02-24 02:49:17,254 | INFO     | mean y: 2558948.2515856237
[2025-02-23 21:49:34] 2025-02-24 02:49:17,254 | INFO     | -- intersect: 2975213664.404252
[2025-02-23 21:49:34] 2025-02-24 02:49:17,254 | INFO     | intersect: 2975213664.404252
[2025-02-23 21:49:34] 2025-02-24 02:49:17,255 | INFO     | chi2: 0.07764471749243275
[2025-02-23 21:49:34] 2025-02-24 02:49:17,255 | INFO     | -- intersect: 2975213664.404252
[2025-02-23 21:49:34] 2025-02-24 02:49:17,255 | INFO     | current memory leak: -1.71 B/s (using 473 data points, chi2=0.08)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | ..............................
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . Timing measurements:
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . get job = 0 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . initial setup = 6 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . payload setup = 27 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . stage-in = 0 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . payload execution = 31639 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . stage-out = 3 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | . log creation = 0 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,260 | INFO     | ..............................
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | 
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | job summary report
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | --------------------------------------------------
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | PanDA job id: 6523020546
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | task id: 43078919
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | errors: (none)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | pilot state: finished 
[2025-02-23 21:49:34] 2025-02-24 02:49:17,447 | INFO     | transexitcode: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | exeerrorcode: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | exeerrordiag: 
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | exitcode: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | exitmsg: OK
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | cpuconsumptiontime: 86530 s
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | nevents: 400
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | neventsw: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | pid: 3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | pgrp: 3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | corecount: 9
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | event service: False
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | sizes: {0: 2382483, 1: 2383168, 2: 2383367, 13: 2383367, 24: 2383423, 30: 2383657, 35: 2383813, 31670: 2422050, 31671: 2422049, 31675: 2431046, 31678: 2431102, 316
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | --------------------------------------------------
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | 
[2025-02-23 21:49:34] 2025-02-24 02:49:17,448 | INFO     | executing command: ls -lF /tmp/boinchome/slots/2
[2025-02-23 21:49:34] 2025-02-24 02:49:17,499 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,500 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-23 21:49:34] 2025-02-24 02:49:17,501 | INFO     | job 6523020546 has completed (purged errors)
[2025-02-23 21:49:34] 2025-02-24 02:49:17,502 | INFO     | overall cleanup function is called
[2025-02-23 21:49:34] 2025-02-24 02:49:18,518 | INFO     | --- collectZombieJob: --- 10, [3947485]
[2025-02-23 21:49:34] 2025-02-24 02:49:18,518 | INFO     | zombie collector waiting for pid 3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:18,519 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-23 21:49:34] 2025-02-24 02:49:18,519 | INFO     | collected zombie processes
[2025-02-23 21:49:34] 2025-02-24 02:49:18,520 | INFO     | will attempt to kill all subprocesses of pid=3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:18,725 | INFO     | process IDs to be killed: [3947485] (in reverse order)
[2025-02-23 21:49:34] 2025-02-24 02:49:19,172 | WARNING  | found no corresponding commands to process id(s)
[2025-02-23 21:49:34] 2025-02-24 02:49:19,172 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-23 21:49:34] 2025-02-24 02:49:19,187 | INFO     | did not find any defunct processes belonging to 3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:19,201 | INFO     | did not find any defunct processes belonging to 3947485
[2025-02-23 21:49:34] 2025-02-24 02:49:19,201 | INFO     | ready for new job
[2025-02-23 21:49:34] 2025-02-24 02:49:19,202 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-23 21:49:34] 2025-02-24 02:49:19,207 | INFO     | **************************************
[2025-02-23 21:49:34] 2025-02-24 02:49:19,207 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-23 21:49:34] 2025-02-24 02:49:19,207 | INFO     | **************************************
[2025-02-23 21:49:34] 2025-02-24 02:49:19,207 | INFO     | 
[2025-02-23 21:49:34] 2025-02-24 02:49:19,224 | INFO     | architecture information:
[2025-02-23 21:49:34] 2025-02-24 02:49:19,225 | INFO     | executing command: cat /etc/os-release
[2025-02-23 21:49:34] 2025-02-24 02:49:19,332 | INFO     | cat /etc/os-release:
[2025-02-23 21:49:34] NAME="CentOS Linux"
[2025-02-23 21:49:34] VERSION="7 (Core)"
[2025-02-23 21:49:34] ID="centos"
[2025-02-23 21:49:34] ID_LIKE="rhel fedora"
[2025-02-23 21:49:34] VERSION_ID="7"
[2025-02-23 21:49:34] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-23 21:49:34] ANSI_COLOR="0;31"
[2025-02-23 21:49:34] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-23 21:49:34] HOME_URL="https://www.centos.org/"
[2025-02-23 21:49:34] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-23 21:49:34] 
[2025-02-23 21:49:34] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-23 21:49:34] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-23 21:49:34] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-23 21:49:34] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-23 21:49:34] 
[2025-02-23 21:49:34] 2025-02-24 02:49:19,332 | INFO     | **************************************
[2025-02-23 21:49:34] 2025-02-24 02:49:19,838 | INFO     | executing command: df -mP /tmp/boinchome/slots/2
[2025-02-23 21:49:34] 2025-02-24 02:49:19,875 | INFO     | sufficient remaining disk space (74120691712 B)
[2025-02-23 21:49:34] 2025-02-24 02:49:19,875 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-23 21:49:34] 2025-02-24 02:49:19,876 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-23 21:49:34] 2025-02-24 02:49:19,877 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-02-23 21:49:34] 2025-02-24 02:49:19,877 | INFO     | found 0 job(s) in 20 queues
[2025-02-23 21:49:34] 2025-02-24 02:49:19,877 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-23 21:49:34] 2025-02-24 02:49:19,878 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-23 21:49:34] 2025-02-24 02:49:19,878 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-23 21:49:34] 2025-02-24 02:49:20,002 | INFO     | all data control threads have been joined
[2025-02-23 21:49:34] 2025-02-24 02:49:20,175 | INFO     | all job control threads have been joined
[2025-02-23 21:49:34] 2025-02-24 02:49:20,369 | INFO     | all payload control threads have been joined
[2025-02-23 21:49:34] 2025-02-24 02:49:20,577 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-23 21:49:34] 2025-02-24 02:49:20,577 | INFO     | aborting loop
[2025-02-23 21:49:34] 2025-02-24 02:49:20,882 | INFO     | [job] retrieve thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:20,999 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,008 | INFO     | [data] control thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,183 | INFO     | [job] control thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,295 | INFO     | [payload] validate_pre thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,362 | INFO     | [data] copytool_in thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,375 | INFO     | [payload] control thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,430 | INFO     | [job] validate thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,497 | INFO     | [payload] validate_post thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,583 | INFO     | [job] job monitor thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,835 | INFO     | [payload] failed_post thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:21,885 | INFO     | [data] copytool_out thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:22,287 | INFO     | [job] create_data_payload thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:22,312 | INFO     | [payload] execute_payloads thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:22,464 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-23 21:49:34] 2025-02-24 02:49:23,067 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-23 21:49:34] 2025-02-24 02:49:23,470 | INFO     | [job] queue monitor thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:27,076 | INFO     | [data] queue_monitor thread has finished
[2025-02-23 21:49:34] 2025-02-24 02:49:28,033 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139741710837568)>', '<ExcThread(monitor, started 139740846221056)>']
[2025-02-23 21:49:34] 2025-02-24 02:49:28,941 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-23 21:49:34] 2025-02-24 02:49:28,941 | INFO     | [monitor] control thread has ended
[2025-02-23 21:49:34] 2025-02-24 02:49:33,058 | INFO     | all workflow threads have been joined
[2025-02-23 21:49:34] 2025-02-24 02:49:33,059 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-23 21:49:34] 2025-02-24 02:49:33,060 | INFO     | traces error code: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:33,062 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-23 21:49:34] 2025-02-24 02:49:33,539 [wrapper] ==== pilot stdout END ====
[2025-02-23 21:49:34] 2025-02-24 02:49:33,556 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-23 21:49:34] 2025-02-24 02:49:33,571 [wrapper] pilotpid: 3939010
[2025-02-23 21:49:34] 2025-02-24 02:49:33,587 [wrapper] Pilot exit status: 0
[2025-02-23 21:49:34] 2025-02-24 02:49:33,696 [wrapper] pandaids: 6523020546
[2025-02-23 21:49:34] 2025-02-24 02:49:33,816 [wrapper] cleanup supervisor_pilot 1290987 3939011
[2025-02-23 21:49:34] 2025-02-24 02:49:33,831 [wrapper] Test setup, not cleaning
[2025-02-23 21:49:34] 2025-02-24 02:49:33,924 [wrapper] apfmon messages muted
[2025-02-23 21:49:34] 2025-02-24 02:49:33,934 [wrapper] ==== wrapper stdout END ====
[2025-02-23 21:49:34] 2025-02-24 02:49:33,945 [wrapper] ==== wrapper stderr END ====
[2025-02-23 21:49:34]  *** Error codes and diagnostics ***
[2025-02-23 21:49:34]     "exeErrorCode": 0,
[2025-02-23 21:49:34]     "exeErrorDiag": "",
[2025-02-23 21:49:34]     "pilotErrorCode": 0,
[2025-02-23 21:49:34]     "pilotErrorDiag": "",
[2025-02-23 21:49:34]  *** Listing of results directory ***
[2025-02-23 21:49:34] total 665044
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas    491065 Feb 22 08:09 pilot3.tar.gz
[2025-02-23 21:49:34] -rwx------. 1 boincer umatlas     35865 Feb 22 08:23 runpilot2-wrapper.sh
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas      5118 Feb 22 08:23 queuedata.json
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas       100 Feb 23 12:59 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-23 21:49:34] -rwxr-xr-x. 1 boincer umatlas      7986 Feb 23 12:59 run_atlas
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas       105 Feb 23 12:59 job.xml
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas 342500142 Feb 23 12:59 EVNT.43078917._002530.pool.root.1
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas    503553 Feb 23 12:59 input.tar.gz
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas     17569 Feb 23 12:59 start_atlas.sh
[2025-02-23 21:49:34] drwxrwx--x. 2 boincer umatlas      4096 Feb 23 12:59 shared
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas         0 Feb 23 12:59 boinc_lockfile
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas      2546 Feb 23 12:59 pandaJob.out
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas       467 Feb 23 12:59 setup.sh.local
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas    987744 Feb 23 12:59 agis_schedconf.cvmfs.json
[2025-02-23 21:49:34] drwx------. 4 boincer umatlas      4096 Feb 23 13:00 pilot3
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas      6841 Feb 23 21:47 init_data.xml
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas 325679400 Feb 23 21:47 HITS.43078919._087809.pool.root.1
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas       532 Feb 23 21:47 boinc_task_state.xml
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas        95 Feb 23 21:48 pilot_heartbeat.json
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas      1054 Feb 23 21:48 memory_monitor_summary.json
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas   1582569 Feb 23 21:48 agis_ddmendpoints.agis.ALL.json
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas    635353 Feb 23 21:48 log.43078919._087809.job.log.tgz.1
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas      7763 Feb 23 21:49 heartbeat.json
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas      8192 Feb 23 21:49 boinc_mmap_file
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas        28 Feb 23 21:49 wrapper_checkpoint.txt
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas      4338 Feb 23 21:49 pilotlog.txt
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas   3875567 Feb 23 21:49 log.43078919._087809.job.log.1
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas       357 Feb 23 21:49 output.list
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas       620 Feb 23 21:49 runtime_log
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas   4526080 Feb 23 21:49 result.tar.gz
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas     11424 Feb 23 21:49 runtime_log.err
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas       665 Feb 23 21:49 dPGODm1e456n9Rq4apOajLDm4fhM0noT9bVoFjIUDmVGeKDm8KFdCo.diag
[2025-02-23 21:49:34] -rw-r--r--. 1 boincer umatlas     21686 Feb 23 21:49 stderr.txt
[2025-02-23 21:49:34] HITS file was successfully produced:
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas 325679400 Feb 23 21:47 shared/HITS.pool.root.1
[2025-02-23 21:49:34]  *** Contents of shared directory: ***
[2025-02-23 21:49:34] total 657460
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas 342500142 Feb 23 12:59 ATLAS.root_0
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas    503553 Feb 23 12:59 input.tar.gz
[2025-02-23 21:49:34] -rw-r--r--. 2 boincer umatlas     17569 Feb 23 12:59 start_atlas.sh
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas 325679400 Feb 23 21:47 HITS.pool.root.1
[2025-02-23 21:49:34] -rw-------. 1 boincer umatlas   4526080 Feb 23 21:49 result.tar.gz
21:49:36 (3933346): run_atlas exited; CPU time 86413.677805
21:49:36 (3933346): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN