Name 1PHNDm2Jry3n7Olcko1bjSoqABFKDmABFKDm7AsVDmNqQKDmeEEmBo_0
Workunit 2330618
Created 8 Sep 2023, 14:07:35 UTC
Sent 8 Sep 2023, 14:07:41 UTC
Report deadline 15 Sep 2023, 14:07:41 UTC
Received 8 Sep 2023, 15:04:11 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4778
Run time 36 min 43 sec
CPU time 17 min 33 sec
Validate state Valid
Credit 35.45
Device peak FLOPS 6.95 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.58 GB
Peak swap size 2.12 GB
Peak disk usage 81.79 MB

Stderr output

<core_client_version>7.20.5</core_client_version>
<![CDATA[
<stderr_txt>
16:27:14 (102656): wrapper (7.7.26015): starting
16:27:14 (102656): wrapper: running run_atlas (--nthreads 3)
[2023-09-08 16:27:14] Arguments: --nthreads 3
[2023-09-08 16:27:14] Threads: 3
[2023-09-08 16:27:14] Checking for CVMFS
[2023-09-08 16:27:14] Probing /cvmfs/atlas.cern.ch... OK
[2023-09-08 16:27:15] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-09-08 16:27:15] Running cvmfs_config stat atlas.cern.ch
[2023-09-08 16:27:15] 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-08 16:27:15] 2.11.0.0 56380 64 49300 123353 3 65 2109294 4194304 0 130560 0 224705 99.228 199427 1993 http://cernvmfs.gridpp.rl.ac.uk:8000/cvmfs/atlas.cern.ch DIRECT 1
[2023-09-08 16:27:15] CVMFS is ok
[2023-09-08 16:27:15] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2023-09-08 16:27:15] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2023-09-08 16:27:15] Small home clusters do not require a local http proxy but it is suggested if
[2023-09-08 16:27:15] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2023-09-08 16:27:15] Further information can be found at the LHC@home message board.
[2023-09-08 16:27:15] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-09-08 16:27:15] Checking for apptainer binary...
[2023-09-08 16:27:15] apptainer is not installed, using version from CVMFS
[2023-09-08 16:27:15] 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-08 16:27:16] dbgrensenh27vm
[2023-09-08 16:27:16] apptainer works
[2023-09-08 16:27:16] Set ATHENA_PROC_NUMBER=3
[2023-09-08 16:27:16] Set ATHENA_CORE_NUMBER=3
[2023-09-08 16:27:16] Starting ATLAS job with PandaID=5957598674
[2023-09-08 16:27:16] 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-08 17:03:55]  *** The last 200 lines of the pilot log: ***
[2023-09-08 17:03:55] 2023-09-08 15:02:53,356 | INFO     | maximum number of monitored processes: 8
[2023-09-08 17:03:55] 2023-09-08 15:02:55,885 | INFO     | monitor loop #271: job 0:5957598674 is in state 'stageout'
[2023-09-08 17:03:55] 2023-09-08 15:02:55,987 | INFO     | number of running child processes to parent process 113094: 1
[2023-09-08 17:03:55] 2023-09-08 15:02:55,988 | INFO     | maximum number of monitored processes: 8
[2023-09-08 17:03:55] 2023-09-08 15:02:58,497 | INFO     | monitor loop #272: job 0:5957598674 is in state 'stageout'
[2023-09-08 17:03:55] 2023-09-08 15:02:58,606 | INFO     | number of running child processes to parent process 113094: 1
[2023-09-08 17:03:55] 2023-09-08 15:02:58,607 | INFO     | maximum number of monitored processes: 8
[2023-09-08 17:03:55] 2023-09-08 15:03:01,144 | INFO     | monitor loop #273: job 0:5957598674 is in state 'stageout'
[2023-09-08 17:03:55] 2023-09-08 15:03:01,249 | INFO     | number of running child processes to parent process 113094: 1
[2023-09-08 17:03:55] 2023-09-08 15:03:01,249 | INFO     | maximum number of monitored processes: 8
[2023-09-08 17:03:55] 2023-09-08 15:03:01,530 | INFO     | [attempt=3/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-09-08 17:03:55] 2023-09-08 15:03:01,603 | 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-09-08 17:03:55] 2023-09-08 15:03:01,604 | 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-09-08 17:03:55] 2023-09-08 15:03:01,653 | INFO     | transferring file 296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log.tgz from /var/lib/boinc-client/slots/1/PanDA_Pilot-5957598674/296d0880-c3ae-4acc-a10d-9a6fb0
[2023-09-08 17:03:55] 2023-09-08 15:03:01,653 | INFO     | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/1/PanDA_Pilot-5957598674/296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log.tgz /var/lib/boinc-cli
[2023-09-08 17:03:55] 2023-09-08 15:03:01,727 | INFO     | Adding to output.list: 296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/99/eb/296d0880-c3ae-
[2023-09-08 17:03:55] 2023-09-08 15:03:01,728 | INFO     | summary of transferred files:
[2023-09-08 17:03:55] 2023-09-08 15:03:01,728 | INFO     |  -- lfn=296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log.tgz, status_code=0, status=transferred
[2023-09-08 17:03:55] 2023-09-08 15:03:01,728 | INFO     | stage-out finished correctly
[2023-09-08 17:03:55] 2023-09-08 15:03:01,796 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-09-08 17:03:55] 2023-09-08 15:03:03,132 | INFO     | job 5957598674 has state=finished
[2023-09-08 17:03:55] 2023-09-08 15:03:03,133 | INFO     | preparing for final server update for job 5957598674 in state='finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:03,133 | INFO     | this job has now completed (state=finished)
[2023-09-08 17:03:55] 2023-09-08 15:03:03,133 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2023-09-08 17:03:55] 2023-09-08 15:03:03,134 | INFO     | job 5957598674 has finished - writing final server update
[2023-09-08 17:03:55] 2023-09-08 15:03:03,135 | INFO     | fitting pss+swap vs Time
[2023-09-08 17:03:55] 2023-09-08 15:03:03,135 | INFO     | current memory leak: 952.91 B/s (using 17 data points, chi2=0.41)
[2023-09-08 17:03:55] 2023-09-08 15:03:03,135 | INFO     | total number of processed events: 2 (read)
[2023-09-08 17:03:55] 2023-09-08 15:03:03,141 | INFO     | executing command: lscpu
[2023-09-08 17:03:55] 2023-09-08 15:03:03,181 | INFO     | found 6 cores (6 cores per socket, 1 sockets)
[2023-09-08 17:03:55] 2023-09-08 15:03:03,182 | INFO     | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-09-08 17:03:55] 2023-09-08 15:03:03,243 | 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-08 17:03:55] 2023-09-08 15:03:03,751 | INFO     | monitor loop #274: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:03,751 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:06,259 | INFO     | monitor loop #275: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:06,261 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:08,769 | INFO     | monitor loop #276: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:08,770 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:11,277 | INFO     | monitor loop #277: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:11,277 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:13,778 | INFO     | monitor loop #278: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:13,778 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:16,280 | INFO     | monitor loop #279: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:16,280 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:18,787 | INFO     | monitor loop #280: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:18,787 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:21,300 | INFO     | monitor loop #281: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:21,301 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:23,807 | INFO     | monitor loop #282: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:23,807 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:26,315 | INFO     | monitor loop #283: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:26,315 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:28,827 | INFO     | monitor loop #284: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:28,827 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:31,336 | INFO     | monitor loop #285: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:31,337 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:32,240 | INFO     | 2155s have passed since pilot start
[2023-09-08 17:03:55] 2023-09-08 15:03:33,840 | INFO     | monitor loop #286: job 0:5957598674 is in state 'finished'
[2023-09-08 17:03:55] 2023-09-08 15:03:33,840 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-09-08 17:03:55] 2023-09-08 15:03:34,977 | INFO     | CPU arch script returned: x86-64-v2
[2023-09-08 17:03:55] 2023-09-08 15:03:34,977 | INFO     | using path: /var/lib/boinc-client/slots/1/PanDA_Pilot-5957598674/memory_monitor_summary.json (trf name=prmon)
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | extracted standard info from prmon json
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | extracted standard memory fields from prmon json
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | ..............................
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . Timing measurements:
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . get job = 67 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . initial setup = 71 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . payload setup = 42 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . stage-in = 69 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . payload execution = 1461 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | . stage-out = 380 s
[2023-09-08 17:03:55] 2023-09-08 15:03:34,978 | INFO     | ..............................
[2023-09-08 17:03:55] 2023-09-08 15:03:35,459 | INFO     | 
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | job summary report
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | --------------------------------------------------
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | PanDA job id: 5957598674
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | task id: NULL
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | errors: (none)
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | status: LOG_TRANSFER = DONE 
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | pilot state: finished 
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | transexitcode: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | exeerrorcode: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:35,460 | INFO     | exeerrordiag: 
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | exitcode: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | exitmsg: OK
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | cpuconsumptiontime: 1232 s
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | nevents: 2
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | neventsw: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | pid: 113094
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | pgrp: 113094
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | corecount: 3
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | event service: False
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | sizes: {0: 2490123, 1: 2490322, 11: 2490322, 22: 2490496, 33: 2490524, 43: 2490552, 54: 2490708, 64: 2490736, 75: 2490792, 82: 2490880, 86: 2490936, 1508: 2513216,
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | --------------------------------------------------
[2023-09-08 17:03:55] 2023-09-08 15:03:35,461 | INFO     | 
[2023-09-08 17:03:55] 2023-09-08 15:03:35,462 | INFO     | executing command: ls -lF /var/lib/boinc-client/slots/1
[2023-09-08 17:03:55] 2023-09-08 15:03:35,554 | INFO     | queue jobs had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue data_in had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue data_out had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue current_data_in had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,555 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,556 | INFO     | queue completed_jobids has 1 job(s)
[2023-09-08 17:03:55] 2023-09-08 15:03:35,556 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,556 | INFO     | queue messages had 0 job(s) [purged]
[2023-09-08 17:03:55] 2023-09-08 15:03:35,556 | INFO     | job 5957598674 has completed (purged errors)
[2023-09-08 17:03:55] 2023-09-08 15:03:35,556 | INFO     | overall cleanup function is called
[2023-09-08 17:03:55] 2023-09-08 15:03:36,587 | INFO     | --- collectZombieJob: --- 10, [113094]
[2023-09-08 17:03:55] 2023-09-08 15:03:36,589 | INFO     | zombie collector trying to kill pid 113094
[2023-09-08 17:03:55] 2023-09-08 15:03:36,589 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-09-08 17:03:55] 2023-09-08 15:03:37,600 | INFO     | collected zombie processes
[2023-09-08 17:03:55] 2023-09-08 15:03:37,601 | INFO     | will now attempt to kill all subprocesses of pid=113094
[2023-09-08 17:03:55] 2023-09-08 15:03:37,690 | INFO     | process IDs to be killed: [113094] (in reverse order)
[2023-09-08 17:03:55] 2023-09-08 15:03:37,784 | WARNING  | found no corresponding commands to process id(s)
[2023-09-08 17:03:55] 2023-09-08 15:03:37,784 | INFO     | Do not look for orphan processes in BOINC jobs
[2023-09-08 17:03:55] 2023-09-08 15:03:37,785 | INFO     | ready for new job
[2023-09-08 17:03:55] 2023-09-08 15:03:37,785 | INFO     | pilot has finished with previous job - re-establishing logging
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | *************************************
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | ***  PanDA Pilot version 3.6.4.7  ***
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | *************************************
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | 
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | pilot is running in a VM
[2023-09-08 17:03:55] 2023-09-08 15:03:37,786 | INFO     | architecture information:
[2023-09-08 17:03:55] 2023-09-08 15:03:37,788 | INFO     | executing command: cat /etc/os-release
[2023-09-08 17:03:55] 2023-09-08 15:03:37,817 | INFO     | cat /etc/os-release:
[2023-09-08 17:03:55] NAME="CentOS Linux"
[2023-09-08 17:03:55] VERSION="7 (Core)"
[2023-09-08 17:03:55] ID="centos"
[2023-09-08 17:03:55] ID_LIKE="rhel fedora"
[2023-09-08 17:03:55] VERSION_ID="7"
[2023-09-08 17:03:55] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-09-08 17:03:55] ANSI_COLOR="0;31"
[2023-09-08 17:03:55] CPE_NAME="cpe:/o:centos:centos:7"
[2023-09-08 17:03:55] HOME_URL="https://www.centos.org/"
[2023-09-08 17:03:55] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-09-08 17:03:55] 
[2023-09-08 17:03:55] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-09-08 17:03:55] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-09-08 17:03:55] REDHAT_SUPPORT_PRODUCT="centos"
[2023-09-08 17:03:55] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-09-08 17:03:55] 
[2023-09-08 17:03:55] 2023-09-08 15:03:37,817 | INFO     | *************************************
[2023-09-08 17:03:55] 2023-09-08 15:03:38,320 | INFO     | executing command: df -mP /var/lib/boinc-client/slots/1
[2023-09-08 17:03:55] 2023-09-08 15:03:38,359 | INFO     | sufficient remaining disk space (38103154688 B)
[2023-09-08 17:03:55] 2023-09-08 15:03:38,359 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2023-09-08 17:03:55] 2023-09-08 15:03:38,359 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-09-08 17:03:55] 2023-09-08 15:03:38,359 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2023-09-08 17:03:55] 2023-09-08 15:03:38,864 | WARNING  | job monitor detected an abort_job request (signal=None)
[2023-09-08 17:03:55] 2023-09-08 15:03:38,864 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2023-09-08 17:03:55] 2023-09-08 15:03:38,864 | INFO     | will abort loop
[2023-09-08 17:03:55] 2023-09-08 15:03:39,274 | INFO     | found 0 job(s) in 20 queues
[2023-09-08 17:03:55] 2023-09-08 15:03:39,275 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2023-09-08 17:03:55] 2023-09-08 15:03:39,275 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2023-09-08 17:03:55] 2023-09-08 15:03:39,372 | INFO     | [job] retrieve thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:39,468 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-09-08 17:03:55] 2023-09-08 15:03:39,880 | INFO     | [job] job monitor thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:39,900 | INFO     | [data] control thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:39,980 | INFO     | [payload] validate_post thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:39,995 | INFO     | [payload] execute_payloads thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,065 | INFO     | [payload] control thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,100 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2023-09-08 17:03:55] 2023-09-08 15:03:40,105 | INFO     | [job] validate thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,260 | INFO     | [job] control thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,379 | INFO     | [data] copytool_out thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,431 | INFO     | [payload] failed_post thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,471 | INFO     | [job] create_data_payload thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,483 | INFO     | [data] copytool_in thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:40,651 | INFO     | [payload] validate_pre thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:41,103 | INFO     | [job] queue monitor thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:43,516 | INFO     | [data] queue_monitor thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:48,840 | INFO     | job.realtimelogging is not enabled
[2023-09-08 17:03:55] 2023-09-08 15:03:49,845 | INFO     | [payload] run_realtimelog thread has finished
[2023-09-08 17:03:55] 2023-09-08 15:03:50,076 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140488570795840)>', '<ExcThread(monitor, started 140488136959744)>']
[2023-09-08 17:03:55] 2023-09-08 15:03:50,371 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2023-09-08 17:03:55] 2023-09-08 15:03:50,371 | INFO     | [monitor] control thread has ended
[2023-09-08 17:03:55] 2023-09-08 15:03:55,084 | INFO     | end of generic workflow (traces error code: 0)
[2023-09-08 17:03:55] 2023-09-08 15:03:55,084 | INFO     | traces error code: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:55,085 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2023-09-08 17:03:55] 2023-09-08 15:03:55,185 [wrapper] ==== pilot stdout END ====
[2023-09-08 17:03:55] 2023-09-08 15:03:55,200 [wrapper] ==== wrapper stdout RESUME ====
[2023-09-08 17:03:55] 2023-09-08 15:03:55,224 [wrapper] pilotpid: 105824
[2023-09-08 17:03:55] 2023-09-08 15:03:55,232 [wrapper] Pilot exit status: 0
[2023-09-08 17:03:55] 2023-09-08 15:03:55,284 [wrapper] pandaids: 5957598674
[2023-09-08 17:03:55] 2023-09-08 15:03:55,306 [wrapper] apfmon messages muted
[2023-09-08 17:03:55] 2023-09-08 15:03:55,316 [wrapper] Test setup, not cleaning
[2023-09-08 17:03:55] 2023-09-08 15:03:55,325 [wrapper] ==== wrapper stdout END ====
[2023-09-08 17:03:55] 2023-09-08 15:03:55,333 [wrapper] ==== wrapper stderr END ====
[2023-09-08 17:03:55] 2023-09-08 15:03:55,351 [wrapper] wrapperexiting ec=0, duration=2198
[2023-09-08 17:03:55] 2023-09-08 15:03:55,382 [wrapper] apfmon messages muted
[2023-09-08 17:03:55]  *** Error codes and diagnostics ***
[2023-09-08 17:03:55]     "exeErrorCode": 0,
[2023-09-08 17:03:55]     "exeErrorDiag": "",
[2023-09-08 17:03:55]     "pilotErrorCode": 0,
[2023-09-08 17:03:55]     "pilotErrorDiag": "",
[2023-09-08 17:03:55]  *** Listing of results directory ***
[2023-09-08 17:03:55] total 46540
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc   418016 sep  8 15:22 pilot3.tar.gz
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc     4388 sep  8 16:07 queuedata.json
[2023-09-08 17:03:55] -rwx------ 1 boinc boinc    27277 sep  8 16:07 runpilot2-wrapper.sh
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc      107 sep  8 16:27 wrapper_26015_x86_64-pc-linux-gnu
[2023-09-08 17:03:55] -rwxr-xr-x 1 boinc boinc     7986 sep  8 16:27 run_atlas
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc      112 sep  8 16:27 job.xml
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc    17604 sep  8 16:27 start_atlas.sh
[2023-09-08 17:03:55] drwxrwx--x 2 boinc boinc     4096 sep  8 16:27 shared
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc   428874 sep  8 16:27 input.tar.gz
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc     6833 sep  8 16:27 init_data.xml
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc 37595586 sep  8 16:27 EVNT.04972714._000034.pool.root.1
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc        0 sep  8 16:27 boinc_lockfile
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc     2758 sep  8 16:27 pandaJob.out
[2023-09-08 17:03:55] -rw------- 1 boinc boinc      424 sep  8 16:27 setup.sh.local
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  1389912 sep  8 16:28 cric_ddmendpoints.json
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  1023810 sep  8 16:28 agis_schedconf.cvmfs.json
[2023-09-08 17:03:55] drwx------ 4 boinc boinc     4096 sep  8 16:29 pilot3
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc      534 sep  8 16:56 boinc_task_state.xml
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  2859919 sep  8 16:56 output.1.296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.pool.root
[2023-09-08 17:03:55] -rw------- 1 boinc boinc     1006 sep  8 16:56 memory_monitor_summary.json
[2023-09-08 17:03:55] -rw------- 1 boinc boinc   165488 sep  8 17:00 296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log.tgz
[2023-09-08 17:03:55] -rw------- 1 boinc boinc     7811 sep  8 17:03 heartbeat.json
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc     8192 sep  8 17:03 boinc_mmap_file
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc       26 sep  8 17:03 wrapper_checkpoint.txt
[2023-09-08 17:03:55] -rw------- 1 boinc boinc     4133 sep  8 17:03 pilotlog.txt
[2023-09-08 17:03:55] -rw------- 1 boinc boinc   259661 sep  8 17:03 296d0880-c3ae-4acc-a10d-9a6fb0234dbd_31134.1.job.log
[2023-09-08 17:03:55] -rw------- 1 boinc boinc      464 sep  8 17:03 output.list
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc      748 sep  8 17:03 runtime_log
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  3307520 sep  8 17:03 result.tar.gz
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc    12125 sep  8 17:03 runtime_log.err
[2023-09-08 17:03:55] -rw------- 1 boinc boinc      637 sep  8 17:03 1PHNDm2Jry3n7Olcko1bjSoqABFKDmABFKDm7AsVDmNqQKDmeEEmBo.diag
[2023-09-08 17:03:55] -rw-r--r-- 1 boinc boinc    23254 sep  8 17:03 stderr.txt
[2023-09-08 17:03:55] HITS file was successfully produced:
[2023-09-08 17:03:55] -rw------- 1 boinc boinc 2859919 sep  8 16:56 shared/HITS.pool.root.1
[2023-09-08 17:03:55]  *** Contents of shared directory: ***
[2023-09-08 17:03:55] total 43184
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc    17604 sep  8 16:27 start_atlas.sh
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc   428874 sep  8 16:27 input.tar.gz
[2023-09-08 17:03:55] -rw-r--r-- 2 boinc boinc 37595586 sep  8 16:27 ATLAS.root_0
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  2859919 sep  8 16:56 HITS.pool.root.1
[2023-09-08 17:03:55] -rw------- 1 boinc boinc  3307520 sep  8 17:03 result.tar.gz
17:03:56 (102656): run_atlas exited; CPU time 1053.362995
17:03:56 (102656): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN