Name JMZNDm8OHb3n7Olcko1bjSoqABFKDmABFKDm7AsVDmwnMKDmaUfIjm_1
Workunit 2316600
Created 5 Jul 2023, 13:16:50 UTC
Sent 5 Jul 2023, 13:17:42 UTC
Report deadline 12 Jul 2023, 13:17:42 UTC
Received 5 Jul 2023, 14:28:18 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4368
Run time 21 min 49 sec
CPU time 13 min 29 sec
Validate state Valid
Credit 24.40
Device peak FLOPS 7.55 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.52 GB
Peak swap size 2.13 GB
Peak disk usage 83.32 MB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
16:06:16 (8896): wrapper (7.7.26015): starting
16:06:16 (8896): wrapper: running run_atlas (--nthreads 2)
[2023-07-05 16:06:16] Arguments: --nthreads 2
[2023-07-05 16:06:16] Threads: 2
[2023-07-05 16:06:16] Checking for CVMFS
[2023-07-05 16:06:16] Probing /cvmfs/atlas.cern.ch... OK
[2023-07-05 16:06:16] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-07-05 16:06:16] Running cvmfs_config stat atlas.cern.ch
[2023-07-05 16:06:16] 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-07-05 16:06:16] 2.10.1.0 17360 103 46660 120920 0 102 3240356 4194304 0 130560 0 518003 99.994 24583 2791 http://cernvmfs.gridpp.rl.ac.uk:8000/cvmfs/atlas.cern.ch DIRECT 1
[2023-07-05 16:06:16] CVMFS is ok
[2023-07-05 16:06:16] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2023-07-05 16:06:16] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2023-07-05 16:06:16] Small home clusters do not require a local http proxy but it is suggested if
[2023-07-05 16:06:16] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2023-07-05 16:06:16] Further information can be found at the LHC@home message board.
[2023-07-05 16:06:16] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-07-05 16:06:16] Checking for apptainer binary...
[2023-07-05 16:06:16] apptainer is not installed, using version from CVMFS
[2023-07-05 16:06:16] 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-07-05 16:06:17] vps-3dca72ac
[2023-07-05 16:06:17] apptainer works
[2023-07-05 16:06:17] Set ATHENA_PROC_NUMBER=2
[2023-07-05 16:06:17] Set ATHENA_CORE_NUMBER=2
[2023-07-05 16:06:17] Starting ATLAS job with PandaID=5895972654
[2023-07-05 16:06:17] 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-07-05 16:28:02]  *** The last 200 lines of the pilot log: ***
[2023-07-05 16:28:02] 2023-07-05 14:27:02,536 | INFO     | will try again after 24s..
[2023-07-05 16:28:02] 2023-07-05 14:27:05,031 | INFO     | monitor loop #195: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:05,061 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:05,062 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:07,564 | INFO     | monitor loop #196: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:07,589 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:07,590 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:10,093 | INFO     | monitor loop #197: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:10,124 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:10,125 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:12,628 | INFO     | monitor loop #198: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:12,652 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:12,653 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:15,155 | INFO     | monitor loop #199: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:15,181 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:15,181 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:17,684 | INFO     | monitor loop #200: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:17,716 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:17,716 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:20,220 | INFO     | monitor loop #201: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:20,252 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:20,253 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:22,757 | INFO     | monitor loop #202: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:22,795 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:22,796 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:25,298 | INFO     | monitor loop #203: job 0:5895972654 is in state 'stageout'
[2023-07-05 16:28:02] 2023-07-05 14:27:25,331 | INFO     | number of running child processes to parent process 19539: 1
[2023-07-05 16:28:02] 2023-07-05 14:27:25,331 | INFO     | maximum number of monitored processes: 10
[2023-07-05 16:28:02] 2023-07-05 14:27:26,607 | INFO     | [attempt=3/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-07-05 16:28:02] 2023-07-05 14:27:26,715 | 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-07-05 16:28:02] 2023-07-05 14:27:26,715 | 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-07-05 16:28:02] 2023-07-05 14:27:26,762 | INFO     | transferring file 53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log.tgz from /var/lib/boinc-client/slots/1/PanDA_Pilot-5895972654/53e8d949-35e4-4add-937d-beb421
[2023-07-05 16:28:02] 2023-07-05 14:27:26,762 | INFO     | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/1/PanDA_Pilot-5895972654/53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log.tgz /var/lib/boinc-cli
[2023-07-05 16:28:02] 2023-07-05 14:27:26,777 | INFO     | Adding to output.list: 53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/ca/32/53e8d949-35e4-
[2023-07-05 16:28:02] 2023-07-05 14:27:26,778 | INFO     | summary of transferred files:
[2023-07-05 16:28:02] 2023-07-05 14:27:26,778 | INFO     |  -- lfn=53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log.tgz, status_code=0, status=transferred
[2023-07-05 16:28:02] 2023-07-05 14:27:26,778 | INFO     | stage-out finished correctly
[2023-07-05 16:28:02] 2023-07-05 14:27:27,835 | INFO     | monitor loop #204: job 0:5895972654 is in state 'finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:27,835 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-07-05 16:28:02] 2023-07-05 14:27:27,892 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-07-05 16:28:02] 2023-07-05 14:27:30,130 | INFO     | job 5895972654 has state=finished
[2023-07-05 16:28:02] 2023-07-05 14:27:30,131 | INFO     | preparing for final server update for job 5895972654 in state='finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:30,131 | INFO     | this job has now completed (state=finished)
[2023-07-05 16:28:02] 2023-07-05 14:27:30,132 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2023-07-05 16:28:02] 2023-07-05 14:27:30,132 | INFO     | job 5895972654 has finished - writing final server update
[2023-07-05 16:28:02] 2023-07-05 14:27:30,133 | WARNING  | wrong length of table data, x=[1688566481.0, 1688566542.0, 1688566603.0, 1688566664.0, 1688566725.0], y=[1903186.0, 1922670.0, 1936973.0, 1813913.0, 1814349.0] (mu
[2023-07-05 16:28:02] 2023-07-05 14:27:30,134 | INFO     | total number of processed events: 2 (read)
[2023-07-05 16:28:02] 2023-07-05 14:27:30,137 | INFO     | executing command: lscpu
[2023-07-05 16:28:02] 2023-07-05 14:27:30,153 | INFO     | found 2 cores (1 cores per socket, 2 sockets)
[2023-07-05 16:28:02] 2023-07-05 14:27:30,153 | INFO     | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-07-05 16:28:02] 2023-07-05 14:27:30,178 | 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-07-05 16:28:02] 2023-07-05 14:27:30,338 | INFO     | monitor loop #205: job 0:5895972654 is in state 'finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:30,339 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-07-05 16:28:02] 2023-07-05 14:27:32,842 | INFO     | monitor loop #206: job 0:5895972654 is in state 'finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:32,843 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-07-05 16:28:02] 2023-07-05 14:27:34,067 | INFO     | 1271s have passed since pilot start
[2023-07-05 16:28:02] 2023-07-05 14:27:35,348 | INFO     | monitor loop #207: job 0:5895972654 is in state 'finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:35,349 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-07-05 16:28:02] 2023-07-05 14:27:37,852 | INFO     | monitor loop #208: job 0:5895972654 is in state 'finished'
[2023-07-05 16:28:02] 2023-07-05 14:27:37,852 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-07-05 16:28:02] 2023-07-05 14:27:40,221 | INFO     | no CPU architecture reporting
[2023-07-05 16:28:02] 2023-07-05 14:27:40,221 | INFO     | using path: /var/lib/boinc-client/slots/1/PanDA_Pilot-5895972654/memory_monitor_summary.json (trf name=prmon)
[2023-07-05 16:28:02] 2023-07-05 14:27:40,222 | INFO     | extracted standard info from prmon json
[2023-07-05 16:28:02] 2023-07-05 14:27:40,222 | INFO     | extracted standard memory fields from prmon json
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | ..............................
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . Timing measurements:
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . get job = 65 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . initial setup = 37 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . payload setup = 6 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . stage-in = 68 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . payload execution = 696 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | . stage-out = 376 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,223 | INFO     | ..............................
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | 
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | job summary report
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | --------------------------------------------------
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | PanDA job id: 5895972654
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | task id: NULL
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | errors: (none)
[2023-07-05 16:28:02] 2023-07-05 14:27:40,290 | INFO     | status: LOG_TRANSFER = DONE 
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | pilot state: finished 
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | transexitcode: 0
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | exeerrorcode: 0
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | exeerrordiag: 
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | exitcode: 0
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | exitmsg: OK
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | cpuconsumptiontime: 820 s
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | nevents: 2
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | neventsw: 0
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | pid: 19539
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | pgrp: 19539
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | corecount: 2
[2023-07-05 16:28:02] 2023-07-05 14:27:40,291 | INFO     | event service: False
[2023-07-05 16:28:02] 2023-07-05 14:27:40,292 | INFO     | sizes: {0: 2486491, 11: 2486637, 22: 2486665, 32: 2486693, 43: 2486721, 53: 2486749, 64: 2486905, 72: 2487021, 75: 2487049, 706: 2509913, 1082: 2519237, 1084: 2519
[2023-07-05 16:28:02] 2023-07-05 14:27:40,292 | INFO     | --------------------------------------------------
[2023-07-05 16:28:02] 2023-07-05 14:27:40,292 | INFO     | 
[2023-07-05 16:28:02] 2023-07-05 14:27:40,292 | INFO     | executing command: ls -lF /var/lib/boinc-client/slots/1
[2023-07-05 16:28:02] 2023-07-05 14:27:40,310 | INFO     | queue jobs had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,310 | INFO     | queue payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,310 | INFO     | queue data_in had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue data_out had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue current_data_in had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,311 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue completed_jobids has 1 job(s)
[2023-07-05 16:28:02] 2023-07-05 14:27:40,312 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,313 | INFO     | queue messages had 0 job(s) [purged]
[2023-07-05 16:28:02] 2023-07-05 14:27:40,313 | INFO     | job 5895972654 has completed (purged errors)
[2023-07-05 16:28:02] 2023-07-05 14:27:40,313 | INFO     | overall cleanup function is called
[2023-07-05 16:28:02] 2023-07-05 14:27:41,322 | INFO     | --- collectZombieJob: --- 10, [19539]
[2023-07-05 16:28:02] 2023-07-05 14:27:41,323 | INFO     | zombie collector trying to kill pid 19539
[2023-07-05 16:28:02] 2023-07-05 14:27:41,323 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-07-05 16:28:02] 2023-07-05 14:27:42,328 | INFO     | collected zombie processes
[2023-07-05 16:28:02] 2023-07-05 14:27:42,329 | INFO     | will now attempt to kill all subprocesses of pid=19539
[2023-07-05 16:28:02] 2023-07-05 14:27:42,354 | INFO     | process IDs to be killed: [19539] (in reverse order)
[2023-07-05 16:28:02] 2023-07-05 14:27:42,379 | WARNING  | found no corresponding commands to process id(s)
[2023-07-05 16:28:02] 2023-07-05 14:27:42,379 | INFO     | Do not look for orphan processes in BOINC jobs
[2023-07-05 16:28:02] 2023-07-05 14:27:42,380 | INFO     | ready for new job
[2023-07-05 16:28:02] 2023-07-05 14:27:42,380 | INFO     | pilot has finished with previous job - re-establishing logging
[2023-07-05 16:28:02] 2023-07-05 14:27:42,381 | INFO     | ****************************************
[2023-07-05 16:28:02] 2023-07-05 14:27:42,381 | INFO     | ***  PanDA Pilot version 3.6.1 (31)  ***
[2023-07-05 16:28:02] 2023-07-05 14:27:42,381 | INFO     | ****************************************
[2023-07-05 16:28:02] 2023-07-05 14:27:42,381 | INFO     | 
[2023-07-05 16:28:02] 2023-07-05 14:27:42,382 | INFO     | pilot is running in a VM
[2023-07-05 16:28:02] 2023-07-05 14:27:42,382 | INFO     | architecture information:
[2023-07-05 16:28:02] 2023-07-05 14:27:42,382 | INFO     | executing command: cat /etc/os-release
[2023-07-05 16:28:02] 2023-07-05 14:27:42,397 | INFO     | cat /etc/os-release:
[2023-07-05 16:28:02] NAME="CentOS Linux"
[2023-07-05 16:28:02] VERSION="7 (Core)"
[2023-07-05 16:28:02] ID="centos"
[2023-07-05 16:28:02] ID_LIKE="rhel fedora"
[2023-07-05 16:28:02] VERSION_ID="7"
[2023-07-05 16:28:02] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-07-05 16:28:02] ANSI_COLOR="0;31"
[2023-07-05 16:28:02] CPE_NAME="cpe:/o:centos:centos:7"
[2023-07-05 16:28:02] HOME_URL="https://www.centos.org/"
[2023-07-05 16:28:02] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-07-05 16:28:02] 
[2023-07-05 16:28:02] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-07-05 16:28:02] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-07-05 16:28:02] REDHAT_SUPPORT_PRODUCT="centos"
[2023-07-05 16:28:02] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-07-05 16:28:02] 
[2023-07-05 16:28:02] 2023-07-05 14:27:42,397 | INFO     | ****************************************
[2023-07-05 16:28:02] 2023-07-05 14:27:42,898 | INFO     | executing command: df -mP /var/lib/boinc-client/slots/1
[2023-07-05 16:28:02] 2023-07-05 14:27:42,917 | INFO     | sufficient remaining disk space (57309921280 B)
[2023-07-05 16:28:02] 2023-07-05 14:27:42,918 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2023-07-05 16:28:02] 2023-07-05 14:27:42,918 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-07-05 16:28:02] 2023-07-05 14:27:42,918 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2023-07-05 16:28:02] 2023-07-05 14:27:42,974 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-07-05 16:28:02] 2023-07-05 14:27:43,093 | INFO     | found 0 job(s) in 20 queues
[2023-07-05 16:28:02] 2023-07-05 14:27:43,093 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2023-07-05 16:28:02] 2023-07-05 14:27:43,093 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2023-07-05 16:28:02] 2023-07-05 14:27:43,866 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2023-07-05 16:28:02] 2023-07-05 14:27:43,866 | INFO     | aborting loop
[2023-07-05 16:28:02] 2023-07-05 14:27:43,920 | INFO     | [job] retrieve thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,067 | INFO     | [payload] validate_post thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,247 | INFO     | [payload] failed_post thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,425 | INFO     | [payload] control thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,603 | INFO     | [job] control thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,604 | INFO     | [data] copytool_in thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,626 | INFO     | [job] validate thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,783 | INFO     | [data] control thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,839 | INFO     | [job] create_data_payload thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,872 | INFO     | [job] job monitor thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,924 | INFO     | [data] copytool_out thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:44,994 | INFO     | [payload] execute_payloads thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:45,046 | INFO     | [payload] validate_pre thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:45,298 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2023-07-05 16:28:02] 2023-07-05 14:27:46,303 | INFO     | [job] queue monitor thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:46,980 | INFO     | [data] queue_monitor thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:53,698 | INFO     | job.realtimelogging is not enabled
[2023-07-05 16:28:02] 2023-07-05 14:27:54,703 | INFO     | [payload] run_realtimelog thread has finished
[2023-07-05 16:28:02] 2023-07-05 14:27:56,340 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140456152753984)>', '<ExcThread(monitor, started 140455882774272)>']
[2023-07-05 16:28:02] 2023-07-05 14:27:57,143 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2023-07-05 16:28:02] 2023-07-05 14:27:57,143 | INFO     | [monitor] control thread has ended
[2023-07-05 16:28:02] 2023-07-05 14:28:01,364 | INFO     | end of generic workflow (traces error code: 0)
[2023-07-05 16:28:02] 2023-07-05 14:28:01,365 | INFO     | traces error code: 0
[2023-07-05 16:28:02] 2023-07-05 14:28:01,365 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2023-07-05 16:28:02] 2023-07-05 14:28:01,434 [wrapper] ==== pilot stdout END ====
[2023-07-05 16:28:02] 2023-07-05 14:28:01,437 [wrapper] ==== wrapper stdout RESUME ====
[2023-07-05 16:28:02] 2023-07-05 14:28:01,438 [wrapper] pilotpid: 12029
[2023-07-05 16:28:02] 2023-07-05 14:28:01,440 [wrapper] Pilot exit status: 0
[2023-07-05 16:28:02] 2023-07-05 14:28:01,452 [wrapper] pandaids: 5895972654
[2023-07-05 16:28:02] 2023-07-05 14:28:01,457 [wrapper] apfmon messages muted
[2023-07-05 16:28:02] 2023-07-05 14:28:01,459 [wrapper] Test setup, not cleaning
[2023-07-05 16:28:02] 2023-07-05 14:28:01,461 [wrapper] ==== wrapper stdout END ====
[2023-07-05 16:28:02] 2023-07-05 14:28:01,463 [wrapper] ==== wrapper stderr END ====
[2023-07-05 16:28:02] 2023-07-05 14:28:01,466 [wrapper] wrapperexiting ec=0, duration=1304
[2023-07-05 16:28:02] 2023-07-05 14:28:01,468 [wrapper] apfmon messages muted
[2023-07-05 16:28:02]  *** Error codes and diagnostics ***
[2023-07-05 16:28:02]     "exeErrorCode": 0,
[2023-07-05 16:28:02]     "exeErrorDiag": "",
[2023-07-05 16:28:02]     "pilotErrorCode": 0,
[2023-07-05 16:28:02]     "pilotErrorDiag": "",
[2023-07-05 16:28:02]  *** Listing of results directory ***
[2023-07-05 16:28:02] total 45376
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc   410964 Jul  5 14:40 pilot3.tar.gz
[2023-07-05 16:28:02] -rwx------ 1 boinc boinc    27010 Jul  5 15:07 runpilot2-wrapper.sh
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc     4388 Jul  5 15:07 queuedata.json
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc      107 Jul  5 16:06 wrapper_26015_x86_64-pc-linux-gnu
[2023-07-05 16:28:02] -rwxr-xr-x 1 boinc boinc     7986 Jul  5 16:06 run_atlas
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc      112 Jul  5 16:06 job.xml
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc    17624 Jul  5 16:06 start_atlas.sh
[2023-07-05 16:28:02] drwxrwx--x 2 boinc boinc     4096 Jul  5 16:06 shared
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc   422291 Jul  5 16:06 input.tar.gz
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc     6142 Jul  5 16:06 init_data.xml
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc 37658468 Jul  5 16:06 EVNT.04972714._000029.pool.root.1
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc        0 Jul  5 16:06 boinc_lockfile
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc     2756 Jul  5 16:06 pandaJob.out
[2023-07-05 16:28:02] -rw------- 1 boinc boinc      424 Jul  5 16:06 setup.sh.local
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  1013862 Jul  5 16:06 agis_schedconf.cvmfs.json
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  1390398 Jul  5 16:06 cric_ddmendpoints.json
[2023-07-05 16:28:02] drwx------ 4 boinc boinc     4096 Jul  5 16:08 pilot3
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc      532 Jul  5 16:18 boinc_task_state.xml
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  2055404 Jul  5 16:21 output.1.53e8d949-35e4-4add-937d-beb42156d7bb_59019.pool.root
[2023-07-05 16:28:02] -rw------- 1 boinc boinc     1015 Jul  5 16:21 memory_monitor_summary.json
[2023-07-05 16:28:02] -rw------- 1 boinc boinc   434057 Jul  5 16:24 53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log.tgz
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc     8192 Jul  5 16:27 boinc_mmap_file
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc       25 Jul  5 16:27 wrapper_checkpoint.txt
[2023-07-05 16:28:02] -rw------- 1 boinc boinc     7859 Jul  5 16:27 heartbeat.json
[2023-07-05 16:28:02] -rw------- 1 boinc boinc     4050 Jul  5 16:28 pilotlog.txt
[2023-07-05 16:28:02] -rw------- 1 boinc boinc   188082 Jul  5 16:28 53e8d949-35e4-4add-937d-beb42156d7bb_59019.1.job.log
[2023-07-05 16:28:02] -rw------- 1 boinc boinc      464 Jul  5 16:28 output.list
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc      748 Jul  5 16:28 runtime_log
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  2693120 Jul  5 16:28 result.tar.gz
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc    12121 Jul  5 16:28 runtime_log.err
[2023-07-05 16:28:02] -rw------- 1 boinc boinc      629 Jul  5 16:28 JMZNDm8OHb3n7Olcko1bjSoqABFKDmABFKDm7AsVDmwnMKDmaUfIjm.diag
[2023-07-05 16:28:02] -rw-r--r-- 1 boinc boinc    23106 Jul  5 16:28 stderr.txt
[2023-07-05 16:28:02] HITS file was successfully produced:
[2023-07-05 16:28:02] -rw------- 1 boinc boinc 2055404 Jul  5 16:21 shared/HITS.pool.root.1
[2023-07-05 16:28:02]  *** Contents of shared directory: ***
[2023-07-05 16:28:02] total 41852
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc    17624 Jul  5 16:06 start_atlas.sh
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc   422291 Jul  5 16:06 input.tar.gz
[2023-07-05 16:28:02] -rw-r--r-- 2 boinc boinc 37658468 Jul  5 16:06 ATLAS.root_0
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  2055404 Jul  5 16:21 HITS.pool.root.1
[2023-07-05 16:28:02] -rw------- 1 boinc boinc  2693120 Jul  5 16:28 result.tar.gz
16:28:04 (8896): run_atlas exited; CPU time 809.355814
16:28:04 (8896): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN