Name uOJMDmZeqB4n7Olcko1bjSoqABFKDmABFKDm7AsVDmi0SKDmwtI2Rm_0
Workunit 2338386
Created 14 Oct 2023, 10:02:36 UTC
Sent 14 Oct 2023, 10:04:15 UTC
Report deadline 21 Oct 2023, 10:04:15 UTC
Received 14 Oct 2023, 10:34:15 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4662
Run time 28 min 22 sec
CPU time 8 min 12 sec
Validate state Valid
Credit 20.02
Device peak FLOPS 4.45 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.56 GB
Peak swap size 19.46 GB
Peak disk usage 80.88 MB

Stderr output

<core_client_version>7.16.6</core_client_version>
<![CDATA[
<stderr_txt>
04:05:36 (2500095): wrapper (7.7.26015): starting
04:05:36 (2500095): wrapper: running run_atlas (--nthreads 1)
[2023-10-14 04:05:36] Arguments: --nthreads 1
[2023-10-14 04:05:36] Threads: 1
[2023-10-14 04:05:36] Checking for CVMFS
[2023-10-14 04:05:37] Probing /cvmfs/atlas.cern.ch... OK
[2023-10-14 04:05:37] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-10-14 04:05:37] Running cvmfs_config stat atlas.cern.ch
[2023-10-14 04:05:37] 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-10-14 04:05:37] 2.11.0.0 2495895 0 29488 124741 3 16 3032617 4096001 78 130560 0 12863 99.907 31019 6146 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
[2023-10-14 04:05:37] CVMFS is ok
[2023-10-14 04:05:37] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2023-10-14 04:05:37] Small home clusters do not require a local http proxy but it is suggested if
[2023-10-14 04:05:37] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2023-10-14 04:05:37] Further information can be found at the LHC@home message board.
[2023-10-14 04:05:37] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-10-14 04:05:37] Checking for apptainer binary...
[2023-10-14 04:05:37] Using apptainer found in PATH at /usr/local/bin/apptainer
[2023-10-14 04:05:37] Running /usr/local/bin/apptainer --version
[2023-10-14 04:05:37] apptainer version 1.2.3+286-g3ac6f0cb6
[2023-10-14 04:05:37] Checking apptainer works with /usr/local/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-10-14 04:05:38] T5810
[2023-10-14 04:05:38] apptainer works
[2023-10-14 04:05:38] Starting ATLAS job with PandaID=5989781933
[2023-10-14 04:05:38] Running command: /usr/local/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-10-14 04:33:56]  *** The last 200 lines of the pilot log: ***
[2023-10-14 04:33:56] 2023-10-14 10:32:53,052 | INFO     | monitor loop #229: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:32:53,052 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:32:55,555 | INFO     | monitor loop #230: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:32:55,555 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:32:58,056 | INFO     | monitor loop #231: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:32:58,056 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:00,559 | INFO     | monitor loop #232: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:00,559 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:03,062 | INFO     | monitor loop #233: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:03,063 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:05,564 | INFO     | monitor loop #234: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:05,564 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:08,067 | INFO     | monitor loop #235: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:08,068 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:10,568 | INFO     | monitor loop #236: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:10,568 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:13,071 | INFO     | monitor loop #237: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:13,071 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:15,572 | INFO     | monitor loop #238: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:15,572 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:18,075 | INFO     | monitor loop #239: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:18,075 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:20,576 | INFO     | monitor loop #240: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:20,576 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:22,616 | INFO     | [attempt=3/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-10-14 04:33:56] 2023-10-14 10:33:23,064 | INFO     | 1654s have passed since pilot start
[2023-10-14 04:33:56] 2023-10-14 10:33:23,079 | INFO     | monitor loop #241: job 0:5989781933 is in state 'stageout'
[2023-10-14 04:33:56] 2023-10-14 10:33:23,079 | WARNING  | aborting job monitor tasks since payload process 2526215 is not running
[2023-10-14 04:33:56] 2023-10-14 10:33:23,197 | WARNING  | failed to load data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json, error: <urlopen error [SSL: CERTIFICATE_VERIFY_FAILED] certificate verify failed: 
[2023-10-14 04:33:56] 2023-10-14 10:33:23,198 | WARNING  | cache file=/var/lib/boinc-client/slots/1/agis_ddmendpoints.agis.ALL.json is not available: [Errno 2] No such file or directory: '/var/lib/boinc-client/slots/1/agis
[2023-10-14 04:33:56] 2023-10-14 10:33:23,243 | INFO     | transferring file 79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log.tgz from /var/lib/boinc-client/slots/1/PanDA_Pilot-5989781933/79294a46-f40b-4d43-9908-027935
[2023-10-14 04:33:56] 2023-10-14 10:33:23,243 | INFO     | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/1/PanDA_Pilot-5989781933/79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log.tgz /var/lib/boinc-cli
[2023-10-14 04:33:56] 2023-10-14 10:33:23,259 | INFO     | Adding to output.list: 79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/bc/da/79294a46-f40b-
[2023-10-14 04:33:56] 2023-10-14 10:33:23,259 | INFO     | summary of transferred files:
[2023-10-14 04:33:56] 2023-10-14 10:33:23,260 | INFO     |  -- lfn=79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log.tgz, status_code=0, status=transferred
[2023-10-14 04:33:56] 2023-10-14 10:33:23,260 | INFO     | stage-out finished correctly
[2023-10-14 04:33:56] 2023-10-14 10:33:25,256 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-10-14 04:33:56] 2023-10-14 10:33:25,580 | INFO     | monitor loop #242: job 0:5989781933 is in state 'finished'
[2023-10-14 04:33:56] 2023-10-14 10:33:25,580 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:33:56] 2023-10-14 10:33:26,540 | INFO     | job 5989781933 has state=finished
[2023-10-14 04:33:56] 2023-10-14 10:33:26,541 | INFO     | preparing for final server update for job 5989781933 in state='finished'
[2023-10-14 04:33:56] 2023-10-14 10:33:26,541 | INFO     | this job has now completed (state=finished)
[2023-10-14 04:33:56] 2023-10-14 10:33:26,541 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2023-10-14 04:33:56] 2023-10-14 10:33:26,541 | INFO     | job 5989781933 has finished - writing final server update
[2023-10-14 04:33:56] 2023-10-14 10:33:26,541 | INFO     | total number of processed events: 2 (read)
[2023-10-14 04:33:56] 2023-10-14 10:33:26,562 | INFO     | executing command: lscpu
[2023-10-14 04:33:56] 2023-10-14 10:33:26,583 | INFO     | found 14 cores (14 cores per socket, 1 sockets)
[2023-10-14 04:33:56] 2023-10-14 10:33:26,583 | INFO     | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-10-14 04:33:56] 2023-10-14 10:33:26,607 | 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-10-14 04:33:56] 2023-10-14 10:33:28,083 | INFO     | monitor loop #243: job 0:5989781933 is in state 'finished'
[2023-10-14 04:33:56] 2023-10-14 10:33:28,084 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:33:56] 2023-10-14 10:33:30,584 | INFO     | monitor loop #244: job 0:5989781933 is in state 'finished'
[2023-10-14 04:33:56] 2023-10-14 10:33:30,584 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:33:56] 2023-10-14 10:33:33,087 | INFO     | monitor loop #245: job 0:5989781933 is in state 'finished'
[2023-10-14 04:33:56] 2023-10-14 10:33:33,087 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,316 | INFO     | CPU arch script returned: x86-64-v3
[2023-10-14 04:33:56] 2023-10-14 10:33:35,316 | INFO     | using path: /var/lib/boinc-client/slots/1/PanDA_Pilot-5989781933/memory_monitor_summary.json (trf name=prmon)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,317 | INFO     | extracted standard info from prmon json
[2023-10-14 04:33:56] 2023-10-14 10:33:35,318 | INFO     | extracted standard memory fields from prmon json
[2023-10-14 04:33:56] 2023-10-14 10:33:35,318 | INFO     | fitting pss+swap vs Time
[2023-10-14 04:33:56] 2023-10-14 10:33:35,319 | INFO     | current memory leak: 1346.69 B/s (using 11 data points, chi2=0.05)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,319 | INFO     | ..............................
[2023-10-14 04:33:56] 2023-10-14 10:33:35,319 | INFO     | . Timing measurements:
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . get job = 57 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . initial setup = 60 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . payload setup = 14 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . stage-in = 77 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . payload execution = 1052 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . stage-out = 371 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | . log creation = 0 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,320 | INFO     | ..............................
[2023-10-14 04:33:56] 2023-10-14 10:33:35,784 | INFO     | 
[2023-10-14 04:33:56] 2023-10-14 10:33:35,784 | INFO     | job summary report
[2023-10-14 04:33:56] 2023-10-14 10:33:35,784 | INFO     | --------------------------------------------------
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | PanDA job id: 5989781933
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | task id: NULL
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | errors: (none)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | status: LOG_TRANSFER = DONE 
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | pilot state: finished 
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | transexitcode: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | exeerrorcode: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | exeerrordiag: 
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | exitcode: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | exitmsg: OK
[2023-10-14 04:33:56] 2023-10-14 10:33:35,785 | INFO     | cpuconsumptiontime: 490 s
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | nevents: 2
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | neventsw: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | pid: 2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | pgrp: 2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | corecount: 1
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | event service: False
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | sizes: {0: 2434578, 1: 2436121, 12: 2436267, 23: 2436295, 33: 2436323, 44: 2436351, 55: 2436507, 65: 2436535, 76: 2436563, 84: 2436679, 86: 2436707, 1070: 2456544,
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | --------------------------------------------------
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | 
[2023-10-14 04:33:56] 2023-10-14 10:33:35,786 | INFO     | executing command: ls -lF /var/lib/boinc-client/slots/1
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue jobs had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue data_in had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue data_out had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue current_data_in had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,802 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,803 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,804 | INFO     | queue completed_jobids has 1 job(s)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,804 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,804 | INFO     | queue messages had 0 job(s) [purged]
[2023-10-14 04:33:56] 2023-10-14 10:33:35,804 | INFO     | job 5989781933 has completed (purged errors)
[2023-10-14 04:33:56] 2023-10-14 10:33:35,804 | INFO     | overall cleanup function is called
[2023-10-14 04:33:56] 2023-10-14 10:33:36,808 | INFO     | --- collectZombieJob: --- 10, [2526215]
[2023-10-14 04:33:56] 2023-10-14 10:33:36,808 | INFO     | zombie collector waiting for pid 2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:36,808 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-10-14 04:33:56] 2023-10-14 10:33:37,812 | INFO     | collected zombie processes
[2023-10-14 04:33:56] 2023-10-14 10:33:37,812 | INFO     | will now attempt to kill all subprocesses of pid=2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:37,900 | INFO     | process IDs to be killed: [2526215] (in reverse order)
[2023-10-14 04:33:56] 2023-10-14 10:33:37,946 | WARNING  | found no corresponding commands to process id(s)
[2023-10-14 04:33:56] 2023-10-14 10:33:37,946 | INFO     | Do not look for orphan processes in BOINC jobs
[2023-10-14 04:33:56] 2023-10-14 10:33:37,953 | INFO     | did not find any defunct processes belonging to 2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:37,956 | INFO     | did not find any defunct processes belonging to 2526215
[2023-10-14 04:33:56] 2023-10-14 10:33:37,956 | INFO     | ready for new job
[2023-10-14 04:33:56] 2023-10-14 10:33:37,956 | INFO     | pilot has finished with previous job - re-establishing logging
[2023-10-14 04:33:56] 2023-10-14 10:33:37,957 | INFO     | **************************************
[2023-10-14 04:33:56] 2023-10-14 10:33:37,957 | INFO     | ***  PanDA Pilot version 3.6.9.10  ***
[2023-10-14 04:33:56] 2023-10-14 10:33:37,957 | INFO     | **************************************
[2023-10-14 04:33:56] 2023-10-14 10:33:37,958 | INFO     | 
[2023-10-14 04:33:56] 2023-10-14 10:33:37,981 | INFO     | architecture information:
[2023-10-14 04:33:56] 2023-10-14 10:33:37,982 | INFO     | executing command: cat /etc/os-release
[2023-10-14 04:33:56] 2023-10-14 10:33:37,991 | INFO     | cat /etc/os-release:
[2023-10-14 04:33:56] NAME="CentOS Linux"
[2023-10-14 04:33:56] VERSION="7 (Core)"
[2023-10-14 04:33:56] ID="centos"
[2023-10-14 04:33:56] ID_LIKE="rhel fedora"
[2023-10-14 04:33:56] VERSION_ID="7"
[2023-10-14 04:33:56] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-10-14 04:33:56] ANSI_COLOR="0;31"
[2023-10-14 04:33:56] CPE_NAME="cpe:/o:centos:centos:7"
[2023-10-14 04:33:56] HOME_URL="https://www.centos.org/"
[2023-10-14 04:33:56] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-10-14 04:33:56] 
[2023-10-14 04:33:56] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-10-14 04:33:56] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-10-14 04:33:56] REDHAT_SUPPORT_PRODUCT="centos"
[2023-10-14 04:33:56] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-10-14 04:33:56] 
[2023-10-14 04:33:56] 2023-10-14 10:33:37,992 | INFO     | **************************************
[2023-10-14 04:33:56] 2023-10-14 10:33:38,492 | INFO     | executing command: df -mP /var/lib/boinc-client/slots/1
[2023-10-14 04:33:56] 2023-10-14 10:33:38,513 | INFO     | sufficient remaining disk space (211246120960 B)
[2023-10-14 04:33:56] 2023-10-14 10:33:38,513 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2023-10-14 04:33:56] 2023-10-14 10:33:38,513 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-10-14 04:33:56] 2023-10-14 10:33:38,513 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2023-10-14 04:33:56] 2023-10-14 10:33:38,513 | INFO     | found 0 job(s) in 20 queues
[2023-10-14 04:33:56] 2023-10-14 10:33:38,514 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2023-10-14 04:33:56] 2023-10-14 10:33:38,514 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2023-10-14 04:33:56] 2023-10-14 10:33:38,852 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2023-10-14 04:33:56] 2023-10-14 10:33:39,092 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2023-10-14 04:33:56] 2023-10-14 10:33:39,092 | INFO     | aborting loop
[2023-10-14 04:33:56] 2023-10-14 10:33:39,518 | INFO     | [job] retrieve thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:39,536 | INFO     | [payload] control thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:39,796 | INFO     | [payload] validate_post thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:39,836 | INFO     | [data] control thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:39,872 | INFO     | [job] validate thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:39,988 | INFO     | [payload] failed_post thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,096 | INFO     | [job] job monitor thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,128 | INFO     | [job] create_data_payload thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,355 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-10-14 04:33:56] 2023-10-14 10:33:40,356 | INFO     | [data] copytool_in thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,416 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2023-10-14 04:33:56] 2023-10-14 10:33:40,424 | INFO     | [job] control thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,776 | INFO     | [payload] validate_pre thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:40,856 | INFO     | [data] copytool_out thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:41,016 | INFO     | [payload] execute_payloads thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:41,421 | INFO     | [job] queue monitor thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:44,360 | INFO     | [data] queue_monitor thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:49,472 | INFO     | job.realtimelogging is not enabled
[2023-10-14 04:33:56] 2023-10-14 10:33:50,476 | INFO     | [payload] run_realtimelog thread has finished
[2023-10-14 04:33:56] 2023-10-14 10:33:51,636 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140707190613824)>', '<ExcThread(monitor, started 140706551166720)>']
[2023-10-14 04:33:56] 2023-10-14 10:33:52,569 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2023-10-14 04:33:56] 2023-10-14 10:33:52,569 | INFO     | [monitor] control thread has ended
[2023-10-14 04:33:56] 2023-10-14 10:33:56,660 | INFO     | end of generic workflow (traces error code: 0)
[2023-10-14 04:33:56] 2023-10-14 10:33:56,661 | INFO     | traces error code: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:56,661 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2023-10-14 04:33:56] 2023-10-14 10:33:56,714 [wrapper] ==== pilot stdout END ====
[2023-10-14 04:33:56] 2023-10-14 10:33:56,716 [wrapper] ==== wrapper stdout RESUME ====
[2023-10-14 04:33:56] 2023-10-14 10:33:56,721 [wrapper] pilotpid: 2503860
[2023-10-14 04:33:56] 2023-10-14 10:33:56,729 [wrapper] Pilot exit status: 0
[2023-10-14 04:33:56] 2023-10-14 10:33:56,735 [wrapper] pandaids: 5989781933
[2023-10-14 04:33:56] 2023-10-14 10:33:56,739 [wrapper] apfmon messages muted
[2023-10-14 04:33:56] 2023-10-14 10:33:56,741 [wrapper] Test setup, not cleaning
[2023-10-14 04:33:56] 2023-10-14 10:33:56,743 [wrapper] ==== wrapper stdout END ====
[2023-10-14 04:33:56] 2023-10-14 10:33:56,745 [wrapper] ==== wrapper stderr END ====
[2023-10-14 04:33:56] 2023-10-14 10:33:56,751 [wrapper] wrapperexiting ec=0, duration=1698
[2023-10-14 04:33:56] 2023-10-14 10:33:56,756 [wrapper] apfmon messages muted
[2023-10-14 04:33:56]  *** Error codes and diagnostics ***
[2023-10-14 04:33:56]     "exeErrorCode": 0,
[2023-10-14 04:33:56]     "exeErrorDiag": "",
[2023-10-14 04:33:56]     "pilotErrorCode": 0,
[2023-10-14 04:33:56]     "pilotErrorDiag": "",
[2023-10-14 04:33:56]  *** Listing of results directory ***
[2023-10-14 04:33:56] total 43372
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc   433413 Oct 14 03:39 pilot3.tar.gz
[2023-10-14 04:33:56] -rwx------ 1 boinc boinc    27437 Oct 14 04:02 runpilot2-wrapper.sh
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc     4388 Oct 14 04:02 queuedata.json
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc      107 Oct 14 04:05 wrapper_26015_x86_64-pc-linux-gnu
[2023-10-14 04:33:56] -rwxr-xr-x 1 boinc boinc     7986 Oct 14 04:05 run_atlas
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc      112 Oct 14 04:05 job.xml
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc    17624 Oct 14 04:05 start_atlas.sh
[2023-10-14 04:33:56] drwxrwx--x 2 boinc boinc     4096 Oct 14 04:05 shared
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc   444667 Oct 14 04:05 input.tar.gz
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc     9118 Oct 14 04:05 init_data.xml
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc 37727106 Oct 14 04:05 EVNT.04972714._000037.pool.root.1
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc        0 Oct 14 04:05 boinc_lockfile
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc     2756 Oct 14 04:05 pandaJob.out
[2023-10-14 04:33:56] -rw------- 1 boinc boinc      424 Oct 14 04:05 setup.sh.local
[2023-10-14 04:33:56] -rw------- 1 boinc boinc  1361563 Oct 14 04:06 cric_ddmendpoints.json
[2023-10-14 04:33:56] -rw------- 1 boinc boinc   993176 Oct 14 04:06 agis_schedconf.cvmfs.json
[2023-10-14 04:33:56] drwx------ 4 boinc boinc     4096 Oct 14 04:07 pilot3
[2023-10-14 04:33:56] -rw------- 1 boinc boinc  1257600 Oct 14 04:27 output.1.79294a46-f40b-4d43-9908-0279358e0d28_78419.pool.root
[2023-10-14 04:33:56] -rw------- 1 boinc boinc     1033 Oct 14 04:27 memory_monitor_summary.json
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc      534 Oct 14 04:27 boinc_task_state.xml
[2023-10-14 04:33:56] -rw------- 1 boinc boinc   159191 Oct 14 04:30 79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log.tgz
[2023-10-14 04:33:56] -rw------- 1 boinc boinc     6639 Oct 14 04:33 heartbeat.json
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc     8192 Oct 14 04:33 boinc_mmap_file
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc       25 Oct 14 04:33 wrapper_checkpoint.txt
[2023-10-14 04:33:56] -rw------- 1 boinc boinc     4104 Oct 14 04:33 pilotlog.txt
[2023-10-14 04:33:56] -rw------- 1 boinc boinc   197946 Oct 14 04:33 79294a46-f40b-4d43-9908-0279358e0d28_78419.1.job.log
[2023-10-14 04:33:56] -rw------- 1 boinc boinc      464 Oct 14 04:33 output.list
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc      748 Oct 14 04:33 runtime_log
[2023-10-14 04:33:56] -rw------- 1 boinc boinc  1628160 Oct 14 04:33 result.tar.gz
[2023-10-14 04:33:56] -rw------- 1 boinc boinc      628 Oct 14 04:33 uOJMDmZeqB4n7Olcko1bjSoqABFKDmABFKDm7AsVDmi0SKDmwtI2Rm.diag
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc    11947 Oct 14 04:33 runtime_log.err
[2023-10-14 04:33:56] -rw-r--r-- 1 boinc boinc    23130 Oct 14 04:33 stderr.txt
[2023-10-14 04:33:56] HITS file was successfully produced:
[2023-10-14 04:33:56] -rw------- 1 boinc boinc 1257600 Oct 14 04:27 shared/HITS.pool.root.1
[2023-10-14 04:33:56]  *** Contents of shared directory: ***
[2023-10-14 04:33:56] total 40124
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc    17624 Oct 14 04:05 start_atlas.sh
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc   444667 Oct 14 04:05 input.tar.gz
[2023-10-14 04:33:56] -rw-r--r-- 2 boinc boinc 37727106 Oct 14 04:05 ATLAS.root_0
[2023-10-14 04:33:56] -rw------- 1 boinc boinc  1257600 Oct 14 04:27 HITS.pool.root.1
[2023-10-14 04:33:56] -rw------- 1 boinc boinc  1628160 Oct 14 04:33 result.tar.gz
04:33:58 (2500095): run_atlas exited; CPU time 492.259799
04:33:58 (2500095): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN