Name 4jmKDmN7eV3n7Olcko1bjSoqABFKDmABFKDm7AsVDmbnLKDm7HTJwm_0
Workunit 2313423
Created 20 Jun 2023, 1:13:44 UTC
Sent 20 Jun 2023, 1:14:14 UTC
Report deadline 27 Jun 2023, 1:14:14 UTC
Received 20 Jun 2023, 1:43:46 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 1498
Run time 27 min 10 sec
CPU time 13 min 39 sec
Validate state Valid
Credit 19.76
Device peak FLOPS 13.02 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.51 GB
Peak swap size 2.12 GB
Peak disk usage 79.76 MB

Stderr output

<core_client_version>7.4.25</core_client_version>
<![CDATA[
<stderr_txt>
02:15:17 (31866): wrapper (7.7.26015): starting
02:15:17 (31866): wrapper: running run_atlas (--nthreads 4)
[2023-06-20 02:15:17] Arguments: --nthreads 4
[2023-06-20 02:15:17] Threads: 4
[2023-06-20 02:15:17] Checking for CVMFS
[2023-06-20 02:15:18] Probing /cvmfs/atlas.cern.ch... OK
[2023-06-20 02:15:19] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-06-20 02:15:19] Running cvmfs_config stat atlas.cern.ch
[2023-06-20 02:15:19] 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-06-20 02:15:19] 2.9.0.0 32007 0 24932 120347 3 1 2587454 4194305 0 130560 0 0 100.000 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.100.152:3128 1
[2023-06-20 02:15:19] CVMFS is ok
[2023-06-20 02:15:19] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-06-20 02:15:19] Checking for apptainer binary...
[2023-06-20 02:15:19] Using apptainer found in PATH at /usr/bin/apptainer
[2023-06-20 02:15:19] Running /usr/bin/apptainer --version
[2023-06-20 02:15:19] apptainer version 1.0.3
[2023-06-20 02:15:19] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-06-20 02:15:19] TeeC16
[2023-06-20 02:15:19] apptainer works
[2023-06-20 02:15:19] Set ATHENA_PROC_NUMBER=4
[2023-06-20 02:15:19] Set ATHENA_CORE_NUMBER=4
[2023-06-20 02:15:19] Starting ATLAS job with PandaID=5881531671
[2023-06-20 02:15:19] Running command: /usr/bin/apptainer exec -B /cvmfs,/home/m/BOINC/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-06-20 02:42:24]  *** The last 200 lines of the pilot log: ***
[2023-06-20 02:42:24] 2023-06-20 01:41:35,617 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:35,617 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:38,120 | INFO     | monitor loop #229: job 0:5881531671 is in state 'stageout'
[2023-06-20 02:42:24] 2023-06-20 01:41:38,163 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:38,164 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:40,667 | INFO     | monitor loop #230: job 0:5881531671 is in state 'stageout'
[2023-06-20 02:42:24] 2023-06-20 01:41:40,710 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:40,710 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:43,214 | INFO     | monitor loop #231: job 0:5881531671 is in state 'stageout'
[2023-06-20 02:42:24] 2023-06-20 01:41:43,257 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:43,257 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:45,760 | INFO     | monitor loop #232: job 0:5881531671 is in state 'stageout'
[2023-06-20 02:42:24] 2023-06-20 01:41:45,762 | INFO     | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 778476 B
[2023-06-20 02:42:24] 2023-06-20 01:41:45,762 | INFO     | payload log (payload.stdout) within allowed size limit (2147483648 B): 9138 B
[2023-06-20 02:42:24] 2023-06-20 01:41:45,762 | INFO     | executing command: df -mP /home/m/BOINC/slots/3
[2023-06-20 02:42:24] 2023-06-20 01:41:45,778 | INFO     | sufficient remaining disk space (424264335360 B)
[2023-06-20 02:42:24] 2023-06-20 01:41:45,778 | INFO     | work directory size check will use 61362667520 B as a max limit (10% grace limit added)
[2023-06-20 02:42:24] 2023-06-20 01:41:45,780 | INFO     | size of work directory /home/m/BOINC/slots/3/PanDA_Pilot-5881531671: 1125493 B (within 61362667520 B limit)
[2023-06-20 02:42:24] 2023-06-20 01:41:45,780 | INFO     | pfn file=/home/m/BOINC/slots/3/PanDA_Pilot-5881531671/output.1.96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.pool.root does not exist (skip from workdir size calculat
[2023-06-20 02:42:24] 2023-06-20 01:41:45,780 | INFO     | total size of present files: 0 B (workdir size: 1125493 B)
[2023-06-20 02:42:24] 2023-06-20 01:41:45,780 | INFO     | output file size check: skipping output file /home/m/BOINC/slots/3/PanDA_Pilot-5881531671/output.1.96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.pool.root since it do
[2023-06-20 02:42:24] 2023-06-20 01:41:45,822 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:45,822 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:48,325 | INFO     | monitor loop #233: job 0:5881531671 is in state 'stageout'
[2023-06-20 02:42:24] 2023-06-20 01:41:48,368 | INFO     | number of running child processes to parent process 10563: 1
[2023-06-20 02:42:24] 2023-06-20 01:41:48,368 | INFO     | maximum number of monitored processes: 5
[2023-06-20 02:42:24] 2023-06-20 01:41:49,901 | INFO     | [attempt=3/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-06-20 02:42:24] 2023-06-20 01:41:50,031 | 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-06-20 02:42:24] 2023-06-20 01:41:50,032 | WARNING  | cache file=/home/m/BOINC/slots/3/agis_ddmendpoints.agis.ALL.json is not available: [Errno 2] No such file or directory: '/home/m/BOINC/slots/3/agis_ddmendpoints.ag
[2023-06-20 02:42:24] 2023-06-20 01:41:50,081 | INFO     | transferring file 96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log.tgz from /home/m/BOINC/slots/3/PanDA_Pilot-5881531671/96c95397-daf1-4011-8cb9-a08af3dd0c82_6
[2023-06-20 02:42:24] 2023-06-20 01:41:50,081 | INFO     | executing command: /usr/bin/env mv /home/m/BOINC/slots/3/PanDA_Pilot-5881531671/96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log.tgz /home/m/BOINC/slots/3/96c9
[2023-06-20 02:42:24] 2023-06-20 01:41:50,100 | INFO     | Adding to output.list: 96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/09/9a/96c95397-daf1-
[2023-06-20 02:42:24] 2023-06-20 01:41:50,101 | INFO     | executing command: ps aux -q 3340
[2023-06-20 02:42:24] 2023-06-20 01:41:50,127 | INFO     | summary of transferred files:
[2023-06-20 02:42:24] 2023-06-20 01:41:50,127 | INFO     |  -- lfn=96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log.tgz, status_code=0, status=transferred
[2023-06-20 02:42:24] 2023-06-20 01:41:50,128 | INFO     | stage-out finished correctly
[2023-06-20 02:42:24] 2023-06-20 01:41:50,871 | INFO     | monitor loop #234: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:41:50,872 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:41:51,901 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-06-20 02:42:24] 2023-06-20 01:41:52,816 | INFO     | job 5881531671 has state=finished
[2023-06-20 02:42:24] 2023-06-20 01:41:52,817 | INFO     | preparing for final server update for job 5881531671 in state='finished'
[2023-06-20 02:42:24] 2023-06-20 01:41:52,817 | INFO     | this job has now completed (state=finished)
[2023-06-20 02:42:24] 2023-06-20 01:41:52,817 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2023-06-20 02:42:24] 2023-06-20 01:41:52,817 | INFO     | job 5881531671 has finished - writing final server update
[2023-06-20 02:42:24] 2023-06-20 01:41:52,819 | INFO     | fitting pss+swap vs Time
[2023-06-20 02:42:24] 2023-06-20 01:41:52,819 | INFO     | current memory leak: 383.97 B/s (using 10 data points, chi2=0.03)
[2023-06-20 02:42:24] 2023-06-20 01:41:52,820 | INFO     | total number of processed events: 2 (read)
[2023-06-20 02:42:24] 2023-06-20 01:41:52,840 | INFO     | executing command: lscpu
[2023-06-20 02:42:24] 2023-06-20 01:41:52,861 | INFO     | found 2 cores (2 cores per socket, 1 sockets)
[2023-06-20 02:42:24] 2023-06-20 01:41:52,862 | INFO     | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-06-20 02:42:24] 2023-06-20 01:41:52,893 | 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-06-20 02:42:24] 2023-06-20 01:41:53,375 | INFO     | monitor loop #235: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:41:53,375 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:41:55,878 | INFO     | monitor loop #236: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:41:55,878 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:41:58,379 | INFO     | monitor loop #237: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:41:58,380 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:42:00,883 | INFO     | monitor loop #238: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:42:00,884 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:42:03,387 | INFO     | monitor loop #239: job 0:5881531671 is in state 'finished'
[2023-06-20 02:42:24] 2023-06-20 01:42:03,387 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-06-20 02:42:24] 2023-06-20 01:42:05,007 | INFO     | executing command: python3 /home/m/BOINC/slots/3/pilot3/pilot/scripts/cpu_arch.py --alg gcc
[2023-06-20 02:42:24] 2023-06-20 01:42:05,110 | INFO     | using path: /home/m/BOINC/slots/3/PanDA_Pilot-5881531671/memory_monitor_summary.json (trf name=prmon)
[2023-06-20 02:42:24] 2023-06-20 01:42:05,111 | INFO     | extracted standard info from prmon json
[2023-06-20 02:42:24] 2023-06-20 01:42:05,111 | INFO     | extracted standard memory fields from prmon json
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | ..............................
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . Timing measurements:
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . get job = 45 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . initial setup = 50 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . payload setup = 8 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . stage-in = 68 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . payload execution = 1010 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | . stage-out = 378 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,112 | INFO     | ..............................
[2023-06-20 02:42:24] 2023-06-20 01:42:05,174 | INFO     | 
[2023-06-20 02:42:24] 2023-06-20 01:42:05,174 | INFO     | job summary report
[2023-06-20 02:42:24] 2023-06-20 01:42:05,174 | INFO     | --------------------------------------------------
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | PanDA job id: 5881531671
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | task id: NULL
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | errors: (none)
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | status: LOG_TRANSFER = DONE 
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | pilot state: finished 
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | transexitcode: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | exeerrorcode: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | exeerrordiag: 
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | exitcode: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | exitmsg: OK
[2023-06-20 02:42:24] 2023-06-20 01:42:05,175 | INFO     | cpuconsumptiontime: 834 s
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | nevents: 2
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | neventsw: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | pid: 10563
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | pgrp: 10563
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | corecount: 4
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | event service: False
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | sizes: {0: 2500658, 1: 2500857, 12: 2501003, 22: 2501031, 33: 2501059, 44: 2501087, 54: 2501243, 65: 2501271, 74: 2501359, 75: 2501387, 1022: 2521496, 1401: 253083
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | --------------------------------------------------
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | 
[2023-06-20 02:42:24] 2023-06-20 01:42:05,176 | INFO     | executing command: ls -lF /home/m/BOINC/slots/3
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue jobs had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue data_in had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue data_out had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue current_data_in had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,195 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,196 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,197 | INFO     | queue completed_jobids has 1 job(s)
[2023-06-20 02:42:24] 2023-06-20 01:42:05,197 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,197 | INFO     | queue messages had 0 job(s) [purged]
[2023-06-20 02:42:24] 2023-06-20 01:42:05,197 | INFO     | job 5881531671 has completed (purged errors)
[2023-06-20 02:42:24] 2023-06-20 01:42:05,197 | INFO     | overall cleanup function is called
[2023-06-20 02:42:24] 2023-06-20 01:42:06,204 | INFO     | --- collectZombieJob: --- 10, [10563]
[2023-06-20 02:42:24] 2023-06-20 01:42:06,204 | INFO     | zombie collector trying to kill pid 10563
[2023-06-20 02:42:24] 2023-06-20 01:42:06,205 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-06-20 02:42:24] 2023-06-20 01:42:07,210 | INFO     | collected zombie processes
[2023-06-20 02:42:24] 2023-06-20 01:42:07,210 | INFO     | will now attempt to kill all subprocesses of pid=10563
[2023-06-20 02:42:24] 2023-06-20 01:42:07,254 | INFO     | process IDs to be killed: [10563] (in reverse order)
[2023-06-20 02:42:24] 2023-06-20 01:42:07,289 | WARNING  | found no corresponding commands to process id(s)
[2023-06-20 02:42:24] 2023-06-20 01:42:07,289 | INFO     | Do not look for orphan processes in BOINC jobs
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | ready for new job
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | pilot has finished with previous job - re-establishing logging
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | *****************************************
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | ***  PanDA Pilot version 3.6.0 (108)  ***
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | *****************************************
[2023-06-20 02:42:24] 2023-06-20 01:42:07,290 | INFO     | 
[2023-06-20 02:42:24] 2023-06-20 01:42:07,307 | INFO     | architecture information:
[2023-06-20 02:42:24] 2023-06-20 01:42:07,308 | INFO     | executing command: cat /etc/os-release
[2023-06-20 02:42:24] 2023-06-20 01:42:07,324 | INFO     | cat /etc/os-release:
[2023-06-20 02:42:24] NAME="CentOS Linux"
[2023-06-20 02:42:24] VERSION="7 (Core)"
[2023-06-20 02:42:24] ID="centos"
[2023-06-20 02:42:24] ID_LIKE="rhel fedora"
[2023-06-20 02:42:24] VERSION_ID="7"
[2023-06-20 02:42:24] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-06-20 02:42:24] ANSI_COLOR="0;31"
[2023-06-20 02:42:24] CPE_NAME="cpe:/o:centos:centos:7"
[2023-06-20 02:42:24] HOME_URL="https://www.centos.org/"
[2023-06-20 02:42:24] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-06-20 02:42:24] 
[2023-06-20 02:42:24] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-06-20 02:42:24] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-06-20 02:42:24] REDHAT_SUPPORT_PRODUCT="centos"
[2023-06-20 02:42:24] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-06-20 02:42:24] 
[2023-06-20 02:42:24] 2023-06-20 01:42:07,325 | INFO     | *****************************************
[2023-06-20 02:42:24] 2023-06-20 01:42:07,827 | INFO     | executing command: df -mP /home/m/BOINC/slots/3
[2023-06-20 02:42:24] 2023-06-20 01:42:07,846 | INFO     | sufficient remaining disk space (424265383936 B)
[2023-06-20 02:42:24] 2023-06-20 01:42:07,846 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2023-06-20 02:42:24] 2023-06-20 01:42:07,846 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-06-20 02:42:24] 2023-06-20 01:42:07,847 | INFO     | [job] retrieve thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:07,847 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2023-06-20 02:42:24] 2023-06-20 01:42:07,847 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-06-20 02:42:24] 2023-06-20 01:42:07,848 | INFO     | aborting loop
[2023-06-20 02:42:24] 2023-06-20 01:42:07,848 | INFO     | [job] job monitor thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:07,859 | INFO     | [payload] control thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:07,903 | INFO     | [data] control thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:08,214 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2023-06-20 02:42:24] 2023-06-20 01:42:08,258 | INFO     | [payload] failed_post thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:08,506 | INFO     | found 0 job(s) in 20 queues
[2023-06-20 02:42:24] 2023-06-20 01:42:08,506 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2023-06-20 02:42:24] 2023-06-20 01:42:08,506 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2023-06-20 02:42:24] 2023-06-20 01:42:08,509 | INFO     | [data] copytool_in thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:08,772 | INFO     | [job] validate thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:08,794 | INFO     | [payload] validate_post thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:08,984 | INFO     | [job] create_data_payload thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:09,104 | INFO     | [payload] validate_pre thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:09,154 | INFO     | [job] control thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:09,192 | INFO     | [payload] execute_payloads thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:09,215 | INFO     | [data] copytool_out thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:10,185 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2023-06-20 02:42:24] 2023-06-20 01:42:10,185 | INFO     | [job] queue monitor thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:10,849 | INFO     | [data] queue_monitor thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:18,403 | INFO     | job.realtimelogging is not enabled
[2023-06-20 02:42:24] 2023-06-20 01:42:18,403 | INFO     | [payload] run_realtimelog thread has finished
[2023-06-20 02:42:24] 2023-06-20 01:42:18,931 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140665491572544)>', '<ExcThread(monitor, started 140664784275200)>']
[2023-06-20 02:42:24] 2023-06-20 01:42:19,561 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2023-06-20 02:42:24] 2023-06-20 01:42:19,562 | INFO     | [monitor] control thread has ended
[2023-06-20 02:42:24] 2023-06-20 01:42:23,957 | INFO     | end of generic workflow (traces error code: 0)
[2023-06-20 02:42:24] 2023-06-20 01:42:23,957 | INFO     | traces error code: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:23,957 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2023-06-20 02:42:24] 2023-06-20 01:42:24,010 [wrapper] ==== pilot stdout END ====
[2023-06-20 02:42:24] 2023-06-20 01:42:24,015 [wrapper] ==== wrapper stdout RESUME ====
[2023-06-20 02:42:24] 2023-06-20 01:42:24,020 [wrapper] pilotpid: 3340
[2023-06-20 02:42:24] 2023-06-20 01:42:24,024 [wrapper] Pilot exit status: 0
[2023-06-20 02:42:24] 2023-06-20 01:42:24,034 [wrapper] pandaids: 5881531671
[2023-06-20 02:42:24] 2023-06-20 01:42:24,042 [wrapper] apfmon messages muted
[2023-06-20 02:42:24] 2023-06-20 01:42:24,046 [wrapper] Test setup, not cleaning
[2023-06-20 02:42:24] 2023-06-20 01:42:24,049 [wrapper] ==== wrapper stdout END ====
[2023-06-20 02:42:24] 2023-06-20 01:42:24,053 [wrapper] ==== wrapper stderr END ====
[2023-06-20 02:42:24] 2023-06-20 01:42:24,061 [wrapper] wrapperexiting ec=0, duration=1624
[2023-06-20 02:42:24] 2023-06-20 01:42:24,066 [wrapper] apfmon messages muted
[2023-06-20 02:42:24]  *** Error codes and diagnostics ***
[2023-06-20 02:42:24]     "exeErrorCode": 0,
[2023-06-20 02:42:24]     "exeErrorDiag": "",
[2023-06-20 02:42:24]     "pilotErrorCode": 0,
[2023-06-20 02:42:24]     "pilotErrorDiag": "",
[2023-06-20 02:42:24]  *** Listing of results directory ***
[2023-06-20 02:42:24] total 44928
[2023-06-20 02:42:24] -rw-r--r-- 1 m m   410584 Jun 20 01:39 pilot3.tar.gz
[2023-06-20 02:42:24] -rwx------ 1 m m    27012 Jun 20 02:13 runpilot2-wrapper.sh
[2023-06-20 02:42:24] -rw-r--r-- 1 m m     4388 Jun 20 02:13 queuedata.json
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m      107 Jun 20 02:15 wrapper_26015_x86_64-pc-linux-gnu
[2023-06-20 02:42:24] -rwxr-xr-x 1 m m     7986 Jun 20 02:15 run_atlas
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m      112 Jun 20 02:15 job.xml
[2023-06-20 02:42:24] -rw-r--r-- 2 m m    17604 Jun 20 02:15 start_atlas.sh
[2023-06-20 02:42:24] drwxrwx--x 2 m m     4096 Jun 20 02:15 shared
[2023-06-20 02:42:24] -rw-r--r-- 2 m m   421966 Jun 20 02:15 input.tar.gz
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m     5728 Jun 20 02:15 init_data.xml
[2023-06-20 02:42:24] -rw-r--r-- 2 m m 37658468 Jun 20 02:15 EVNT.04972714._000029.pool.root.1
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m        0 Jun 20 02:15 boinc_lockfile
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m     2753 Jun 20 02:15 pandaJob.out
[2023-06-20 02:42:24] -rw------- 1 m m      424 Jun 20 02:15 setup.sh.local
[2023-06-20 02:42:24] -rw------- 1 m m  1017076 Jun 20 02:15 agis_schedconf.cvmfs.json
[2023-06-20 02:42:24] -rw------- 1 m m  1399895 Jun 20 02:16 cric_ddmendpoints.json
[2023-06-20 02:42:24] drwx------ 4 m m     4096 Jun 20 02:17 pilot3
[2023-06-20 02:42:24] -rw------- 1 m m  2054597 Jun 20 02:35 output.1.96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.pool.root
[2023-06-20 02:42:24] -rw------- 1 m m     1018 Jun 20 02:35 memory_monitor_summary.json
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m      533 Jun 20 02:35 boinc_task_state.xml
[2023-06-20 02:42:24] -rw------- 1 m m   162923 Jun 20 02:38 96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log.tgz
[2023-06-20 02:42:24] -rw------- 1 m m     6674 Jun 20 02:42 heartbeat.json
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m     8192 Jun 20 02:42 boinc_mmap_file
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m       25 Jun 20 02:42 wrapper_checkpoint.txt
[2023-06-20 02:42:24] -rw------- 1 m m     3985 Jun 20 02:42 pilotlog.txt
[2023-06-20 02:42:24] -rw------- 1 m m   223209 Jun 20 02:42 96c95397-daf1-4011-8cb9-a08af3dd0c82_66767.1.job.log
[2023-06-20 02:42:24] -rw------- 1 m m      464 Jun 20 02:42 output.list
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m      748 Jun 20 02:42 runtime_log
[2023-06-20 02:42:24] -rw------- 1 m m  2457600 Jun 20 02:42 result.tar.gz
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m    11905 Jun 20 02:42 runtime_log.err
[2023-06-20 02:42:24] -rw------- 1 m m      627 Jun 20 02:42 4jmKDmN7eV3n7Olcko1bjSoqABFKDmABFKDm7AsVDmbnLKDm7HTJwm.diag
[2023-06-20 02:42:24] -rw-rw-r-- 1 m m    22910 Jun 20 02:42 stderr.txt
[2023-06-20 02:42:24] HITS file was successfully produced:
[2023-06-20 02:42:24] -rw------- 1 m m 2054597 Jun 20 02:35 shared/HITS.pool.root.1
[2023-06-20 02:42:24]  *** Contents of shared directory: ***
[2023-06-20 02:42:24] total 41620
[2023-06-20 02:42:24] -rw-r--r-- 2 m m    17604 Jun 20 02:15 start_atlas.sh
[2023-06-20 02:42:24] -rw-r--r-- 2 m m   421966 Jun 20 02:15 input.tar.gz
[2023-06-20 02:42:24] -rw-r--r-- 2 m m 37658468 Jun 20 02:15 ATLAS.root_0
[2023-06-20 02:42:24] -rw------- 1 m m  2054597 Jun 20 02:35 HITS.pool.root.1
[2023-06-20 02:42:24] -rw------- 1 m m  2457600 Jun 20 02:42 result.tar.gz
02:42:26 (31866): run_atlas exited; CPU time 819.100756
02:42:26 (31866): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN