Name 0B9LDmRVqB4n7Olcko1bjSoqABFKDmABFKDm7AsVDmg0SKDmPDPtRo_0
Workunit 2338385
Created 14 Oct 2023, 9:52:56 UTC
Sent 14 Oct 2023, 9:54:52 UTC
Report deadline 21 Oct 2023, 9:54:52 UTC
Received 14 Oct 2023, 10:36:16 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4662
Run time 31 min 12 sec
CPU time 9 min 15 sec
Validate state Valid
Credit 22.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.57 GB
Peak swap size 18.95 GB
Peak disk usage 80.44 MB

Stderr output

<core_client_version>7.16.6</core_client_version>
<![CDATA[
<stderr_txt>
04:04:43 (2495757): wrapper (7.7.26015): starting
04:04:43 (2495757): wrapper: running run_atlas (--nthreads 1)
[2023-10-14 04:04:43] Arguments: --nthreads 1
[2023-10-14 04:04:43] Threads: 1
[2023-10-14 04:04:43] Checking for CVMFS
[2023-10-14 04:04:45] Probing /cvmfs/atlas.cern.ch... OK
[2023-10-14 04:04:47] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-10-14 04:04:47] Running cvmfs_config stat atlas.cern.ch
[2023-10-14 04:04:48] 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:04:48] 2.11.0.0 2495895 0 23268 124741 3 1 2969081 4096001 0 130560 0 0 0.000 960 740 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
[2023-10-14 04:04:48] CVMFS is ok
[2023-10-14 04:04:48] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2023-10-14 04:04:48] Small home clusters do not require a local http proxy but it is suggested if
[2023-10-14 04:04:48] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2023-10-14 04:04:48] Further information can be found at the LHC@home message board.
[2023-10-14 04:04:48] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-10-14 04:04:48] Checking for apptainer binary...
[2023-10-14 04:04:48] Using apptainer found in PATH at /usr/local/bin/apptainer
[2023-10-14 04:04:48] Running /usr/local/bin/apptainer --version
[2023-10-14 04:04:48] apptainer version 1.2.3+286-g3ac6f0cb6
[2023-10-14 04:04:48] 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:04:49] T5810
[2023-10-14 04:04:49] apptainer works
[2023-10-14 04:04:49] Starting ATLAS job with PandaID=5989776885
[2023-10-14 04:04:49] Running command: /usr/local/bin/apptainer exec -B /cvmfs,/var/lib/boinc-client/slots/17 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-10-14 04:35:53]  *** The last 200 lines of the pilot log: ***
[2023-10-14 04:35:53] 2023-10-14 10:34:52,140 | INFO     | [attempt=2/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-10-14 04:35:53] 2023-10-14 10:34:52,692 | 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:35:53] 2023-10-14 10:34:52,693 | INFO     | will try again after 32s..
[2023-10-14 04:35:53] 2023-10-14 10:34:54,494 | INFO     | monitor loop #263: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:34:54,494 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:34:56,996 | INFO     | monitor loop #264: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:34:56,996 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:34:59,499 | INFO     | monitor loop #265: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:34:59,499 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:02,002 | INFO     | monitor loop #266: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:02,002 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:04,504 | INFO     | monitor loop #267: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:04,504 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:07,007 | INFO     | monitor loop #268: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:07,008 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:09,508 | INFO     | monitor loop #269: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:09,508 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:12,011 | INFO     | monitor loop #270: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:12,012 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:14,512 | INFO     | monitor loop #271: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:14,512 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:17,015 | INFO     | monitor loop #272: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:17,016 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:19,516 | INFO     | monitor loop #273: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:19,516 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:22,019 | INFO     | monitor loop #274: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:22,020 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:24,520 | INFO     | monitor loop #275: job 0:5989776885 is in state 'stageout'
[2023-10-14 04:35:53] 2023-10-14 10:35:24,520 | WARNING  | aborting job monitor tasks since payload process 2513789 is not running
[2023-10-14 04:35:53] 2023-10-14 10:35:24,792 | INFO     | [attempt=3/3] loading data from url=https://atlas-cric.cern.ch/cache/ddmendpoints.json
[2023-10-14 04:35:53] 2023-10-14 10:35:25,768 | 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:35:53] 2023-10-14 10:35:25,768 | WARNING  | cache file=/var/lib/boinc-client/slots/17/agis_ddmendpoints.agis.ALL.json is not available: [Errno 2] No such file or directory: '/var/lib/boinc-client/slots/17/ag
[2023-10-14 04:35:53] 2023-10-14 10:35:25,818 | INFO     | transferring file 46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log.tgz from /var/lib/boinc-client/slots/17/PanDA_Pilot-5989776885/46d3fadc-f591-459d-b17c-47c72
[2023-10-14 04:35:53] 2023-10-14 10:35:25,818 | INFO     | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/17/PanDA_Pilot-5989776885/46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log.tgz /var/lib/boinc-cl
[2023-10-14 04:35:53] 2023-10-14 10:35:25,836 | INFO     | Adding to output.list: 46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log.tgz davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/hc_test/5b/9b/46d3fadc-f591-
[2023-10-14 04:35:53] 2023-10-14 10:35:25,836 | INFO     | summary of transferred files:
[2023-10-14 04:35:53] 2023-10-14 10:35:25,836 | INFO     |  -- lfn=46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log.tgz, status_code=0, status=transferred
[2023-10-14 04:35:53] 2023-10-14 10:35:25,836 | INFO     | stage-out finished correctly
[2023-10-14 04:35:53] 2023-10-14 10:35:25,919 | INFO     | finished stage-out for finished payload, adding job to finished_jobs queue
[2023-10-14 04:35:53] 2023-10-14 10:35:26,004 | INFO     | job 5989776885 has state=finished
[2023-10-14 04:35:53] 2023-10-14 10:35:26,004 | INFO     | preparing for final server update for job 5989776885 in state='finished'
[2023-10-14 04:35:53] 2023-10-14 10:35:26,005 | INFO     | this job has now completed (state=finished)
[2023-10-14 04:35:53] 2023-10-14 10:35:26,005 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2023-10-14 04:35:53] 2023-10-14 10:35:26,005 | INFO     | job 5989776885 has finished - writing final server update
[2023-10-14 04:35:53] 2023-10-14 10:35:26,005 | INFO     | total number of processed events: 2 (read)
[2023-10-14 04:35:53] 2023-10-14 10:35:26,029 | INFO     | executing command: lscpu
[2023-10-14 04:35:53] 2023-10-14 10:35:26,068 | INFO     | found 14 cores (14 cores per socket, 1 sockets)
[2023-10-14 04:35:53] 2023-10-14 10:35:26,068 | INFO     | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-10-14 04:35:53] 2023-10-14 10:35:26,110 | 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:35:53] 2023-10-14 10:35:27,023 | INFO     | monitor loop #276: job 0:5989776885 is in state 'finished'
[2023-10-14 04:35:53] 2023-10-14 10:35:27,024 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:35:53] 2023-10-14 10:35:29,526 | INFO     | monitor loop #277: job 0:5989776885 is in state 'finished'
[2023-10-14 04:35:53] 2023-10-14 10:35:29,526 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,028 | INFO     | monitor loop #278: job 0:5989776885 is in state 'finished'
[2023-10-14 04:35:53] 2023-10-14 10:35:32,028 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,733 | INFO     | CPU arch script returned: x86-64-v3
[2023-10-14 04:35:53] 2023-10-14 10:35:32,733 | INFO     | using path: /var/lib/boinc-client/slots/17/PanDA_Pilot-5989776885/memory_monitor_summary.json (trf name=prmon)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,734 | INFO     | extracted standard info from prmon json
[2023-10-14 04:35:53] 2023-10-14 10:35:32,734 | INFO     | extracted standard memory fields from prmon json
[2023-10-14 04:35:53] 2023-10-14 10:35:32,735 | INFO     | fitting pss+swap vs Time
[2023-10-14 04:35:53] 2023-10-14 10:35:32,735 | INFO     | current memory leak: 1317.50 B/s (using 12 data points, chi2=0.09)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,740 | INFO     | ..............................
[2023-10-14 04:35:53] 2023-10-14 10:35:32,740 | INFO     | . Timing measurements:
[2023-10-14 04:35:53] 2023-10-14 10:35:32,740 | INFO     | . get job = 71 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,740 | INFO     | . initial setup = 66 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | . payload setup = 12 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | . stage-in = 49 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | . payload execution = 1160 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | . stage-out = 432 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | . log creation = 0 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,741 | INFO     | ..............................
[2023-10-14 04:35:53] 2023-10-14 10:35:32,944 | INFO     | 
[2023-10-14 04:35:53] 2023-10-14 10:35:32,944 | INFO     | job summary report
[2023-10-14 04:35:53] 2023-10-14 10:35:32,944 | INFO     | --------------------------------------------------
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | PanDA job id: 5989776885
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | task id: NULL
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | errors: (none)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | status: LOG_TRANSFER = DONE 
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | pilot state: finished 
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | transexitcode: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | exeerrorcode: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | exeerrordiag: 
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | exitcode: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | exitmsg: OK
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | cpuconsumptiontime: 555 s
[2023-10-14 04:35:53] 2023-10-14 10:35:32,945 | INFO     | nevents: 2
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | neventsw: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | pid: 2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | pgrp: 2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | corecount: 1
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | event service: False
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | sizes: {0: 2436088, 1: 2436088, 11: 2436262, 22: 2436290, 33: 2436318, 43: 2436346, 54: 2436502, 56: 2436590, 65: 2436618, 1176: 2458925, 1608: 2468327, 1615: 2468
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | --------------------------------------------------
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | 
[2023-10-14 04:35:53] 2023-10-14 10:35:32,946 | INFO     | executing command: ls -lF /var/lib/boinc-client/slots/17
[2023-10-14 04:35:53] 2023-10-14 10:35:32,980 | INFO     | queue jobs had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue data_in had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue data_out had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue current_data_in had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,981 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue completed_jobids has 1 job(s)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | queue messages had 0 job(s) [purged]
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | job 5989776885 has completed (purged errors)
[2023-10-14 04:35:53] 2023-10-14 10:35:32,982 | INFO     | overall cleanup function is called
[2023-10-14 04:35:53] 2023-10-14 10:35:33,992 | INFO     | --- collectZombieJob: --- 10, [2513789]
[2023-10-14 04:35:53] 2023-10-14 10:35:33,992 | INFO     | zombie collector waiting for pid 2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:33,993 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-10-14 04:35:53] 2023-10-14 10:35:34,996 | INFO     | collected zombie processes
[2023-10-14 04:35:53] 2023-10-14 10:35:34,996 | INFO     | will now attempt to kill all subprocesses of pid=2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:35,063 | INFO     | process IDs to be killed: [2513789] (in reverse order)
[2023-10-14 04:35:53] 2023-10-14 10:35:35,115 | WARNING  | found no corresponding commands to process id(s)
[2023-10-14 04:35:53] 2023-10-14 10:35:35,115 | INFO     | Do not look for orphan processes in BOINC jobs
[2023-10-14 04:35:53] 2023-10-14 10:35:35,119 | INFO     | did not find any defunct processes belonging to 2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:35,122 | INFO     | did not find any defunct processes belonging to 2513789
[2023-10-14 04:35:53] 2023-10-14 10:35:35,122 | INFO     | ready for new job
[2023-10-14 04:35:53] 2023-10-14 10:35:35,122 | INFO     | pilot has finished with previous job - re-establishing logging
[2023-10-14 04:35:53] 2023-10-14 10:35:35,123 | INFO     | **************************************
[2023-10-14 04:35:53] 2023-10-14 10:35:35,123 | INFO     | ***  PanDA Pilot version 3.6.9.10  ***
[2023-10-14 04:35:53] 2023-10-14 10:35:35,123 | INFO     | **************************************
[2023-10-14 04:35:53] 2023-10-14 10:35:35,123 | INFO     | 
[2023-10-14 04:35:53] 2023-10-14 10:35:35,141 | INFO     | architecture information:
[2023-10-14 04:35:53] 2023-10-14 10:35:35,141 | INFO     | executing command: cat /etc/os-release
[2023-10-14 04:35:53] 2023-10-14 10:35:35,151 | INFO     | cat /etc/os-release:
[2023-10-14 04:35:53] NAME="CentOS Linux"
[2023-10-14 04:35:53] VERSION="7 (Core)"
[2023-10-14 04:35:53] ID="centos"
[2023-10-14 04:35:53] ID_LIKE="rhel fedora"
[2023-10-14 04:35:53] VERSION_ID="7"
[2023-10-14 04:35:53] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-10-14 04:35:53] ANSI_COLOR="0;31"
[2023-10-14 04:35:53] CPE_NAME="cpe:/o:centos:centos:7"
[2023-10-14 04:35:53] HOME_URL="https://www.centos.org/"
[2023-10-14 04:35:53] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-10-14 04:35:53] 
[2023-10-14 04:35:53] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-10-14 04:35:53] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-10-14 04:35:53] REDHAT_SUPPORT_PRODUCT="centos"
[2023-10-14 04:35:53] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-10-14 04:35:53] 
[2023-10-14 04:35:53] 2023-10-14 10:35:35,151 | INFO     | **************************************
[2023-10-14 04:35:53] 2023-10-14 10:35:35,652 | INFO     | executing command: df -mP /var/lib/boinc-client/slots/17
[2023-10-14 04:35:53] 2023-10-14 10:35:35,677 | INFO     | sufficient remaining disk space (211331055616 B)
[2023-10-14 04:35:53] 2023-10-14 10:35:35,677 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2023-10-14 04:35:53] 2023-10-14 10:35:35,677 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-10-14 04:35:53] 2023-10-14 10:35:35,677 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2023-10-14 04:35:53] 2023-10-14 10:35:35,677 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2023-10-14 04:35:53] 2023-10-14 10:35:35,678 | INFO     | found 0 job(s) in 20 queues
[2023-10-14 04:35:53] 2023-10-14 10:35:35,678 | INFO     | aborting loop
[2023-10-14 04:35:53] 2023-10-14 10:35:35,678 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2023-10-14 04:35:53] 2023-10-14 10:35:35,678 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2023-10-14 04:35:53] 2023-10-14 10:35:36,428 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2023-10-14 04:35:53] 2023-10-14 10:35:36,508 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-10-14 04:35:53] 2023-10-14 10:35:36,680 | INFO     | [job] retrieve thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:36,681 | INFO     | [job] job monitor thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:36,696 | INFO     | [payload] validate_post thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:36,812 | INFO     | [data] control thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,048 | INFO     | [job] validate thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,084 | INFO     | [payload] control thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,264 | INFO     | [job] create_data_payload thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,448 | INFO     | [payload] validate_pre thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,492 | INFO     | [payload] execute_payloads thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,496 | INFO     | [data] copytool_in thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,692 | INFO     | [payload] failed_post thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,744 | INFO     | [job] control thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:37,836 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2023-10-14 04:35:53] 2023-10-14 10:35:38,432 | INFO     | [data] copytool_out thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:38,840 | INFO     | [job] queue monitor thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:40,512 | INFO     | [data] queue_monitor thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:46,612 | INFO     | job.realtimelogging is not enabled
[2023-10-14 04:35:53] 2023-10-14 10:35:47,616 | INFO     | [payload] run_realtimelog thread has finished
[2023-10-14 04:35:53] 2023-10-14 10:35:48,244 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139650616223552)>', '<ExcThread(monitor, started 139650056320768)>']
[2023-10-14 04:35:53] 2023-10-14 10:35:48,728 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2023-10-14 04:35:53] 2023-10-14 10:35:48,728 | INFO     | [monitor] control thread has ended
[2023-10-14 04:35:53] 2023-10-14 10:35:53,268 | INFO     | end of generic workflow (traces error code: 0)
[2023-10-14 04:35:53] 2023-10-14 10:35:53,269 | INFO     | traces error code: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:53,269 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2023-10-14 04:35:53] 2023-10-14 10:35:53,323 [wrapper] ==== pilot stdout END ====
[2023-10-14 04:35:53] 2023-10-14 10:35:53,324 [wrapper] ==== wrapper stdout RESUME ====
[2023-10-14 04:35:53] 2023-10-14 10:35:53,326 [wrapper] pilotpid: 2499987
[2023-10-14 04:35:53] 2023-10-14 10:35:53,328 [wrapper] Pilot exit status: 0
[2023-10-14 04:35:53] 2023-10-14 10:35:53,345 [wrapper] pandaids: 5989776885
[2023-10-14 04:35:53] 2023-10-14 10:35:53,359 [wrapper] apfmon messages muted
[2023-10-14 04:35:53] 2023-10-14 10:35:53,361 [wrapper] Test setup, not cleaning
[2023-10-14 04:35:53] 2023-10-14 10:35:53,362 [wrapper] ==== wrapper stdout END ====
[2023-10-14 04:35:53] 2023-10-14 10:35:53,370 [wrapper] ==== wrapper stderr END ====
[2023-10-14 04:35:53] 2023-10-14 10:35:53,384 [wrapper] wrapperexiting ec=0, duration=1864
[2023-10-14 04:35:53] 2023-10-14 10:35:53,386 [wrapper] apfmon messages muted
[2023-10-14 04:35:53]  *** Error codes and diagnostics ***
[2023-10-14 04:35:53]     "exeErrorCode": 0,
[2023-10-14 04:35:53]     "exeErrorDiag": "",
[2023-10-14 04:35:53]     "pilotErrorCode": 0,
[2023-10-14 04:35:53]     "pilotErrorDiag": "",
[2023-10-14 04:35:53]  *** Listing of results directory ***
[2023-10-14 04:35:53] total 43160
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc   433413 Oct 14 03:39 pilot3.tar.gz
[2023-10-14 04:35:53] -rwx------ 1 boinc boinc    27439 Oct 14 03:52 runpilot2-wrapper.sh
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc     4388 Oct 14 03:52 queuedata.json
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc      107 Oct 14 04:04 wrapper_26015_x86_64-pc-linux-gnu
[2023-10-14 04:35:53] -rwxr-xr-x 1 boinc boinc     7986 Oct 14 04:04 run_atlas
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc      112 Oct 14 04:04 job.xml
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc    17604 Oct 14 04:04 start_atlas.sh
[2023-10-14 04:35:53] drwxrwx--x 2 boinc boinc     4096 Oct 14 04:04 shared
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc   444664 Oct 14 04:04 input.tar.gz
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc     9119 Oct 14 04:04 init_data.xml
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc 37498453 Oct 14 04:04 EVNT.04972714._000025.pool.root.1
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc        0 Oct 14 04:04 boinc_lockfile
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc     2752 Oct 14 04:04 pandaJob.out
[2023-10-14 04:35:53] -rw------- 1 boinc boinc      424 Oct 14 04:04 setup.sh.local
[2023-10-14 04:35:53] -rw------- 1 boinc boinc  1361563 Oct 14 04:06 cric_ddmendpoints.json
[2023-10-14 04:35:53] -rw------- 1 boinc boinc   993176 Oct 14 04:06 agis_schedconf.cvmfs.json
[2023-10-14 04:35:53] drwx------ 4 boinc boinc     4096 Oct 14 04:07 pilot3
[2023-10-14 04:35:53] -rw------- 1 boinc boinc  1239585 Oct 14 04:28 output.1.46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.pool.root
[2023-10-14 04:35:53] -rw------- 1 boinc boinc     1023 Oct 14 04:28 memory_monitor_summary.json
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc      534 Oct 14 04:28 boinc_task_state.xml
[2023-10-14 04:35:53] -rw------- 1 boinc boinc   161597 Oct 14 04:31 46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log.tgz
[2023-10-14 04:35:53] -rw------- 1 boinc boinc     8480 Oct 14 04:35 heartbeat.json
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc     8192 Oct 14 04:35 boinc_mmap_file
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc       25 Oct 14 04:35 wrapper_checkpoint.txt
[2023-10-14 04:35:53] -rw------- 1 boinc boinc     4105 Oct 14 04:35 pilotlog.txt
[2023-10-14 04:35:53] -rw------- 1 boinc boinc   213657 Oct 14 04:35 46d3fadc-f591-459d-b17c-47c723eb0fe1_79571.1.job.log
[2023-10-14 04:35:53] -rw------- 1 boinc boinc      464 Oct 14 04:35 output.list
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc      748 Oct 14 04:35 runtime_log
[2023-10-14 04:35:53] -rw------- 1 boinc boinc  1638400 Oct 14 04:35 result.tar.gz
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc    11958 Oct 14 04:35 runtime_log.err
[2023-10-14 04:35:53] -rw------- 1 boinc boinc      631 Oct 14 04:35 0B9LDmRVqB4n7Olcko1bjSoqABFKDmABFKDm7AsVDmg0SKDmPDPtRo.diag
[2023-10-14 04:35:53] -rw-r--r-- 1 boinc boinc    23227 Oct 14 04:35 stderr.txt
[2023-10-14 04:35:53] HITS file was successfully produced:
[2023-10-14 04:35:53] -rw------- 1 boinc boinc 1239585 Oct 14 04:28 shared/HITS.pool.root.1
[2023-10-14 04:35:53]  *** Contents of shared directory: ***
[2023-10-14 04:35:53] total 39888
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc    17604 Oct 14 04:04 start_atlas.sh
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc   444664 Oct 14 04:04 input.tar.gz
[2023-10-14 04:35:53] -rw-r--r-- 2 boinc boinc 37498453 Oct 14 04:04 ATLAS.root_0
[2023-10-14 04:35:53] -rw------- 1 boinc boinc  1239585 Oct 14 04:28 HITS.pool.root.1
[2023-10-14 04:35:53] -rw------- 1 boinc boinc  1638400 Oct 14 04:35 result.tar.gz
04:35:54 (2495757): run_atlas exited; CPU time 555.966071
04:35:54 (2495757): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN