Name dXYMDmI0IW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm9g2LDmmuXv9m_2
Workunit 232091146
Created 6 May 2025, 6:30:18 UTC
Sent 6 May 2025, 9:28:40 UTC
Report deadline 14 May 2025, 9:28:40 UTC
Received 6 May 2025, 20:00:08 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10805936
Run time 10 hours 11 min 58 sec
CPU time 19 hours 49 min 15 sec
Validate state Valid
Credit 1,654.54
Device peak FLOPS 41.42 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 2.51 GB
Peak swap size 31.45 GB
Peak disk usage 834.38 MB

Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
05:29:06 (96063): wrapper (7.7.26015): starting
05:29:06 (96063): wrapper: running run_atlas (--nthreads 8)
[2025-05-06 05:29:06] Arguments: --nthreads 8
[2025-05-06 05:29:06] Threads: 8
[2025-05-06 05:29:06] Checking for CVMFS
[2025-05-06 05:29:06] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-06 05:29:07] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-06 05:29:07] Running cvmfs_config stat atlas.cern.ch
[2025-05-06 05:29:08] 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-05-06 05:29:08] 2.11.2.0 89917 2970 140000 145671 3 186 13971105 18432000 12513 130560 0 9592761 99.264 11974177 46255 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-06 05:29:08] CVMFS is ok
[2025-05-06 05:29:08] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-06 05:29:08] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-06 05:29:08] Further information can be found at the LHC@home message board.
[2025-05-06 05:29:08] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-06 05:29:08] Checking for apptainer binary...
[2025-05-06 05:29:08] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-06 05:29:08] Running /usr/bin/apptainer --version
[2025-05-06 05:29:08] apptainer version 1.3.2-1.el7
[2025-05-06 05:29:08] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-06 05:29:15] c-212-3.aglt2.org
[2025-05-06 05:29:15] apptainer works
[2025-05-06 05:29:15] Set ATHENA_PROC_NUMBER=8
[2025-05-06 05:29:15] Set ATHENA_CORE_NUMBER=8
[2025-05-06 05:29:15] Starting ATLAS job with PandaID=6634477726
[2025-05-06 05:29:15] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
10:20:02 (96063): BOINC client no longer exists - exiting
10:20:02 (96063): timer handler: client dead, exiting
10:29:09 (8143): wrapper (7.7.26015): starting
10:29:09 (8143): wrapper: running run_atlas (--nthreads 8)
[2025-05-06 10:29:09] Arguments: --nthreads 8
[2025-05-06 10:29:09] Threads: 8
[2025-05-06 10:29:09] This job has been restarted, cleaning up previous attempt
[2025-05-06 10:29:09] Checking for CVMFS
[2025-05-06 10:29:10] Probing /cvmfs/atlas.cern.ch... OK
[2025-05-06 10:29:10] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-05-06 10:29:10] Running cvmfs_config stat atlas.cern.ch
[2025-05-06 10:29:11] 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-05-06 10:29:11] 2.11.2.0 89917 3270 155400 145678 0 98 15119975 18432000 12519 130560 0 10941723 99.339 12360950 46474 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-05-06 10:29:11] CVMFS is ok
[2025-05-06 10:29:11] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-05-06 10:29:11] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-05-06 10:29:11] Further information can be found at the LHC@home message board.
[2025-05-06 10:29:11] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-05-06 10:29:11] Checking for apptainer binary...
[2025-05-06 10:29:11] Using apptainer found in PATH at /usr/bin/apptainer
[2025-05-06 10:29:11] Running /usr/bin/apptainer --version
[2025-05-06 10:29:11] apptainer version 1.3.2-1.el7
[2025-05-06 10:29:11] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-05-06 10:29:13] c-212-3.aglt2.org
[2025-05-06 10:29:13] apptainer works
[2025-05-06 10:29:13] Set ATHENA_PROC_NUMBER=8
[2025-05-06 10:29:13] Set ATHENA_CORE_NUMBER=8
[2025-05-06 10:29:13] Starting ATLAS job with PandaID=6634477726
[2025-05-06 10:29:13] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-05-06 15:50:12]  *** The last 200 lines of the pilot log: ***
[2025-05-06 15:50:12] 2025-05-06 19:49:46,909 | INFO     | mean y: 2398794.0415335465
[2025-05-06 15:50:12] 2025-05-06 19:49:46,909 | INFO     | -- intersect: -32421913671.325943
[2025-05-06 15:50:12] 2025-05-06 19:49:46,910 | INFO     | intersect: -32421913671.325943
[2025-05-06 15:50:12] 2025-05-06 19:49:46,910 | INFO     | chi2: 7.439929319119508
[2025-05-06 15:50:12] 2025-05-06 19:49:46,910 | INFO     | sum of square deviations: 9059949972.129932
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | sum of deviations: 215293404326.74045
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | mean x: 1746551224.6493506
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | mean y: 2411841.701298701
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | -- intersect: -41501234441.3914
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | intersect: -41501234441.3914
[2025-05-06 15:50:12] 2025-05-06 19:49:46,922 | INFO     | chi2: 5.853100768931642
[2025-05-06 15:50:12] 2025-05-06 19:49:46,923 | INFO     | current chi2=5.853100768931642 (change=21.328543352017512 %)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,923 | INFO     | right removable region: 307
[2025-05-06 15:50:12] 2025-05-06 19:49:46,923 | INFO     | sum of square deviations: 9059921912.129932
[2025-05-06 15:50:12] 2025-05-06 19:49:46,933 | INFO     | sum of deviations: 89719862533.06502
[2025-05-06 15:50:12] 2025-05-06 19:49:46,933 | INFO     | mean x: 1746551529.6493506
[2025-05-06 15:50:12] 2025-05-06 19:49:46,933 | INFO     | mean y: 2428269.074675325
[2025-05-06 15:50:12] 2025-05-06 19:49:46,934 | INFO     | -- intersect: -17293566626.560673
[2025-05-06 15:50:12] 2025-05-06 19:49:46,934 | INFO     | intersect: -17293566626.560673
[2025-05-06 15:50:12] 2025-05-06 19:49:46,934 | INFO     | chi2: 4.299889572477979
[2025-05-06 15:50:12] 2025-05-06 19:49:46,934 | INFO     | current chi2=4.299889572477979 (change=42.2052362590609 %)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,934 | INFO     | sum of square deviations: 8625797417.016481
[2025-05-06 15:50:12] 2025-05-06 19:49:46,944 | INFO     | sum of deviations: 23475368509.874603
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | mean x: 1746551682.1518152
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | mean y: 2451541.0462046205
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | -- intersect: -4750841676.711369
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | intersect: -4750841676.711369
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | chi2: 2.6011320116838603
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | current chi2=2.6011320116838603 (change=39.50700435814084 %)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,945 | INFO     | sum of square deviations: 8205766209.399314
[2025-05-06 15:50:12] 2025-05-06 19:49:46,947 | INFO     | sum of deviations: -19208838556.093964
[2025-05-06 15:50:12] 2025-05-06 19:49:46,947 | INFO     | mean x: 1746551834.6543624
[2025-05-06 15:50:12] 2025-05-06 19:49:46,947 | INFO     | mean y: 2466978.610738255
[2025-05-06 15:50:12] 2025-05-06 19:49:46,948 | INFO     | -- intersect: 4090961747.4839144
[2025-05-06 15:50:12] 2025-05-06 19:49:46,948 | INFO     | intersect: 4090961747.4839144
[2025-05-06 15:50:12] 2025-05-06 19:49:46,956 | INFO     | chi2: 1.7634022338859885
[2025-05-06 15:50:12] 2025-05-06 19:49:46,956 | INFO     | current chi2=1.7634022338859885 (change=32.206353773469644 %)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,957 | INFO     | sum of square deviations: 7799613904.088725
[2025-05-06 15:50:12] 2025-05-06 19:49:46,958 | INFO     | sum of deviations: -33351777036.385666
[2025-05-06 15:50:12] 2025-05-06 19:49:46,958 | INFO     | mean x: 1746551987.1535835
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | mean y: 2472288.986348123
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | -- intersect: 7470869208.924451
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | intersect: 7470869208.924451
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | chi2: 1.6826600438212647
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | current chi2=1.6826600438212647 (change=4.57877326642562 %)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | left removable region: 40
[2025-05-06 15:50:12] 2025-05-06 19:49:46,959 | INFO     | sum of square deviations: 5902104339.303359
[2025-05-06 15:50:12] 2025-05-06 19:49:46,969 | INFO     | sum of deviations: 3536995511.247191
[2025-05-06 15:50:12] 2025-05-06 19:49:46,969 | INFO     | mean x: 1746552414.1460674
[2025-05-06 15:50:12] 2025-05-06 19:49:46,969 | INFO     | mean y: 2488483.3782771537
[2025-05-06 15:50:12] 2025-05-06 19:49:46,970 | INFO     | -- intersect: -1044180245.9179822
[2025-05-06 15:50:12] 2025-05-06 19:49:46,970 | INFO     | intersect: -1044180245.9179822
[2025-05-06 15:50:12] 2025-05-06 19:49:46,970 | INFO     | chi2: 0.0012822143739003185
[2025-05-06 15:50:12] 2025-05-06 19:49:46,970 | INFO     | -- intersect: -1044180245.9179822
[2025-05-06 15:50:12] 2025-05-06 19:49:46,970 | INFO     | current memory leak: 0.60 B/s (using 267 data points, chi2=0.00)
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | ..............................
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . Timing measurements:
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . get job = 0 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . initial setup = 2 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . payload setup = 17 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . stage-in = 0 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . payload execution = 19073 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . stage-out = 4 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | . log creation = 0 s
[2025-05-06 15:50:12] 2025-05-06 19:49:46,971 | INFO     | ..............................
[2025-05-06 15:50:12] 2025-05-06 19:49:47,312 | INFO     | 
[2025-05-06 15:50:12] 2025-05-06 19:49:47,312 | INFO     | job summary report
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | --------------------------------------------------
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | PanDA job id: 6634477726
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | task id: 44506063
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | errors: (none)
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | status: LOG_TRANSFER = DONE 
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | pilot state: finished 
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | transexitcode: 0
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | exeerrorcode: 0
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | exeerrordiag: 
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | exitcode: 0
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | exitmsg: OK
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | cpuconsumptiontime: 38473 s
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | nevents: 400
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | neventsw: 0
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | pid: 72094
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | pgrp: 72094
[2025-05-06 15:50:12] 2025-05-06 19:49:47,313 | INFO     | corecount: 8
[2025-05-06 15:50:12] 2025-05-06 19:49:47,314 | INFO     | event service: False
[2025-05-06 15:50:12] 2025-05-06 19:49:47,314 | INFO     | sizes: {0: 2392906, 1: 2393591, 2: 2393790, 13: 2393790, 15: 2394052, 24: 2394080, 19095: 2427103, 19100: 2436044, 19101: 2436100, 19167: 2436270}
[2025-05-06 15:50:12] 2025-05-06 19:49:47,314 | INFO     | --------------------------------------------------
[2025-05-06 15:50:12] 2025-05-06 19:49:47,314 | INFO     | 
[2025-05-06 15:50:12] 2025-05-06 19:49:47,314 | INFO     | executing command: ls -lF /tmp/boinchome/slots/5
[2025-05-06 15:50:12] 2025-05-06 19:49:47,640 | INFO     | queue jobs had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue data_in had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue data_out had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,641 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | queue completed_jobids has 1 job(s)
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | queue messages had 0 job(s) [purged]
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | job 6634477726 has completed (purged errors)
[2025-05-06 15:50:12] 2025-05-06 19:49:47,642 | INFO     | overall cleanup function is called
[2025-05-06 15:50:12] 2025-05-06 19:49:48,650 | INFO     | --- collectZombieJob: --- 10, [72094]
[2025-05-06 15:50:12] 2025-05-06 19:49:48,650 | INFO     | zombie collector waiting for pid 72094
[2025-05-06 15:50:12] 2025-05-06 19:49:48,650 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-05-06 15:50:12] 2025-05-06 19:49:48,651 | INFO     | collected zombie processes
[2025-05-06 15:50:12] 2025-05-06 19:49:48,651 | INFO     | will attempt to kill all subprocesses of pid=72094
[2025-05-06 15:50:12] 2025-05-06 19:49:50,954 | INFO     | process IDs to be killed: [72094] (in reverse order)
[2025-05-06 15:50:12] 2025-05-06 19:49:51,803 | WARNING  | found no corresponding commands to process id(s)
[2025-05-06 15:50:12] 2025-05-06 19:49:51,803 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-05-06 15:50:12] 2025-05-06 19:49:51,915 | INFO     | did not find any defunct processes belonging to 72094
[2025-05-06 15:50:12] 2025-05-06 19:49:52,171 | INFO     | did not find any defunct processes belonging to 72094
[2025-05-06 15:50:12] 2025-05-06 19:49:52,171 | INFO     | ready for new job
[2025-05-06 15:50:12] 2025-05-06 19:49:52,171 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-05-06 15:50:12] 2025-05-06 19:49:52,208 | INFO     | **************************************
[2025-05-06 15:50:12] 2025-05-06 19:49:52,208 | INFO     | ***  PanDA Pilot version 3.10.2.2  ***
[2025-05-06 15:50:12] 2025-05-06 19:49:52,208 | INFO     | **************************************
[2025-05-06 15:50:12] 2025-05-06 19:49:52,208 | INFO     | 
[2025-05-06 15:50:12] 2025-05-06 19:49:52,282 | INFO     | architecture information:
[2025-05-06 15:50:12] 2025-05-06 19:49:52,290 | INFO     | executing command: cat /etc/os-release
[2025-05-06 15:50:12] 2025-05-06 19:49:52,450 | INFO     | cat /etc/os-release:
[2025-05-06 15:50:12] NAME="CentOS Linux"
[2025-05-06 15:50:12] VERSION="7 (Core)"
[2025-05-06 15:50:12] ID="centos"
[2025-05-06 15:50:12] ID_LIKE="rhel fedora"
[2025-05-06 15:50:12] VERSION_ID="7"
[2025-05-06 15:50:12] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-05-06 15:50:12] ANSI_COLOR="0;31"
[2025-05-06 15:50:12] CPE_NAME="cpe:/o:centos:centos:7"
[2025-05-06 15:50:12] HOME_URL="https://www.centos.org/"
[2025-05-06 15:50:12] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-05-06 15:50:12] 
[2025-05-06 15:50:12] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-05-06 15:50:12] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-05-06 15:50:12] REDHAT_SUPPORT_PRODUCT="centos"
[2025-05-06 15:50:12] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-05-06 15:50:12] 
[2025-05-06 15:50:12] 2025-05-06 19:49:52,451 | INFO     | **************************************
[2025-05-06 15:50:12] 2025-05-06 19:49:52,955 | INFO     | executing command: df -mP /tmp/boinchome/slots/5
[2025-05-06 15:50:12] 2025-05-06 19:49:52,972 | INFO     | sufficient remaining disk space (103449362432 B)
[2025-05-06 15:50:12] 2025-05-06 19:49:52,972 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-05-06 15:50:12] 2025-05-06 19:49:52,972 | INFO     | current server update state: UPDATING_FINAL
[2025-05-06 15:50:12] 2025-05-06 19:49:52,973 | INFO     | update_server=False
[2025-05-06 15:50:12] 2025-05-06 19:49:52,973 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-05-06 15:50:12] 2025-05-06 19:49:52,973 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-05-06 15:50:12] 2025-05-06 19:49:52,975 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-05-06 15:50:12] 2025-05-06 19:49:52,975 | INFO     | aborting loop
[2025-05-06 15:50:12] 2025-05-06 19:49:53,141 | INFO     | PID=30129 has CPU usage=3.4% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR 
[2025-05-06 15:50:12] 2025-05-06 19:49:53,141 | INFO     | .. there are 18 such processes running
[2025-05-06 15:50:12] 2025-05-06 19:49:53,142 | INFO     | found 0 job(s) in 20 queues
[2025-05-06 15:50:12] 2025-05-06 19:49:53,142 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-05-06 15:50:12] 2025-05-06 19:49:53,142 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-05-06 15:50:12] 2025-05-06 19:49:53,645 | INFO     | all job control threads have been joined
[2025-05-06 15:50:12] 2025-05-06 19:49:53,847 | INFO     | all data control threads have been joined
[2025-05-06 15:50:12] 2025-05-06 19:49:53,997 | INFO     | [job] job monitor thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:53,998 | INFO     | [job] retrieve thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,001 | INFO     | [job] queue monitor thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,092 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-05-06 15:50:12] 2025-05-06 19:49:54,253 | INFO     | all payload control threads have been joined
[2025-05-06 15:50:12] 2025-05-06 19:49:54,305 | INFO     | [payload] validate_post thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,320 | INFO     | [payload] validate_pre thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,461 | INFO     | [data] copytool_in thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,651 | INFO     | [job] control thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,853 | INFO     | [data] control thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:54,908 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-05-06 15:50:12] 2025-05-06 19:49:55,050 | INFO     | [job] create_data_payload thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:55,096 | INFO     | [job] validate thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:55,204 | INFO     | [payload] execute_payloads thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:55,259 | INFO     | [payload] control thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:55,491 | INFO     | [payload] failed_post thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:56,099 | INFO     | [data] copytool_out thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:49:58,917 | INFO     | [data] queue_monitor thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:50:03,214 | INFO     | job.realtimelogging is not enabled
[2025-05-06 15:50:12] 2025-05-06 19:50:04,222 | INFO     | [payload] run_realtimelog thread has finished
[2025-05-06 15:50:12] 2025-05-06 19:50:04,711 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140603203151680)>', '<ExcThread(monitor, started 140602909902592)>']
[2025-05-06 15:50:12] 2025-05-06 19:50:05,220 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-05-06 15:50:12] 2025-05-06 19:50:05,220 | INFO     | [monitor] control thread has ended
[2025-05-06 15:50:12] 2025-05-06 19:50:09,737 | INFO     | all workflow threads have been joined
[2025-05-06 15:50:12] 2025-05-06 19:50:09,737 | INFO     | end of generic workflow (traces error code: 0)
[2025-05-06 15:50:12] 2025-05-06 19:50:09,737 | INFO     | traces error code: 0
[2025-05-06 15:50:12] 2025-05-06 19:50:09,738 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-05-06 15:50:12] 2025-05-06 19:50:09,898 [wrapper] ==== pilot stdout END ====
[2025-05-06 15:50:12] 2025-05-06 19:50:09,933 [wrapper] ==== wrapper stdout RESUME ====
[2025-05-06 15:50:12] 2025-05-06 19:50:09,969 [wrapper] pilotpid: 30129
[2025-05-06 15:50:12] 2025-05-06 19:50:10,004 [wrapper] Pilot exit status: 0
[2025-05-06 15:50:12] 2025-05-06 19:50:10,170 [wrapper] pandaids: 6634477726 6634477726
[2025-05-06 15:50:12] 2025-05-06 19:50:10,578 [wrapper] cleanup supervisor_pilot 44442 30130
[2025-05-06 15:50:12] 2025-05-06 19:50:10,613 [wrapper] Test setup, not cleaning
[2025-05-06 15:50:12] 2025-05-06 19:50:10,653 [wrapper] apfmon messages muted
[2025-05-06 15:50:12] 2025-05-06 19:50:10,689 [wrapper] ==== wrapper stdout END ====
[2025-05-06 15:50:12] 2025-05-06 19:50:10,720 [wrapper] ==== wrapper stderr END ====
[2025-05-06 15:50:12]  *** Error codes and diagnostics ***
[2025-05-06 15:50:12]     "exeErrorCode": 0,
[2025-05-06 15:50:12]     "exeErrorDiag": "",
[2025-05-06 15:50:12]     "pilotErrorCode": 0,
[2025-05-06 15:50:12]     "pilotErrorDiag": "",
[2025-05-06 15:50:12]  *** Listing of results directory ***
[2025-05-06 15:50:12] total 631380
[2025-05-06 15:50:12] drwx------ 4 boincer umatlas      4096 Apr  3 04:00 pilot3
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas    495897 May  5 17:34 pilot3.tar.gz
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas      5111 May  5 17:57 queuedata.json
[2025-05-06 15:50:12] -rwx------ 1 boincer umatlas     37140 May  5 17:58 runpilot2-wrapper.sh
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas       100 May  6 05:29 wrapper_26015_x86_64-pc-linux-gnu
[2025-05-06 15:50:12] -rwxr-xr-x 1 boincer umatlas      7986 May  6 05:29 run_atlas
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas       105 May  6 05:29 job.xml
[2025-05-06 15:50:12] -rw-r--r-- 3 boincer umatlas 221987978 May  6 05:29 EVNT.44506061._000635.pool.root.1
[2025-05-06 15:50:12] -rw-r--r-- 3 boincer umatlas 221987978 May  6 05:29 ATLAS.root_0
[2025-05-06 15:50:12] -rw-r--r-- 2 boincer umatlas     17569 May  6 05:29 start_atlas.sh
[2025-05-06 15:50:12] drwxrwx--x 2 boincer umatlas      4096 May  6 05:29 shared
[2025-05-06 15:50:12] -rw-r--r-- 2 boincer umatlas    508879 May  6 05:29 input.tar.gz
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas         0 May  6 05:29 boinc_lockfile
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas      2555 May  6 10:29 pandaJob.out
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas       467 May  6 10:29 setup.sh.local
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas    998316 May  6 10:29 agis_schedconf.cvmfs.json
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas 194572637 May  6 15:46 HITS.44506063._015837.pool.root.1
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas       531 May  6 15:47 boinc_task_state.xml
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas      1074 May  6 15:48 memory_monitor_summary.json
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas   1596741 May  6 15:48 agis_ddmendpoints.agis.ALL.json
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas    429123 May  6 15:48 log.44506063._015837.job.log.tgz.1
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas      6387 May  6 15:49 init_data.xml
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas        96 May  6 15:49 pilot_heartbeat.json
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas      7738 May  6 15:49 heartbeat.json
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas      4819 May  6 15:50 pilotlog.txt
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas        28 May  6 15:50 wrapper_checkpoint.txt
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas   1634483 May  6 15:50 log.44506063._015837.job.log.1
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas      8192 May  6 15:50 boinc_mmap_file
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas       357 May  6 15:50 output.list
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas       620 May  6 15:50 runtime_log
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas   2078720 May  6 15:50 result.tar.gz
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas     11499 May  6 15:50 runtime_log.err
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas       787 May  6 15:50 dXYMDmI0IW7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm9g2LDmmuXv9m.diag
[2025-05-06 15:50:12] -rw-r--r-- 1 boincer umatlas     23199 May  6 15:50 stderr.txt
[2025-05-06 15:50:12] HITS file was successfully produced:
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas 194572637 May  6 15:46 shared/HITS.pool.root.1
[2025-05-06 15:50:12]  *** Contents of shared directory: ***
[2025-05-06 15:50:12] total 409364
[2025-05-06 15:50:12] -rw-r--r-- 3 boincer umatlas 221987978 May  6 05:29 ATLAS.root_0
[2025-05-06 15:50:12] -rw-r--r-- 2 boincer umatlas     17569 May  6 05:29 start_atlas.sh
[2025-05-06 15:50:12] -rw-r--r-- 2 boincer umatlas    508879 May  6 05:29 input.tar.gz
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas 194572637 May  6 15:46 HITS.pool.root.1
[2025-05-06 15:50:12] -rw------- 1 boincer umatlas   2078720 May  6 15:50 result.tar.gz
15:50:13 (8143): run_atlas exited; CPU time 38138.250454
15:50:13 (8143): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN