Name | ZSoKDm6sj56n9Rq4apOajLDm4fhM0noT9bVoFjIUDmWVdKDmqIAQPo_3 |
Workunit | 230497634 |
Created | 24 Feb 2025, 13:37:53 UTC |
Sent | 24 Feb 2025, 13:37:56 UTC |
Report deadline | 4 Mar 2025, 13:37:56 UTC |
Received | 24 Feb 2025, 22:23:26 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10687461 |
Run time | 8 hours 35 min 49 sec |
CPU time | 1 days 8 hours 13 min 36 sec |
Validate state | Valid |
Credit | 1,409.41 |
Device peak FLOPS | 33.45 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.69 GB |
Peak swap size | 31.52 GB |
Peak disk usage | 1.26 GB |
<core_client_version>7.7.0</core_client_version> <![CDATA[ <stderr_txt> 08:38:18 (18585): wrapper (7.7.26015): starting 08:38:18 (18585): wrapper: running run_atlas (--nthreads 10) [2025-02-24 08:38:19] Arguments: --nthreads 10 [2025-02-24 08:38:19] Threads: 10 [2025-02-24 08:38:19] Checking for CVMFS [2025-02-24 08:38:19] Probing /cvmfs/atlas.cern.ch... OK [2025-02-24 08:38:20] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-02-24 08:38:20] Running cvmfs_config stat atlas.cern.ch [2025-02-24 08:38:21] 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 08:38:21] 2.11.2.0 16907 139686 179372 143009 0 324 12947954 18432000 9128 130560 0 55000857 98.871 139170171 42921 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1 [2025-02-24 08:38:21] CVMFS is ok [2025-02-24 08:38:21] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-02-24 08:38:21] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-02-24 08:38:21] Further information can be found at the LHC@home message board. [2025-02-24 08:38:21] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-02-24 08:38:21] Checking for apptainer binary... [2025-02-24 08:38:21] Using apptainer found in PATH at /usr/bin/apptainer [2025-02-24 08:38:21] Running /usr/bin/apptainer --version [2025-02-24 08:38:21] apptainer version 1.3.2-1.el7 [2025-02-24 08:38:21] 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 08:38:29] c-210-12.aglt2.org [2025-02-24 08:38:29] apptainer works [2025-02-24 08:38:29] Set ATHENA_PROC_NUMBER=10 [2025-02-24 08:38:29] Set ATHENA_CORE_NUMBER=10 [2025-02-24 08:38:29] Starting ATLAS job with PandaID=6522370765 [2025-02-24 08:38:29] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh 12:28:13 (12373): wrapper (7.7.26015): starting 12:28:13 (12373): wrapper: running run_atlas (--nthreads 10) [2025-02-24 12:28:13] Arguments: --nthreads 10 [2025-02-24 12:28:13] Threads: 10 [2025-02-24 12:28:13] This job has been restarted, cleaning up previous attempt [2025-02-24 12:28:13] Checking for CVMFS [2025-02-24 12:28:13] Probing /cvmfs/atlas.cern.ch... OK [2025-02-24 12:28:13] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-02-24 12:28:13] Running cvmfs_config stat atlas.cern.ch [2025-02-24 12:28: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 12:28:14] 2.11.2.0 16907 139916 191112 143011 2 314 9575371 18432001 8313 130560 0 55486359 98.861 141145970 42818 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1 [2025-02-24 12:28:14] CVMFS is ok [2025-02-24 12:28:14] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-02-24 12:28:14] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-02-24 12:28:14] Further information can be found at the LHC@home message board. [2025-02-24 12:28:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-02-24 12:28:14] Checking for apptainer binary... [2025-02-24 12:28:14] Using apptainer found in PATH at /usr/bin/apptainer [2025-02-24 12:28:14] Running /usr/bin/apptainer --version [2025-02-24 12:28:14] apptainer version 1.3.2-1.el7 [2025-02-24 12:28:14] 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 12:28:17] c-210-12.aglt2.org [2025-02-24 12:28:17] apptainer works [2025-02-24 12:28:17] Set ATHENA_PROC_NUMBER=10 [2025-02-24 12:28:17] Set ATHENA_CORE_NUMBER=10 [2025-02-24 12:28:17] Starting ATLAS job with PandaID=6522370765 [2025-02-24 12:28:17] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-02-24 17:22:18] *** The last 200 lines of the pilot log: *** [2025-02-24 17:22:18] 2025-02-24 22:22:06,798 | INFO | chi2: 7.286365039170705 [2025-02-24 17:22:18] 2025-02-24 22:22:06,798 | INFO | model: linear, x: [1740418146.0, 1740418207.0, 1740418268.0, 1740418329.0, 1740418390.0, 1740418451.0, 1740418512.0, 1740418573.0, 1740418634.0, 1740418695.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,798 | INFO | sum of square deviations: 7102621634.207746 [2025-02-24 17:22:18] 2025-02-24 22:22:06,800 | INFO | sum of deviations: 248556919817.92975 [2025-02-24 17:22:18] 2025-02-24 22:22:06,800 | INFO | mean x: 1740426777.5528169 [2025-02-24 17:22:18] 2025-02-24 22:22:06,800 | INFO | mean y: 2665615.3380281692 [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | -- intersect: -60903735045.75064 [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | intersect: -60903735045.75064 [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | chi2: 6.491345071354941 [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | current chi2=6.491345071354941 (change=10.911064207486486 %) [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | right removable region: 283 [2025-02-24 17:22:18] 2025-02-24 22:22:06,801 | INFO | model: linear, x: [1740418451.0, 1740418512.0, 1740418573.0, 1740418634.0, 1740418695.0, 1740418756.0, 1740418817.0, 1740418878.0, 1740418939.0, 1740419000.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,802 | INFO | sum of square deviations: 7102612484.207746 [2025-02-24 17:22:18] 2025-02-24 22:22:06,803 | INFO | sum of deviations: 140292453334.61627 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | mean x: 1740427082.5528169 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | mean y: 2692751.7922535213 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | -- intersect: -34374627678.43519 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | intersect: -34374627678.43519 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | chi2: 4.205905476779145 [2025-02-24 17:22:18] 2025-02-24 22:22:06,804 | INFO | current chi2=4.205905476779145 (change=42.27704137565638 %) [2025-02-24 17:22:18] 2025-02-24 22:22:06,805 | INFO | model: linear, x: [1740418756.0, 1740418817.0, 1740418878.0, 1740418939.0, 1740419000.0, 1740419061.0, 1740419122.0, 1740419183.0, 1740419244.0, 1740419305.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,805 | INFO | sum of square deviations: 6734024254.19357 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | sum of deviations: 71861062508.81725 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | mean x: 1740427235.0537634 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | mean y: 2721066.41218638 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | -- intersect: -18569969736.172997 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | intersect: -18569969736.172997 [2025-02-24 17:22:18] 2025-02-24 22:22:06,807 | INFO | chi2: 2.476619584071611 [2025-02-24 17:22:18] 2025-02-24 22:22:06,808 | INFO | current chi2=2.476619584071611 (change=41.1156623051788 %) [2025-02-24 17:22:18] 2025-02-24 22:22:06,808 | INFO | model: linear, x: [1740419061.0, 1740419122.0, 1740419183.0, 1740419244.0, 1740419305.0, 1740419366.0, 1740419427.0, 1740419488.0, 1740419549.0, 1740419610.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,808 | INFO | sum of square deviations: 6378413011.678868 [2025-02-24 17:22:18] 2025-02-24 22:22:06,810 | INFO | sum of deviations: 15311694001.561985 [2025-02-24 17:22:18] 2025-02-24 22:22:06,810 | INFO | mean x: 1740427387.5547445 [2025-02-24 17:22:18] 2025-02-24 22:22:06,810 | INFO | mean y: 2745263.02919708 [2025-02-24 17:22:18] 2025-02-24 22:22:06,810 | INFO | -- intersect: -4175236241.3641496 [2025-02-24 17:22:18] 2025-02-24 22:22:06,810 | INFO | intersect: -4175236241.3641496 [2025-02-24 17:22:18] 2025-02-24 22:22:06,811 | INFO | chi2: 1.222595612266352 [2025-02-24 17:22:18] 2025-02-24 22:22:06,811 | INFO | current chi2=1.222595612266352 (change=50.63450115110611 %) [2025-02-24 17:22:18] 2025-02-24 22:22:06,811 | INFO | model: linear, x: [1740419366.0, 1740419427.0, 1740419488.0, 1740419549.0, 1740419610.0, 1740419671.0, 1740419732.0, 1740419793.0, 1740419854.0, 1740419916.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,811 | INFO | sum of square deviations: 6035546194.163573 [2025-02-24 17:22:18] 2025-02-24 22:22:06,813 | INFO | sum of deviations: -5655268703.843878 [2025-02-24 17:22:18] 2025-02-24 22:22:06,813 | INFO | mean x: 1740427540.055762 [2025-02-24 17:22:18] 2025-02-24 22:22:06,813 | INFO | mean y: 2754584.189591078 [2025-02-24 17:22:18] 2025-02-24 22:22:06,813 | INFO | -- intersect: 1633524208.3378093 [2025-02-24 17:22:18] 2025-02-24 22:22:06,813 | INFO | intersect: 1633524208.3378093 [2025-02-24 17:22:18] 2025-02-24 22:22:06,814 | INFO | chi2: 1.0599169257857035 [2025-02-24 17:22:18] 2025-02-24 22:22:06,814 | INFO | current chi2=1.0599169257857035 (change=13.30600934998347 %) [2025-02-24 17:22:18] 2025-02-24 22:22:06,814 | INFO | left removable region: 40 [2025-02-24 17:22:18] 2025-02-24 22:22:06,814 | INFO | model: linear, x: [1740420587.0, 1740420647.0, 1740420708.0, 1740420769.0, 1740420830.0, 1740420892.0, 1740420952.0, 1740421013.0, 1740421074.0, 1740421135.0, 1740 [2025-02-24 17:22:18] 2025-02-24 22:22:06,814 | INFO | sum of square deviations: 4449156034.502032 [2025-02-24 17:22:18] 2025-02-24 22:22:06,816 | INFO | sum of deviations: -13546669141.539093 [2025-02-24 17:22:18] 2025-02-24 22:22:06,816 | INFO | mean x: 1740427967.0452676 [2025-02-24 17:22:18] 2025-02-24 22:22:06,816 | INFO | mean y: 2780881.1399176954 [2025-02-24 17:22:18] 2025-02-24 22:22:06,816 | INFO | -- intersect: 5301988562.644074 [2025-02-24 17:22:18] 2025-02-24 22:22:06,816 | INFO | intersect: 5301988562.644074 [2025-02-24 17:22:18] 2025-02-24 22:22:06,817 | INFO | chi2: 0.0619088339597745 [2025-02-24 17:22:18] 2025-02-24 22:22:06,817 | INFO | -- intersect: 5301988562.644074 [2025-02-24 17:22:18] 2025-02-24 22:22:06,817 | INFO | current memory leak: -3.04 B/s (using 243 data points, chi2=0.06) [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | .............................. [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . Timing measurements: [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . get job = 0 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . initial setup = 2 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . payload setup = 9 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . stage-in = 0 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . payload execution = 17580 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . stage-out = 2 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | . log creation = 0 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,818 | INFO | .............................. [2025-02-24 17:22:18] 2025-02-24 22:22:06,991 | INFO | [2025-02-24 17:22:18] 2025-02-24 22:22:06,991 | INFO | job summary report [2025-02-24 17:22:18] 2025-02-24 22:22:06,991 | INFO | -------------------------------------------------- [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | PanDA job id: 6522370765 [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | task id: 43078919 [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | errors: (none) [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | status: LOG_TRANSFER = DONE [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | pilot state: finished [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | transexitcode: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | exeerrorcode: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | exeerrordiag: [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | exitcode: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:06,992 | INFO | exitmsg: OK [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | cpuconsumptiontime: 106789 s [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | nevents: 400 [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | neventsw: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | pid: 36129 [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | pgrp: 36129 [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | corecount: 10 [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | event service: False [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | sizes: {0: 2383309, 5: 2383515, 11: 2383571, 17593: 2415535, 17595: 2424532, 17599: 2424646} [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | -------------------------------------------------- [2025-02-24 17:22:18] 2025-02-24 22:22:06,993 | INFO | [2025-02-24 17:22:18] 2025-02-24 22:22:06,994 | INFO | executing command: ls -lF /tmp/boinchome/slots/1 [2025-02-24 17:22:18] 2025-02-24 22:22:07,017 | INFO | queue jobs had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,017 | INFO | queue payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,017 | INFO | queue data_in had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,017 | INFO | queue data_out had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue current_data_in had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,018 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue completed_jobids has 1 job(s) [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | queue messages had 0 job(s) [purged] [2025-02-24 17:22:18] 2025-02-24 22:22:07,019 | INFO | job 6522370765 has completed (purged errors) [2025-02-24 17:22:18] 2025-02-24 22:22:07,020 | INFO | overall cleanup function is called [2025-02-24 17:22:18] 2025-02-24 22:22:08,029 | INFO | --- collectZombieJob: --- 10, [36129] [2025-02-24 17:22:18] 2025-02-24 22:22:08,029 | INFO | zombie collector waiting for pid 36129 [2025-02-24 17:22:18] 2025-02-24 22:22:08,029 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-02-24 17:22:18] 2025-02-24 22:22:08,030 | INFO | collected zombie processes [2025-02-24 17:22:18] 2025-02-24 22:22:08,030 | INFO | will attempt to kill all subprocesses of pid=36129 [2025-02-24 17:22:18] 2025-02-24 22:22:08,157 | INFO | process IDs to be killed: [36129] (in reverse order) [2025-02-24 17:22:18] 2025-02-24 22:22:08,243 | WARNING | found no corresponding commands to process id(s) [2025-02-24 17:22:18] 2025-02-24 22:22:08,243 | INFO | Do not look for orphan processes in BOINC jobs [2025-02-24 17:22:18] 2025-02-24 22:22:08,250 | INFO | did not find any defunct processes belonging to 36129 [2025-02-24 17:22:18] 2025-02-24 22:22:08,255 | INFO | did not find any defunct processes belonging to 36129 [2025-02-24 17:22:18] 2025-02-24 22:22:08,256 | INFO | ready for new job [2025-02-24 17:22:18] 2025-02-24 22:22:08,256 | INFO | pilot has finished with previous job - re-establishing logging [2025-02-24 17:22:18] 2025-02-24 22:22:08,260 | INFO | ************************************** [2025-02-24 17:22:18] 2025-02-24 22:22:08,260 | INFO | *** PanDA Pilot version 3.9.4.15 *** [2025-02-24 17:22:18] 2025-02-24 22:22:08,260 | INFO | ************************************** [2025-02-24 17:22:18] 2025-02-24 22:22:08,260 | INFO | [2025-02-24 17:22:18] 2025-02-24 22:22:08,263 | INFO | architecture information: [2025-02-24 17:22:18] 2025-02-24 22:22:08,263 | INFO | executing command: cat /etc/os-release [2025-02-24 17:22:18] 2025-02-24 22:22:08,279 | INFO | cat /etc/os-release: [2025-02-24 17:22:18] NAME="CentOS Linux" [2025-02-24 17:22:18] VERSION="7 (Core)" [2025-02-24 17:22:18] ID="centos" [2025-02-24 17:22:18] ID_LIKE="rhel fedora" [2025-02-24 17:22:18] VERSION_ID="7" [2025-02-24 17:22:18] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-02-24 17:22:18] ANSI_COLOR="0;31" [2025-02-24 17:22:18] CPE_NAME="cpe:/o:centos:centos:7" [2025-02-24 17:22:18] HOME_URL="https://www.centos.org/" [2025-02-24 17:22:18] BUG_REPORT_URL="https://bugs.centos.org/" [2025-02-24 17:22:18] [2025-02-24 17:22:18] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-02-24 17:22:18] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-02-24 17:22:18] REDHAT_SUPPORT_PRODUCT="centos" [2025-02-24 17:22:18] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-02-24 17:22:18] [2025-02-24 17:22:18] 2025-02-24 22:22:08,280 | INFO | ************************************** [2025-02-24 17:22:18] 2025-02-24 22:22:08,784 | INFO | executing command: df -mP /tmp/boinchome/slots/1 [2025-02-24 17:22:18] 2025-02-24 22:22:08,806 | INFO | sufficient remaining disk space (57249103872 B) [2025-02-24 17:22:18] 2025-02-24 22:22:08,807 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-02-24 17:22:18] 2025-02-24 22:22:08,807 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-02-24 17:22:18] 2025-02-24 22:22:08,808 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-02-24 17:22:18] 2025-02-24 22:22:08,808 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-02-24 17:22:18] 2025-02-24 22:22:08,893 | WARNING | job monitor detected an abort_job request (signal=args.signal) [2025-02-24 17:22:18] 2025-02-24 22:22:08,893 | WARNING | cannot recover job monitoring - aborting pilot [2025-02-24 17:22:18] 2025-02-24 22:22:08,894 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-02-24 17:22:18] 2025-02-24 22:22:08,894 | INFO | will abort loop [2025-02-24 17:22:18] 2025-02-24 22:22:08,910 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-02-24 17:22:18] 2025-02-24 22:22:09,249 | INFO | all data control threads have been joined [2025-02-24 17:22:18] 2025-02-24 22:22:09,754 | INFO | found 0 job(s) in 20 queues [2025-02-24 17:22:18] 2025-02-24 22:22:09,755 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-02-24 17:22:18] 2025-02-24 22:22:09,755 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-02-24 17:22:18] 2025-02-24 22:22:09,813 | INFO | [job] retrieve thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:09,813 | INFO | [job] queue monitor thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:09,899 | INFO | [job] job monitor thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,073 | INFO | [data] copytool_in thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,102 | INFO | [job] validate thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,199 | INFO | [job] create_data_payload thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,250 | INFO | [data] control thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,263 | INFO | [payload] execute_payloads thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,309 | INFO | all payload control threads have been joined [2025-02-24 17:22:18] 2025-02-24 22:22:10,400 | INFO | [payload] failed_post thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,507 | INFO | all job control threads have been joined [2025-02-24 17:22:18] 2025-02-24 22:22:10,615 | INFO | [payload] run_realtimelog thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:10,814 | INFO | [data] copytool_out thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:11,134 | INFO | [payload] validate_post thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:11,186 | INFO | [payload] validate_pre thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:11,315 | INFO | [payload] control thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:11,508 | INFO | [job] control thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:12,916 | INFO | [data] queue_monitor thread has finished [2025-02-24 17:22:18] 2025-02-24 22:22:13,429 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139839688877888)>', '<ExcThread(monitor, started 139839395571456)>'] [2025-02-24 17:22:18] 2025-02-24 22:22:13,768 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-02-24 17:22:18] 2025-02-24 22:22:13,769 | INFO | [monitor] control thread has ended [2025-02-24 17:22:18] 2025-02-24 22:22:18,455 | INFO | all workflow threads have been joined [2025-02-24 17:22:18] 2025-02-24 22:22:18,455 | INFO | end of generic workflow (traces error code: 0) [2025-02-24 17:22:18] 2025-02-24 22:22:18,455 | INFO | traces error code: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:18,456 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-02-24 17:22:18] 2025-02-24 22:22:18,596 [wrapper] ==== pilot stdout END ==== [2025-02-24 17:22:18] 2025-02-24 22:22:18,600 [wrapper] ==== wrapper stdout RESUME ==== [2025-02-24 17:22:18] 2025-02-24 22:22:18,604 [wrapper] pilotpid: 20402 [2025-02-24 17:22:18] 2025-02-24 22:22:18,607 [wrapper] Pilot exit status: 0 [2025-02-24 17:22:18] 2025-02-24 22:22:18,619 [wrapper] pandaids: 6522370765 6522370765 [2025-02-24 17:22:18] 2025-02-24 22:22:18,672 [wrapper] cleanup supervisor_pilot 10279 20403 [2025-02-24 17:22:18] 2025-02-24 22:22:18,676 [wrapper] Test setup, not cleaning [2025-02-24 17:22:18] 2025-02-24 22:22:18,682 [wrapper] apfmon messages muted [2025-02-24 17:22:18] 2025-02-24 22:22:18,685 [wrapper] ==== wrapper stdout END ==== [2025-02-24 17:22:18] 2025-02-24 22:22:18,687 [wrapper] ==== wrapper stderr END ==== [2025-02-24 17:22:18] *** Error codes and diagnostics *** [2025-02-24 17:22:18] "exeErrorCode": 0, [2025-02-24 17:22:18] "exeErrorDiag": "", [2025-02-24 17:22:18] "pilotErrorCode": 0, [2025-02-24 17:22:18] "pilotErrorDiag": "", [2025-02-24 17:22:18] *** Listing of results directory *** [2025-02-24 17:22:18] total 988552 [2025-02-24 17:22:18] drwx------ 4 boincer umatlas 4096 Dec 18 06:03 pilot3 [2025-02-24 17:22:18] -rwx------ 1 boincer umatlas 35865 Feb 21 10:12 runpilot2-wrapper.sh [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 5118 Feb 21 10:12 queuedata.json [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 491065 Feb 21 10:12 pilot3.tar.gz [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 100 Feb 24 08:38 wrapper_26015_x86_64-pc-linux-gnu [2025-02-24 17:22:18] -rwxr-xr-x 1 boincer umatlas 7986 Feb 24 08:38 run_atlas [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 105 Feb 24 08:38 job.xml [2025-02-24 17:22:18] -rw-r--r-- 3 boincer umatlas 341909005 Feb 24 08:38 EVNT.43078917._001259.pool.root.1 [2025-02-24 17:22:18] -rw-r--r-- 3 boincer umatlas 341909005 Feb 24 08:38 ATLAS.root_0 [2025-02-24 17:22:18] -rw-r--r-- 2 boincer umatlas 503554 Feb 24 08:38 input.tar.gz [2025-02-24 17:22:18] -rw-r--r-- 2 boincer umatlas 17569 Feb 24 08:38 start_atlas.sh [2025-02-24 17:22:18] drwxrwx--x 2 boincer umatlas 4096 Feb 24 08:38 shared [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 0 Feb 24 08:38 boinc_lockfile [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 2545 Feb 24 12:28 pandaJob.out [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 467 Feb 24 12:28 setup.sh.local [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 987749 Feb 24 12:28 agis_schedconf.cvmfs.json [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 6230 Feb 24 17:19 init_data.xml [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 96 Feb 24 17:21 pilot_heartbeat.json [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 319747530 Feb 24 17:21 HITS.43078919._084030.pool.root.1 [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 533 Feb 24 17:21 boinc_task_state.xml [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 1058 Feb 24 17:21 memory_monitor_summary.json [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 1582569 Feb 24 17:22 agis_ddmendpoints.agis.ALL.json [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 494693 Feb 24 17:22 log.43078919._084030.job.log.tgz.1 [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 8192 Feb 24 17:22 boinc_mmap_file [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 29 Feb 24 17:22 wrapper_checkpoint.txt [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 7769 Feb 24 17:22 heartbeat.json [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 4401 Feb 24 17:22 pilotlog.txt [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 1957085 Feb 24 17:22 log.43078919._084030.job.log.1 [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 357 Feb 24 17:22 output.list [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 620 Feb 24 17:22 runtime_log [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 2467840 Feb 24 17:22 result.tar.gz [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 788 Feb 24 17:22 ZSoKDm6sj56n9Rq4apOajLDm4fhM0noT9bVoFjIUDmWVdKDmqIAQPo.diag [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 11506 Feb 24 17:22 runtime_log.err [2025-02-24 17:22:18] -rw-r--r-- 1 boincer umatlas 23745 Feb 24 17:22 stderr.txt [2025-02-24 17:22:18] HITS file was successfully produced: [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 319747530 Feb 24 17:21 shared/HITS.pool.root.1 [2025-02-24 17:22:18] *** Contents of shared directory: *** [2025-02-24 17:22:18] total 649084 [2025-02-24 17:22:18] -rw-r--r-- 3 boincer umatlas 341909005 Feb 24 08:38 ATLAS.root_0 [2025-02-24 17:22:18] -rw-r--r-- 2 boincer umatlas 503554 Feb 24 08:38 input.tar.gz [2025-02-24 17:22:18] -rw-r--r-- 2 boincer umatlas 17569 Feb 24 08:38 start_atlas.sh [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 319747530 Feb 24 17:21 HITS.pool.root.1 [2025-02-24 17:22:18] -rw------- 1 boincer umatlas 2467840 Feb 24 17:22 result.tar.gz 17:22:20 (12373): run_atlas exited; CPU time 106619.222718 17:22:20 (12373): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN