| Name | 0RWNDmp9Vw3n7Olcko1bjSoqABFKDmABFKDm7AsVDmhSQKDm1u8ipn_0 |
| Workunit | 2329062 |
| Created | 2 Sep 2023, 3:07:20 UTC |
| Sent | 2 Sep 2023, 3:08:57 UTC |
| Report deadline | 9 Sep 2023, 3:08:57 UTC |
| Received | 2 Sep 2023, 4:01:51 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 4912 |
| Run time | 51 min 36 sec |
| CPU time | 14 min 9 sec |
| Validate state | Valid |
| Credit | 37.91 |
| Device peak FLOPS | 4.64 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 1,013.72 MB |
| Peak swap size | 3.02 GB |
| Peak disk usage | 81.64 MB |
Stderr output
<core_client_version>7.20.5</core_client_version>
<![CDATA[
<stderr_txt>
06:09:23 (320133): wrapper (7.7.26015): starting
06:09:23 (320133): wrapper: running /usr/bin/wget (https://atlas-cric.cern.ch/cache/ddmendpoints.json -O agis_ddmendpoints.agis.ALL.json)
--2023-09-02 06:09:23-- https://atlas-cric.cern.ch/cache/ddmendpoints.json
Resolving atlas-cric.cern.ch (atlas-cric.cern.ch)... 188.185.66.30, 2001:1458:d00:1::100:218
Connecting to atlas-cric.cern.ch (atlas-cric.cern.ch)|188.185.66.30|:443... connected.
HTTP request sent, awaiting response... 200 OK
Length: 1663378 (1.6M) [application/json]
Saving to: ‘agis_ddmendpoints.agis.ALL.json’
0K .......... .......... .......... .......... .......... 3% 859K 2s
50K .......... .......... .......... .......... .......... 6% 521K 2s
100K .......... .......... .......... .......... .......... 9% 12.8M 2s
150K .......... .......... .......... .......... .......... 12% 1018K 1s
200K .......... .......... .......... .......... .......... 15% 798K 1s
250K .......... .......... .......... .......... .......... 18% 662K 2s
300K .......... .......... .......... .......... .......... 21% 1.06M 1s
350K .......... .......... .......... .......... .......... 24% 7.46M 1s
400K .......... .......... .......... .......... .......... 27% 525K 1s
450K .......... .......... .......... .......... .......... 30% 6.84M 1s
500K .......... .......... .......... .......... .......... 33% 1011K 1s
550K .......... .......... .......... .......... .......... 36% 1020K 1s
600K .......... .......... .......... .......... .......... 40% 1011K 1s
650K .......... .......... .......... .......... .......... 43% 1014K 1s
700K .......... .......... .......... .......... .......... 46% 3.42M 1s
750K .......... .......... .......... .......... .......... 49% 911K 1s
800K .......... .......... .......... .......... .......... 52% 989K 1s
850K .......... .......... .......... .......... .......... 55% 1.01M 1s
900K .......... .......... .......... .......... .......... 58% 1.12M 1s
950K .......... .......... .......... .......... .......... 61% 3.95M 1s
1000K .......... .......... .......... .......... .......... 64% 975K 1s
1050K .......... .......... .......... .......... .......... 67% 781K 0s
1100K .......... .......... .......... .......... .......... 70% 1.30M 0s
1150K .......... .......... .......... .......... .......... 73% 1.79M 0s
1200K .......... .......... .......... .......... .......... 76% 944K 0s
1250K .......... .......... .......... .......... .......... 80% 837K 0s
1300K .......... .......... .......... .......... .......... 83% 1.26M 0s
1350K .......... .......... .......... .......... .......... 86% 3.53M 0s
1400K .......... .......... .......... .......... .......... 89% 1008K 0s
1450K .......... .......... .......... .......... .......... 92% 912K 0s
1500K .......... .......... .......... .......... .......... 95% 927K 0s
1550K .......... .......... .......... .......... .......... 98% 5.07M 0s
1600K .......... .......... .... 100% 252K=1.5s
2023-09-02 06:09:25 (1.04 MB/s) - ‘agis_ddmendpoints.agis.ALL.json’ saved [1663378/1663378]
06:09:27 (320133): /usr/bin/wget exited; CPU time 0.031113
06:09:27 (320133): wrapper: running run_atlas (--nthreads 1)
[2023-09-02 06:09:27] Arguments: --nthreads 1
[2023-09-02 06:09:27] Threads: 1
[2023-09-02 06:09:27] Checking for CVMFS
[2023-09-02 06:09:28] Probing /cvmfs/atlas.cern.ch... OK
[2023-09-02 06:09:28] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-09-02 06:09:28] Running cvmfs_config stat atlas.cern.ch
[2023-09-02 06:09:29] 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
[2023-09-02 06:09:29] 2.10.1.0 1471 229 40036 123148 3 113 5009342 10240000 0 130560 0 1309355 99.989 49870 1305 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
[2023-09-02 06:09:29] CVMFS is ok
[2023-09-02 06:09:29] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2023-09-02 06:09:29] Small home clusters do not require a local http proxy but it is suggested if
[2023-09-02 06:09:29] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2023-09-02 06:09:29] Further information can be found at the LHC@home message board.
[2023-09-02 06:09:29] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-09-02 06:09:29] Checking for apptainer binary...
[2023-09-02 06:09:29] apptainer is not installed, using version from CVMFS
[2023-09-02 06:09:29] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-09-02 06:09:45] debian-lhcathome
[2023-09-02 06:09:45] apptainer works
[2023-09-02 06:09:45] Starting ATLAS job with PandaID=5950017755
[2023-09-02 06:09:45] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc-client/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-09-02 07:01:35] *** The last 200 lines of the pilot log: ***
[2023-09-02 07:01:35] workdir=None
[2023-09-02 07:01:35] ]
[2023-09-02 07:01:35] 2023-09-02 04:00:25,585 | INFO | transferring file 59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log.tgz from /var/lib/boinc-client/slots/1/PanDA_Pilot-5950017755/59339b6d-c793-4c89-b3c3-19c5a07
[2023-09-02 07:01:35] 2023-09-02 04:00:25,585 | INFO | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/1/PanDA_Pilot-5950017755/59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log.tgz /var/lib/boinc-clie
[2023-09-02 07:01:35] 2023-09-02 04:00:25,602 | INFO | Adding to output.list: 59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/1e/5f/59339b6d-c793-4
[2023-09-02 07:01:35] 2023-09-02 04:00:25,603 | INFO | summary of transferred files:
[2023-09-02 07:01:35] 2023-09-02 04:00:25,603 | INFO | -- lfn=59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log.tgz, status_code=0, status=transferred
[2023-09-02 07:01:35] 2023-09-02 04:00:25,603 | INFO | stage-out finished correctly
[2023-09-02 07:01:35] 2023-09-02 04:00:25,779 | INFO | monitor loop #227: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:25,779 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:28,284 | INFO | monitor loop #228: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:28,284 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,088 | INFO | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-09-02 07:01:35] 2023-09-02 04:00:29,540 | INFO | job 5950017755 has state=finished
[2023-09-02 07:01:35] 2023-09-02 04:00:29,541 | INFO | preparing for final server update for job 5950017755 in state='finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:29,541 | INFO | this job has now completed (state=finished)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,541 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,541 | INFO | job 5950017755 has finished - writing final server update
[2023-09-02 07:01:35] 2023-09-02 04:00:29,542 | INFO | fitting pss+swap vs Time
[2023-09-02 07:01:35] 2023-09-02 04:00:29,543 | INFO | current memory leak: 178.17 B/s (using 39 data points, chi2=2.77)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,543 | INFO | total number of processed events: 2 (read)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,544 | INFO | executing command: lscpu
[2023-09-02 07:01:35] 2023-09-02 04:00:29,580 | INFO | found 8 cores (8 cores per socket, 1 sockets)
[2023-09-02 07:01:35] 2023-09-02 04:00:29,580 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-09-02 07:01:35] 2023-09-02 04:00:29,614 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup
[2023-09-02 07:01:35] 2023-09-02 04:00:30,787 | INFO | monitor loop #229: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:30,787 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:33,292 | INFO | monitor loop #230: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:33,292 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:35,795 | INFO | monitor loop #231: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:35,796 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:38,301 | INFO | monitor loop #232: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:38,301 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:39,608 | INFO | 3022s have passed since pilot start
[2023-09-02 07:01:35] 2023-09-02 04:00:40,831 | INFO | monitor loop #233: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:40,831 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:43,335 | INFO | monitor loop #234: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:43,336 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:45,840 | INFO | monitor loop #235: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:45,840 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:48,347 | INFO | monitor loop #236: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:48,347 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:50,851 | INFO | monitor loop #237: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:50,851 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:53,357 | INFO | monitor loop #238: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:53,357 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:55,860 | INFO | monitor loop #239: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:55,860 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:00:58,364 | INFO | monitor loop #240: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:00:58,365 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:01:00,868 | INFO | monitor loop #241: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:01:00,868 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:01:03,371 | INFO | monitor loop #242: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:01:03,371 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:01:05,875 | INFO | monitor loop #243: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:01:05,875 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:01:08,402 | INFO | monitor loop #244: job 0:5950017755 is in state 'finished'
[2023-09-02 07:01:35] 2023-09-02 04:01:08,403 | INFO | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-02 07:01:35] 2023-09-02 04:01:10,323 | INFO | CPU arch script returned: x86-64-v3
[2023-09-02 07:01:35] 2023-09-02 04:01:10,323 | INFO | using path: /var/lib/boinc-client/slots/1/PanDA_Pilot-5950017755/memory_monitor_summary.json (trf name=prmon)
[2023-09-02 07:01:35] 2023-09-02 04:01:10,324 | INFO | extracted standard info from prmon json
[2023-09-02 07:01:35] 2023-09-02 04:01:10,324 | INFO | extracted standard memory fields from prmon json
[2023-09-02 07:01:35] 2023-09-02 04:01:10,324 | INFO | ..............................
[2023-09-02 07:01:35] 2023-09-02 04:01:10,324 | INFO | . Timing measurements:
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . get job = 0 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . initial setup = 2 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . payload setup = 50 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . stage-in = 0 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . payload execution = 2909 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | . stage-out = 1 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,325 | INFO | ..............................
[2023-09-02 07:01:35] 2023-09-02 04:01:10,399 | INFO |
[2023-09-02 07:01:35] 2023-09-02 04:01:10,399 | INFO | job summary report
[2023-09-02 07:01:35] 2023-09-02 04:01:10,399 | INFO | --------------------------------------------------
[2023-09-02 07:01:35] 2023-09-02 04:01:10,399 | INFO | PanDA job id: 5950017755
[2023-09-02 07:01:35] 2023-09-02 04:01:10,399 | INFO | task id: NULL
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | errors: (none)
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | status: LOG_TRANSFER = DONE
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | pilot state: finished
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | transexitcode: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | exeerrorcode: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | exeerrordiag:
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | exitcode: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | exitmsg: OK
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | cpuconsumptiontime: 1269 s
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | nevents: 2
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | neventsw: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | pid: 354188
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | pgrp: 354188
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | corecount: 1
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | event service: False
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | sizes: {0: 2490277, 1: 2490277, 12: 2490305, 16: 2490539, 22: 2490567, 2964: 2514752, 2967: 2523812, 2970: 2523868, 3011: 2524090}
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | --------------------------------------------------
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO |
[2023-09-02 07:01:35] 2023-09-02 04:01:10,400 | INFO | executing command: ls -lF /var/lib/boinc-client/slots/1
[2023-09-02 07:01:35] 2023-09-02 04:01:10,428 | INFO | queue jobs had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue data_in had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue data_out had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue current_data_in had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue validated_jobs had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue validated_payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue monitored_payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue finished_jobs had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue finished_payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue finished_data_in had 1 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,429 | INFO | queue finished_data_out had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue failed_jobs had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue failed_payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue failed_data_in had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue failed_data_out had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue completed_jobs had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue completed_jobids has 1 job(s)
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue realtimelog_payloads had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | queue messages had 0 job(s) [purged]
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | job 5950017755 has completed (purged errors)
[2023-09-02 07:01:35] 2023-09-02 04:01:10,430 | INFO | overall cleanup function is called
[2023-09-02 07:01:35] 2023-09-02 04:01:11,437 | INFO | --- collectZombieJob: --- 10, [354188]
[2023-09-02 07:01:35] 2023-09-02 04:01:11,437 | INFO | zombie collector trying to kill pid 354188
[2023-09-02 07:01:35] 2023-09-02 04:01:11,437 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-09-02 07:01:35] 2023-09-02 04:01:12,439 | INFO | collected zombie processes
[2023-09-02 07:01:35] 2023-09-02 04:01:12,439 | INFO | will now attempt to kill all subprocesses of pid=354188
[2023-09-02 07:01:35] 2023-09-02 04:01:12,496 | INFO | process IDs to be killed: [354188] (in reverse order)
[2023-09-02 07:01:35] 2023-09-02 04:01:12,567 | WARNING | found no corresponding commands to process id(s)
[2023-09-02 07:01:35] 2023-09-02 04:01:12,567 | INFO | Do not look for orphan processes in BOINC jobs
[2023-09-02 07:01:35] 2023-09-02 04:01:12,567 | INFO | ready for new job
[2023-09-02 07:01:35] 2023-09-02 04:01:12,567 | INFO | pilot has finished with previous job - re-establishing logging
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO | *************************************
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO | *** PanDA Pilot version 3.6.4.7 ***
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO | *************************************
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO |
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO | pilot is running in a VM
[2023-09-02 07:01:35] 2023-09-02 04:01:12,585 | INFO | architecture information:
[2023-09-02 07:01:35] 2023-09-02 04:01:12,616 | INFO | executing command: cat /etc/os-release
[2023-09-02 07:01:35] 2023-09-02 04:01:12,658 | INFO | cat /etc/os-release:
[2023-09-02 07:01:35] NAME="CentOS Linux"
[2023-09-02 07:01:35] VERSION="7 (Core)"
[2023-09-02 07:01:35] ID="centos"
[2023-09-02 07:01:35] ID_LIKE="rhel fedora"
[2023-09-02 07:01:35] VERSION_ID="7"
[2023-09-02 07:01:35] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-09-02 07:01:35] ANSI_COLOR="0;31"
[2023-09-02 07:01:35] CPE_NAME="cpe:/o:centos:centos:7"
[2023-09-02 07:01:35] HOME_URL="https://www.centos.org/"
[2023-09-02 07:01:35] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-09-02 07:01:35]
[2023-09-02 07:01:35] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-09-02 07:01:35] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-09-02 07:01:35] REDHAT_SUPPORT_PRODUCT="centos"
[2023-09-02 07:01:35] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-09-02 07:01:35]
[2023-09-02 07:01:35] 2023-09-02 04:01:12,658 | INFO | *************************************
[2023-09-02 07:01:35] 2023-09-02 04:01:13,159 | INFO | executing command: df -mP /var/lib/boinc-client/slots/1
[2023-09-02 07:01:35] 2023-09-02 04:01:13,188 | INFO | sufficient remaining disk space (37399560192 B)
[2023-09-02 07:01:35] 2023-09-02 04:01:13,189 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job
[2023-09-02 07:01:35] 2023-09-02 04:01:13,189 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-09-02 07:01:35] 2023-09-02 04:01:13,189 | WARNING | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2023-09-02 07:01:35] 2023-09-02 04:01:13,189 | INFO | found 0 job(s) in 20 queues
[2023-09-02 07:01:35] 2023-09-02 04:01:13,190 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2023-09-02 07:01:35] 2023-09-02 04:01:13,190 | WARNING | will wait for a maximum of 300 s for threads to finish
[2023-09-02 07:01:35] 2023-09-02 04:01:13,418 | WARNING | job monitor detected an abort_job request (signal=None)
[2023-09-02 07:01:35] 2023-09-02 04:01:13,419 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2023-09-02 07:01:35] 2023-09-02 04:01:13,419 | INFO | will abort loop
[2023-09-02 07:01:35] 2023-09-02 04:01:13,934 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2023-09-02 07:01:35] 2023-09-02 04:01:14,191 | INFO | [job] retrieve thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,254 | INFO | [payload] validate_post thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,421 | INFO | [job] job monitor thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,575 | INFO | [job] create_data_payload thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,672 | INFO | [job] control thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,771 | INFO | [data] control thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,909 | INFO | [payload] failed_post thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:14,974 | INFO | [data] copytool_in thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:15,127 | INFO | [payload] execute_payloads thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:15,183 | INFO | [payload] validate_pre thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:15,189 | INFO | [job] validate thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:15,411 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2023-09-02 07:01:35] 2023-09-02 04:01:15,453 | INFO | [payload] control thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:15,743 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-09-02 07:01:35] 2023-09-02 04:01:15,939 | INFO | [data] copytool_out thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:16,412 | INFO | [job] queue monitor thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:19,751 | INFO | [data] queue_monitor thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:23,546 | INFO | job.realtimelogging is not enabled
[2023-09-02 07:01:35] 2023-09-02 04:01:24,551 | INFO | [payload] run_realtimelog thread has finished
[2023-09-02 07:01:35] 2023-09-02 04:01:26,591 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140708769957696)>', '<ExcThread(monitor, started 140707935274752)>']
[2023-09-02 07:01:35] 2023-09-02 04:01:27,259 | WARNING | job_aborted has been set - aborting pilot monitoring
[2023-09-02 07:01:35] 2023-09-02 04:01:27,259 | INFO | [monitor] control thread has ended
[2023-09-02 07:01:35] 2023-09-02 04:01:31,616 | INFO | end of generic workflow (traces error code: 0)
[2023-09-02 07:01:35] 2023-09-02 04:01:31,616 | INFO | traces error code: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:31,616 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2023-09-02 07:01:35] 2023-09-02 04:01:32,071 [wrapper] ==== pilot stdout END ====
[2023-09-02 07:01:35] 2023-09-02 04:01:32,122 [wrapper] ==== wrapper stdout RESUME ====
[2023-09-02 07:01:35] 2023-09-02 04:01:32,127 [wrapper] pilotpid: 329764
[2023-09-02 07:01:35] 2023-09-02 04:01:32,151 [wrapper] Pilot exit status: 0
[2023-09-02 07:01:35] 2023-09-02 04:01:32,270 [wrapper] pandaids: 5950017755
[2023-09-02 07:01:35] 2023-09-02 04:01:32,279 [wrapper] apfmon messages muted
[2023-09-02 07:01:35] 2023-09-02 04:01:32,283 [wrapper] Test setup, not cleaning
[2023-09-02 07:01:35] 2023-09-02 04:01:32,290 [wrapper] ==== wrapper stdout END ====
[2023-09-02 07:01:35] 2023-09-02 04:01:32,300 [wrapper] ==== wrapper stderr END ====
[2023-09-02 07:01:35] 2023-09-02 04:01:32,311 [wrapper] wrapperexiting ec=0, duration=3107
[2023-09-02 07:01:35] 2023-09-02 04:01:32,315 [wrapper] apfmon messages muted
[2023-09-02 07:01:35] *** Error codes and diagnostics ***
[2023-09-02 07:01:35] "exeErrorCode": 0,
[2023-09-02 07:01:35] "exeErrorDiag": "",
[2023-09-02 07:01:35] "pilotErrorCode": 0,
[2023-09-02 07:01:35] "pilotErrorDiag": "",
[2023-09-02 07:01:35] *** Listing of results directory ***
[2023-09-02 07:01:35] total 45524
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 418016 Sep 2 05:37 pilot3.tar.gz
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 1663378 Sep 2 06:00 agis_ddmendpoints.agis.ALL.json
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 4388 Sep 2 06:06 queuedata.json
[2023-09-02 07:01:35] -rwx------ 1 boinc boinc 27277 Sep 2 06:07 runpilot2-wrapper.sh
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 107 Sep 2 06:09 wrapper_26015_x86_64-pc-linux-gnu
[2023-09-02 07:01:35] -rwxr-xr-x 1 boinc boinc 7986 Sep 2 06:09 run_atlas
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 112 Sep 2 06:09 job.xml
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 17600 Sep 2 06:09 start_atlas.sh
[2023-09-02 07:01:35] drwxrwx--x 2 boinc boinc 4096 Sep 2 06:09 shared
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 428864 Sep 2 06:09 input.tar.gz
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 6516 Sep 2 06:09 init_data.xml
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 37708683 Sep 2 06:09 EVNT.04972714._000031.pool.root.1
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 0 Sep 2 06:09 boinc_lockfile
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 2746 Sep 2 06:09 pandaJob.out
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 424 Sep 2 06:09 setup.sh.local
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 1028014 Sep 2 06:10 agis_schedconf.cvmfs.json
[2023-09-02 07:01:35] drwx------ 4 boinc boinc 4096 Sep 2 06:10 pilot3
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 2076075 Sep 2 06:47 output.1.59339b6d-c793-4c89-b3c3-19c5a072e710_5494.pool.root
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 1023 Sep 2 07:00 memory_monitor_summary.json
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 175157 Sep 2 07:00 59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log.tgz
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 533 Sep 2 07:00 boinc_task_state.xml
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 8769 Sep 2 07:01 heartbeat.json
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 8192 Sep 2 07:01 boinc_mmap_file
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 25 Sep 2 07:01 wrapper_checkpoint.txt
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 4256 Sep 2 07:01 pilotlog.txt
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 313469 Sep 2 07:01 59339b6d-c793-4c89-b3c3-19c5a072e710_5494.1.job.log
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 460 Sep 2 07:01 output.list
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 744 Sep 2 07:01 runtime_log
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 2590720 Sep 2 07:01 result.tar.gz
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 11989 Sep 2 07:01 runtime_log.err
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 646 Sep 2 07:01 0RWNDmp9Vw3n7Olcko1bjSoqABFKDmABFKDm7AsVDmhSQKDm1u8ipn.diag
[2023-09-02 07:01:35] -rw-r--r-- 1 boinc boinc 25991 Sep 2 07:01 stderr.txt
[2023-09-02 07:01:35] HITS file was successfully produced:
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 2076075 Sep 2 06:47 shared/HITS.pool.root.1
[2023-09-02 07:01:35] *** Contents of shared directory: ***
[2023-09-02 07:01:35] total 41828
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 17600 Sep 2 06:09 start_atlas.sh
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 428864 Sep 2 06:09 input.tar.gz
[2023-09-02 07:01:35] -rw-r--r-- 2 boinc boinc 37708683 Sep 2 06:09 ATLAS.root_0
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 2076075 Sep 2 06:47 HITS.pool.root.1
[2023-09-02 07:01:35] -rw------- 1 boinc boinc 2590720 Sep 2 07:01 result.tar.gz
07:01:37 (320133): run_atlas exited; CPU time 815.171631
07:01:37 (320133): called boinc_finish(0)
</stderr_txt>
]]>
©2024 CERN