Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
10:10:11 (179799): wrapper (7.7.26015): starting
10:10:11 (179799): wrapper: running run_atlas (--nthreads 8)
[2025-02-24 10:10:11] Arguments: --nthreads 8
[2025-02-24 10:10:11] Threads: 8
[2025-02-24 10:10:11] Checking for CVMFS
[2025-02-24 10:10:12] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-24 10:10:13] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-24 10:10:13] Running cvmfs_config stat atlas.cern.ch
[2025-02-24 10:10:14] 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-24 10:10:14] 2.11.2.0 158282 5499 161124 143009 2 514 18092866 18432000 19918 130560 0 25737908 98.908 61011537 46621 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-02-24 10:10:14] CVMFS is ok
[2025-02-24 10:10:14] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-24 10:10:14] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-24 10:10:14] Further information can be found at the LHC@home message board.
[2025-02-24 10:10:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-24 10:10:14] Checking for apptainer binary...
[2025-02-24 10:10:14] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-24 10:10:14] Running /usr/bin/apptainer --version
[2025-02-24 10:10:15] apptainer version 1.3.2-1.el7
[2025-02-24 10:10:15] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-24 10:11:00] c-211-35-2.aglt2.org
[2025-02-24 10:11:00] apptainer works
[2025-02-24 10:11:00] Set ATHENA_PROC_NUMBER=8
[2025-02-24 10:11:00] Set ATHENA_CORE_NUMBER=8
[2025-02-24 10:11:00] Starting ATLAS job with PandaID=6524006410
[2025-02-24 10:11:00] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/4 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-24 15:04:06]  *** The last 200 lines of the pilot log: ***
[2025-02-24 15:04:06] 2025-02-24 20:03:46,320 | INFO     | chi2: 8.836662024101532
[2025-02-24 15:04:06] 2025-02-24 20:03:46,320 | INFO     | current chi2=8.836662024101532 (change=31.118277090603293 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,320 | INFO     | model: linear, x: [1740411370.0, 1740411431.0, 1740411492.0, 1740411553.0, 1740411614.0, 1740411675.0, 1740411736.0, 1740411797.0, 1740411858.0, 1740411920.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,320 | INFO     | sum of square deviations: 5705286943.757604
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | sum of deviations: 151560229129.81815
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | mean x: 1740419391.530303
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | mean y: 2497026.022727273
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | -- intersect: -46231524919.34542
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | intersect: -46231524919.34542
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | chi2: 5.872398092742945
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | current chi2=5.872398092742945 (change=33.54506399898188 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,321 | INFO     | model: linear, x: [1740411675.0, 1740411736.0, 1740411797.0, 1740411858.0, 1740411920.0, 1740411980.0, 1740412041.0, 1740412102.0, 1740412163.0, 1740412224.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,322 | INFO     | sum of square deviations: 5387213423.752904
[2025-02-24 15:04:06] 2025-02-24 20:03:46,322 | INFO     | sum of deviations: 91410338725.35143
[2025-02-24 15:04:06] 2025-02-24 20:03:46,322 | INFO     | mean x: 1740419544.030888
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | mean y: 2525857.081081081
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | -- intersect: -29528945709.021526
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | intersect: -29528945709.021526
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | chi2: 4.006807131903246
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | current chi2=4.006807131903246 (change=31.768809460400497 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | model: linear, x: [1740411980.0, 1740412041.0, 1740412102.0, 1740412163.0, 1740412224.0, 1740412285.0, 1740412346.0, 1740412407.0, 1740412468.0, 1740412529.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,323 | INFO     | sum of square deviations: 5081202195.307067
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | sum of deviations: 40552648848.8898
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | mean x: 1740419696.527559
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | mean y: 2551200.5157480314
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | -- intersect: -13887592527.312866
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | intersect: -13887592527.312866
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | chi2: 2.6639041515526274
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | current chi2=2.6639041515526274 (change=33.51553833619976 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,324 | INFO     | model: linear, x: [1740412285.0, 1740412346.0, 1740412407.0, 1740412468.0, 1740412529.0, 1740412590.0, 1740412651.0, 1740412712.0, 1740412773.0, 1740412834.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,325 | INFO     | sum of square deviations: 4786989892.803185
[2025-02-24 15:04:06] 2025-02-24 20:03:46,325 | INFO     | sum of deviations: -8013594422.658649
[2025-02-24 15:04:06] 2025-02-24 20:03:46,325 | INFO     | mean x: 1740419849.0281124
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | mean y: 2576367.236947791
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | -- intersect: 2916102217.0040836
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | intersect: 2916102217.0040836
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | chi2: 1.4114834242434104
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | current chi2=1.4114834242434104 (change=47.014481605100436 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | model: linear, x: [1740412590.0, 1740412651.0, 1740412712.0, 1740412773.0, 1740412834.0, 1740412895.0, 1740412956.0, 1740413018.0, 1740413078.0, 1740413139.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,326 | INFO     | sum of square deviations: 4504359202.79918
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | sum of deviations: -29237956209.446777
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | mean x: 1740420001.5286884
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | mean y: 2587806.1352459015
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | -- intersect: 11299716098.905146
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | intersect: 11299716098.905146
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | chi2: 1.1471811763009825
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | current chi2=1.1471811763009825 (change=18.7251400478968 %)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | left removable region: 70
[2025-02-24 15:04:06] 2025-02-24 20:03:46,327 | INFO     | model: linear, x: [1740414725.0, 1740414787.0, 1740414847.0, 1740414908.0, 1740414969.0, 1740415030.0, 1740415091.0, 1740415152.0, 1740415213.0, 1740415274.0, 1740
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | sum of square deviations: 2593893485.9802933
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | sum of deviations: -24608699573.50735
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | mean x: 1740420886.0098522
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | mean y: 2603253.7536945813
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | -- intersect: 16514266106.049908
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | intersect: 16514266106.049908
[2025-02-24 15:04:06] 2025-02-24 20:03:46,328 | INFO     | chi2: 0.1474486691408263
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | -- intersect: 16514266106.049908
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | current memory leak: -9.49 B/s (using 203 data points, chi2=0.15)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | ..............................
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . Timing measurements:
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . get job = 0 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . initial setup = 15 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . payload setup = 128 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . stage-in = 0 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . payload execution = 17118 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . stage-out = 2 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | . log creation = 0 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,329 | INFO     | ..............................
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | 
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | job summary report
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | --------------------------------------------------
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | PanDA job id: 6524006410
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | task id: 43078919
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | errors: (none)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | pilot state: finished 
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | transexitcode: 0
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | exeerrorcode: 0
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | exeerrordiag: 
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | exitcode: 0
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | exitmsg: OK
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | cpuconsumptiontime: 86307 s
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | nevents: 400
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | neventsw: 0
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | pid: 257443
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | pgrp: 257443
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | corecount: 8
[2025-02-24 15:04:06] 2025-02-24 20:03:46,377 | INFO     | event service: False
[2025-02-24 15:04:06] 2025-02-24 20:03:46,378 | INFO     | sizes: {0: 2382483, 1: 2383168, 2: 2383367, 13: 2383367, 24: 2383423, 35: 2383451, 46: 2383607, 57: 2383635, 60: 2383869, 67: 2383897, 17251: 2415859, 17253: 24248
[2025-02-24 15:04:06] 2025-02-24 20:03:46,378 | INFO     | --------------------------------------------------
[2025-02-24 15:04:06] 2025-02-24 20:03:46,378 | INFO     | 
[2025-02-24 15:04:06] 2025-02-24 20:03:46,378 | INFO     | executing command: ls -lF /tmp/boinchome/slots/4
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,398 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | job 6524006410 has completed (purged errors)
[2025-02-24 15:04:06] 2025-02-24 20:03:46,399 | INFO     | overall cleanup function is called
[2025-02-24 15:04:06] 2025-02-24 20:03:47,401 | INFO     | --- collectZombieJob: --- 10, [257443]
[2025-02-24 15:04:06] 2025-02-24 20:03:47,401 | INFO     | zombie collector waiting for pid 257443
[2025-02-24 15:04:06] 2025-02-24 20:03:47,401 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-24 15:04:06] 2025-02-24 20:03:47,402 | INFO     | collected zombie processes
[2025-02-24 15:04:06] 2025-02-24 20:03:47,402 | INFO     | will attempt to kill all subprocesses of pid=257443
[2025-02-24 15:04:06] 2025-02-24 20:03:47,545 | INFO     | process IDs to be killed: [257443] (in reverse order)
[2025-02-24 15:04:06] 2025-02-24 20:03:47,654 | WARNING  | found no corresponding commands to process id(s)
[2025-02-24 15:04:06] 2025-02-24 20:03:47,654 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-24 15:04:06] 2025-02-24 20:03:47,661 | INFO     | did not find any defunct processes belonging to 257443
[2025-02-24 15:04:06] 2025-02-24 20:03:47,667 | INFO     | did not find any defunct processes belonging to 257443
[2025-02-24 15:04:06] 2025-02-24 20:03:47,667 | INFO     | ready for new job
[2025-02-24 15:04:06] 2025-02-24 20:03:47,667 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-24 15:04:06] 2025-02-24 20:03:47,669 | INFO     | **************************************
[2025-02-24 15:04:06] 2025-02-24 20:03:47,669 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-24 15:04:06] 2025-02-24 20:03:47,669 | INFO     | **************************************
[2025-02-24 15:04:06] 2025-02-24 20:03:47,669 | INFO     | 
[2025-02-24 15:04:06] 2025-02-24 20:03:47,672 | INFO     | architecture information:
[2025-02-24 15:04:06] 2025-02-24 20:03:47,672 | INFO     | executing command: cat /etc/os-release
[2025-02-24 15:04:06] 2025-02-24 20:03:47,687 | INFO     | cat /etc/os-release:
[2025-02-24 15:04:06] NAME="CentOS Linux"
[2025-02-24 15:04:06] VERSION="7 (Core)"
[2025-02-24 15:04:06] ID="centos"
[2025-02-24 15:04:06] ID_LIKE="rhel fedora"
[2025-02-24 15:04:06] VERSION_ID="7"
[2025-02-24 15:04:06] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-24 15:04:06] ANSI_COLOR="0;31"
[2025-02-24 15:04:06] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-24 15:04:06] HOME_URL="https://www.centos.org/"
[2025-02-24 15:04:06] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-24 15:04:06] 
[2025-02-24 15:04:06] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-24 15:04:06] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-24 15:04:06] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-24 15:04:06] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-24 15:04:06] 
[2025-02-24 15:04:06] 2025-02-24 20:03:47,687 | INFO     | **************************************
[2025-02-24 15:04:06] 2025-02-24 20:03:48,189 | INFO     | executing command: df -mP /tmp/boinchome/slots/4
[2025-02-24 15:04:06] 2025-02-24 20:03:48,210 | INFO     | sufficient remaining disk space (106211311616 B)
[2025-02-24 15:04:06] 2025-02-24 20:03:48,210 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-24 15:04:06] 2025-02-24 20:03:48,210 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-24 15:04:06] 2025-02-24 20:03:48,210 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-02-24 15:04:06] 2025-02-24 20:03:48,211 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-24 15:04:06] 2025-02-24 20:03:48,211 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-24 15:04:06] 2025-02-24 20:03:48,211 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-24 15:04:06] 2025-02-24 20:03:48,212 | INFO     | found 0 job(s) in 20 queues
[2025-02-24 15:04:06] 2025-02-24 20:03:48,212 | INFO     | aborting loop
[2025-02-24 15:04:06] 2025-02-24 20:03:48,212 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-24 15:04:06] 2025-02-24 20:03:48,213 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-24 15:04:06] 2025-02-24 20:03:48,807 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-24 15:04:06] 2025-02-24 20:03:49,134 | INFO     | all data control threads have been joined
[2025-02-24 15:04:06] 2025-02-24 20:03:49,213 | INFO     | [job] retrieve thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,217 | INFO     | [job] queue monitor thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,218 | INFO     | [job] job monitor thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,328 | INFO     | [payload] validate_post thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,333 | INFO     | all job control threads have been joined
[2025-02-24 15:04:06] 2025-02-24 20:03:49,444 | INFO     | all payload control threads have been joined
[2025-02-24 15:04:06] 2025-02-24 20:03:49,522 | INFO     | [job] validate thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,833 | INFO     | [payload] validate_pre thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:49,951 | INFO     | [data] copytool_in thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,084 | INFO     | [job] create_data_payload thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,140 | INFO     | [data] control thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,213 | INFO     | [data] copytool_out thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,243 | INFO     | [payload] execute_payloads thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,338 | INFO     | [job] control thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,445 | INFO     | [payload] control thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:50,468 | INFO     | [payload] failed_post thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:52,813 | INFO     | [data] queue_monitor thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:03:58,468 | INFO     | job.realtimelogging is not enabled
[2025-02-24 15:04:06] 2025-02-24 20:03:59,474 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-24 15:04:06] 2025-02-24 20:04:00,771 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140607716398912)>', '<ExcThread(monitor, started 140607154546432)>']
[2025-02-24 15:04:06] 2025-02-24 20:04:01,259 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-24 15:04:06] 2025-02-24 20:04:01,259 | INFO     | [monitor] control thread has ended
[2025-02-24 15:04:06] 2025-02-24 20:04:05,796 | INFO     | all workflow threads have been joined
[2025-02-24 15:04:06] 2025-02-24 20:04:05,796 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-24 15:04:06] 2025-02-24 20:04:05,796 | INFO     | traces error code: 0
[2025-02-24 15:04:06] 2025-02-24 20:04:05,796 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-24 15:04:06] 2025-02-24 20:04:05,924 [wrapper] ==== pilot stdout END ====
[2025-02-24 15:04:06] 2025-02-24 20:04:05,927 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-24 15:04:06] 2025-02-24 20:04:05,930 [wrapper] pilotpid: 207206
[2025-02-24 15:04:06] 2025-02-24 20:04:05,932 [wrapper] Pilot exit status: 0
[2025-02-24 15:04:06] 2025-02-24 20:04:05,941 [wrapper] pandaids: 6524006410
[2025-02-24 15:04:06] 2025-02-24 20:04:05,987 [wrapper] cleanup supervisor_pilot  97707 207207
[2025-02-24 15:04:06] 2025-02-24 20:04:05,989 [wrapper] Test setup, not cleaning
[2025-02-24 15:04:06] 2025-02-24 20:04:05,994 [wrapper] apfmon messages muted
[2025-02-24 15:04:06] 2025-02-24 20:04:05,997 [wrapper] ==== wrapper stdout END ====
[2025-02-24 15:04:06] 2025-02-24 20:04:05,999 [wrapper] ==== wrapper stderr END ====
[2025-02-24 15:04:06]  *** Error codes and diagnostics ***
[2025-02-24 15:04:06]     "exeErrorCode": 0,
[2025-02-24 15:04:06]     "exeErrorDiag": "",
[2025-02-24 15:04:06]     "pilotErrorCode": 0,
[2025-02-24 15:04:06]     "pilotErrorDiag": "",
[2025-02-24 15:04:06]  *** Listing of results directory ***
[2025-02-24 15:04:06] total 669220
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas    491065 Feb 23 01:58 pilot3.tar.gz
[2025-02-24 15:04:06] -rwx------ 1 boincer umatlas     35865 Feb 23 02:39 runpilot2-wrapper.sh
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas      5118 Feb 23 02:39 queuedata.json
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas       100 Feb 24 10:10 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-24 15:04:06] -rwxr-xr-x 1 boincer umatlas      7986 Feb 24 10:10 run_atlas
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas       105 Feb 24 10:10 job.xml
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas 347231237 Feb 24 10:10 EVNT.43078917._002038.pool.root.1
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas     17569 Feb 24 10:10 start_atlas.sh
[2025-02-24 15:04:06] drwxrwx--x 2 boincer umatlas      4096 Feb 24 10:10 shared
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas    503555 Feb 24 10:10 input.tar.gz
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas         0 Feb 24 10:10 boinc_lockfile
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas      2546 Feb 24 10:11 pandaJob.out
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas       467 Feb 24 10:11 setup.sh.local
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas    987749 Feb 24 10:13 agis_schedconf.cvmfs.json
[2025-02-24 15:04:06] drwx------ 4 boincer umatlas      4096 Feb 24 10:13 pilot3
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas      6386 Feb 24 14:56 init_data.xml
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas 329569325 Feb 24 15:03 HITS.43078919._090772.pool.root.1
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas       531 Feb 24 15:03 boinc_task_state.xml
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas        95 Feb 24 15:03 pilot_heartbeat.json
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas      1065 Feb 24 15:03 memory_monitor_summary.json
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas   1582569 Feb 24 15:03 agis_ddmendpoints.agis.ALL.json
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas    446925 Feb 24 15:03 log.43078919._090772.job.log.tgz.1
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas      7796 Feb 24 15:03 heartbeat.json
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas      8192 Feb 24 15:04 boinc_mmap_file
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas        28 Feb 24 15:04 wrapper_checkpoint.txt
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas      4411 Feb 24 15:04 pilotlog.txt
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas   1889410 Feb 24 15:04 log.43078919._090772.job.log.1
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas       357 Feb 24 15:04 output.list
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas       620 Feb 24 15:04 runtime_log
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas   2355200 Feb 24 15:04 result.tar.gz
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas     11429 Feb 24 15:04 runtime_log.err
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas       664 Feb 24 15:04 kz9NDmllL66nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm1CvKDmXRzbTo.diag
[2025-02-24 15:04:06] -rw-r--r-- 1 boincer umatlas     21712 Feb 24 15:04 stderr.txt
[2025-02-24 15:04:06] HITS file was successfully produced:
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas 329569325 Feb 24 15:03 shared/HITS.pool.root.1
[2025-02-24 15:04:06]  *** Contents of shared directory: ***
[2025-02-24 15:04:06] total 663760
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas 347231237 Feb 24 10:10 ATLAS.root_0
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas     17569 Feb 24 10:10 start_atlas.sh
[2025-02-24 15:04:06] -rw-r--r-- 2 boincer umatlas    503555 Feb 24 10:10 input.tar.gz
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas 329569325 Feb 24 15:03 HITS.pool.root.1
[2025-02-24 15:04:06] -rw------- 1 boincer umatlas   2355200 Feb 24 15:04 result.tar.gz
15:04:07 (179799): run_atlas exited; CPU time 86204.315178
15:04:07 (179799): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN