Name oLVLDmLHgV3n7Olcko1bjSoqABFKDmABFKDm7AsVDmtnLKDmPr0gxn_0
Workunit 2313437
Created 20 Jun 2023, 2:28:10 UTC
Sent 20 Jun 2023, 2:35:29 UTC
Report deadline 27 Jun 2023, 2:35:29 UTC
Received 20 Jun 2023, 3:03:36 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 1498
Run time 25 min 39 sec
CPU time 11 min 51 sec
Validate state Valid
Credit 18.77
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 84.00 MB

Stderr output

<core_client_version>7.4.25</core_client_version>
<![CDATA[
<stderr_txt>
03:36:45 (20573): wrapper (7.7.26015): starting
03:36:45 (20573): wrapper: running run_atlas (--nthreads 4)
[2023-06-20 03:36:45] Arguments: --nthreads 4
[2023-06-20 03:36:45] Threads: 4
[2023-06-20 03:36:45] Checking for CVMFS
[2023-06-20 03:36:47] Probing /cvmfs/atlas.cern.ch... OK
[2023-06-20 03:36:49] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-06-20 03:36:49] Running cvmfs_config stat atlas.cern.ch
[2023-06-20 03:36:49] 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 03:36:49] 2.9.0.0 20716 0 24880 120348 3 1 2623219 4194304 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 03:36:49] CVMFS is ok
[2023-06-20 03:36:49] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-06-20 03:36:49] Checking for apptainer binary...
[2023-06-20 03:36:49] Using apptainer found in PATH at /usr/bin/apptainer
[2023-06-20 03:36:49] Running /usr/bin/apptainer --version
[2023-06-20 03:36:49] apptainer version 1.0.3
[2023-06-20 03:36:49] 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 03:36:49] TeeC16
[2023-06-20 03:36:49] apptainer works
[2023-06-20 03:36:49] Set ATHENA_PROC_NUMBER=4
[2023-06-20 03:36:49] Set ATHENA_CORE_NUMBER=4
[2023-06-20 03:36:49] Starting ATLAS job with PandaID=5881581257
[2023-06-20 03:36:49] 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 04:02:21]  *** The last 200 lines of the pilot log: ***
[2023-06-20 04:02:21] 2023-06-20 03:02:03,107 | DEBUG    | pilot.user.atlas.utilities       | get_cpu_arch              | ec=2, stdout=************************************************************************
[2023-06-20 04:02:21] Requested:  cpu_flags ... 
[2023-06-20 04:02:21]  Setting up cpuflags 0.1.0 ... 
[2023-06-20 04:02:21] >>>>>>>>>>>>>>>>>>>>>>>>> Information for user <<<<<<<<<<<<<<<<<<<<<<<<<
[2023-06-20 04:02:21] ************************************************************************, stderr=usage: cpu_arch.py [-h] [--logpath LOGPATH] [--alg {x86,x86naive}] [-d]
[2023-06-20 04:02:21] cpu_arch.py: error: argument --alg: invalid choice: 'gcc' (choose from 'x86', 'x86naive')
[2023-06-20 04:02:21] 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,107 | INFO     | pilot.util.workernode            | get_cpu_arch              | no CPU architecture reporting
[2023-06-20 04:02:21] 2023-06-20 03:02:03,107 | INFO     | pilot.user.atlas.utilities       | get_memory_values         | using path: /home/m/BOINC/slots/3/PanDA_Pilot-5881581257/memory_monitor_summary.json (trf name=prmon
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | DEBUG    | pilot.user.atlas.utilities       | get_memory_monitor_info   | summary_dictionary={'Avg': {'nprocs': 5.0, 'nthreads': 5.933, 'pss': 1316622.0, 'rchar': 68383407.0,
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard info from prmon json
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard memory fields from prmon json
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.util.timing                | timing_report             | . Timing measurements:
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.util.timing                | timing_report             | . get job = 39 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,108 | INFO     | pilot.util.timing                | timing_report             | . initial setup = 43 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | INFO     | pilot.util.timing                | timing_report             | . payload setup = 44 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | INFO     | pilot.util.timing                | timing_report             | . stage-in = 84 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 900 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 354 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '5881581257', 'state': 'finished', 'timestamp': '2023-06-20T04:01:51+00:00', 'siteNam
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5881581257', 'state': 'finished', 'timestamp': '2023-06-20T04:01:51
[2023-06-20 04:02:21] 2023-06-20 03:02:03,109 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /home/m/BOINC/slots/3/heartbeat.json
[2023-06-20 04:02:21] 2023-06-20 03:02:03,110 | DEBUG    | pilot.control.job                | queue_monitor             | job.completed=False
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5881581257
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-06-20 04:02:21] 2023-06-20 03:02:03,169 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 724 s
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:03,170 | INFO     | pilot.control.job                | make_job_report           | pid: 31385
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | pgrp: 31385
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | corecount: 4
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2500187, 1: 2501122, 11: 2501268, 22: 2501296, 33: 2501324, 43: 2501352, 54: 2501508, 65:
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.control.job                | make_job_report           | 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /home/m/BOINC/slots/3:
[2023-06-20 04:02:21] 
[2023-06-20 04:02:21] 2023-06-20 03:02:03,171 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /home/m/BOINC/slots/3
[2023-06-20 04:02:21] 2023-06-20 03:02:03,191 | DEBUG    | pilot.control.job                | has_job_completed         | total 44852
[2023-06-20 04:02:21] -rw-r--r-- 2 m m 39611081 Jun 20 03:36 EVNT.04972714._000022.pool.root.1
[2023-06-20 04:02:21] drwxrwx--- 2 m m     4096 Jun 20 04:01 PanDA_Pilot-5881581257/
[2023-06-20 04:02:21] -rw------- 1 m m  1017084 Jun 20 03:37 agis_schedconf.cvmfs.json
[2023-06-20 04:02:21] -rw------- 1 m m   577855 Jun 20 04:02 be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.1.job.log
[2023-06-20 04:02:21] -rw------- 1 m m   180472 Jun 20 03:59 be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.1.job.log.tgz
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m        0 Jun 20 03:36 boinc_lockfile
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     8192 Jun 20 04:01 boinc_mmap_file
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      533 Jun 20 03:56 boinc_task_state.xml
[2023-06-20 04:02:21] -rw------- 1 m m  1399895 Jun 20 03:37 cric_ddmendpoints.json
[2023-06-20 04:02:21] -rw------- 1 m m     7349 Jun 20 04:02 heartbeat.json
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     5728 Jun 20 03:36 init_data.xml
[2023-06-20 04:02:21] -rw-r--r-- 2 m m   427191 Jun 20 03:36 input.tar.gz
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      112 Jun 20 03:36 job.xml
[2023-06-20 04:02:21] -rw------- 1 m m     1016 Jun 20 03:55 memory_monitor_summary.json
[2023-06-20 04:02:21] -rw------- 1 m m      129 Jun 20 03:36 oLVLDmLHgV3n7Olcko1bjSoqABFKDmABFKDm7AsVDmtnLKDmPr0gxn.diag
[2023-06-20 04:02:21] -rw------- 1 m m  1549093 Jun 20 03:55 output.1.be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.pool.root
[2023-06-20 04:02:21] -rw------- 1 m m      464 Jun 20 04:01 output.list
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     2666 Jun 20 03:36 pandaJob.out
[2023-06-20 04:02:21] drwx------ 4 m m     4096 Jun 20 03:38 pilot3/
[2023-06-20 04:02:21] -rw------- 1 m m   415467 Jun 20 03:28 pilot3.tar.gz
[2023-06-20 04:02:21] -rw------- 1 m m   564163 Jun 20 04:02 pilotlog.txt
[2023-06-20 04:02:21] -rw-r--r-- 1 m m     4388 Jun 20 03:27 queuedata.json
[2023-06-20 04:02:21] -rwxr-xr-x 1 m m     7986 Jun 20 03:36 run_atlas*
[2023-06-20 04:02:21] -rwx------ 1 m m    27010 Jun 20 03:28 runpilot2-wrapper.sh*
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      407 Jun 20 03:36 runtime_log
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     7699 Jun 20 03:36 runtime_log.err
[2023-06-20 04:02:21] -rw------- 1 m m      424 Jun 20 03:36 setup.sh.local
[2023-06-20 04:02:21] drwxrwx--x 2 m m     4096 Jun 20 03:36 shared/
[2023-06-20 04:02:21] -rw-r--r-- 2 m m    17632 Jun 20 03:36 start_atlas.sh
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     1716 Jun 20 03:36 stderr.txt
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      107 Jun 20 03:36 wrapper_26015_x86_64-pc-linux-gnu
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m       25 Jun 20 04:01 wrapper_checkpoint.txt
[2023-06-20 04:02:21] 2023-06-20 03:02:03,191 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,191 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,191 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,191 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,192 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,193 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-06-20 04:02:21] 2023-06-20 03:02:03,194 | INFO     | pilot.control.job                | has_job_completed         | job 5881581257 has completed (purged errors)
[2023-06-20 04:02:21] 2023-06-20 03:02:03,194 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-06-20 04:02:21] 2023-06-20 03:02:03,194 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-06-20 04:02:21] 2023-06-20 03:02:03,196 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /home/m/BOINC/slots/3/PanDA_Pilot-5881581257
[2023-06-20 04:02:21] 2023-06-20 03:02:04,201 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [31385]
[2023-06-20 04:02:21] 2023-06-20 03:02:04,201 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector trying to kill pid 31385
[2023-06-20 04:02:21] 2023-06-20 03:02:04,202 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-06-20 04:02:21] 2023-06-20 03:02:05,207 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-06-20 04:02:21] 2023-06-20 03:02:05,207 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=31385
[2023-06-20 04:02:21] 2023-06-20 03:02:05,250 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [31385] (in reverse order)
[2023-06-20 04:02:21] 2023-06-20 03:02:05,287 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-06-20 04:02:21] 2023-06-20 03:02:05,287 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-06-20 04:02:21] 2023-06-20 03:02:05,288 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-06-20 04:02:21] 2023-06-20 03:02:05,288 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-06-20 04:02:21] 2023-06-20 03:02:05,288 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-06-20 04:02:21] 2023-06-20 03:02:05,288 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-06-20 04:02:21] 2023-06-20 03:02:05,289 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.6.1 (21)  ***
[2023-06-20 04:02:21] 2023-06-20 03:02:05,289 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-06-20 04:02:21] 2023-06-20 03:02:05,289 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-06-20 04:02:21] 2023-06-20 03:02:05,307 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-06-20 04:02:21] 2023-06-20 03:02:05,308 | INFO     | pilot.util.container             | print_executable          | executing command: cat /etc/os-release
[2023-06-20 04:02:21] 2023-06-20 03:02:05,325 | INFO     | pilot.util.filehandling          | dump                      | cat /etc/os-release:
[2023-06-20 04:02:21] NAME="CentOS Linux"
[2023-06-20 04:02:21] VERSION="7 (Core)"
[2023-06-20 04:02:21] ID="centos"
[2023-06-20 04:02:21] ID_LIKE="rhel fedora"
[2023-06-20 04:02:21] VERSION_ID="7"
[2023-06-20 04:02:21] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-06-20 04:02:21] ANSI_COLOR="0;31"
[2023-06-20 04:02:21] CPE_NAME="cpe:/o:centos:centos:7"
[2023-06-20 04:02:21] HOME_URL="https://www.centos.org/"
[2023-06-20 04:02:21] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-06-20 04:02:21] 
[2023-06-20 04:02:21] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-06-20 04:02:21] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-06-20 04:02:21] REDHAT_SUPPORT_PRODUCT="centos"
[2023-06-20 04:02:21] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-06-20 04:02:21] 
[2023-06-20 04:02:21] 2023-06-20 03:02:05,326 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-06-20 04:02:21] 2023-06-20 03:02:05,829 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /home/m/BOINC/slots/3
[2023-06-20 04:02:21] 2023-06-20 03:02:05,829 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /home/m/BOINC/slots/3
[2023-06-20 04:02:21] 2023-06-20 03:02:05,848 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem     1048576-blocks  Used Available Capacity Mounted on
[2023-06-20 04:02:21] /dev/sda1              455417 27878    404383       7% /home/m/BOINC/slots/3
[2023-06-20 04:02:21] 2023-06-20 03:02:05,848 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-06-20 04:02:21] 2023-06-20 03:02:05,848 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (424026308608 B)
[2023-06-20 04:02:21] 2023-06-20 03:02:05,849 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-06-20 04:02:21] 2023-06-20 03:02:05,849 | WARNING  | pilot.control.job                | retrieve                  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-06-20 04:02:21] 2023-06-20 03:02:05,849 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:05,849 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-06-20 04:02:21] 2023-06-20 03:02:05,851 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-06-20 04:02:21] 2023-06-20 03:02:05,851 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:05,943 | WARNING  | pilot.util.common                | should_abort              | job:job_monitor:received graceful stop - abort after this iteration
[2023-06-20 04:02:21] 2023-06-20 03:02:05,943 | INFO     | pilot.control.job                | job_monitor               | aborting loop
[2023-06-20 04:02:21] 2023-06-20 03:02:05,943 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:05,969 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,446 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-06-20 04:02:21] 2023-06-20 03:02:06,446 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,473 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,481 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-06-20 04:02:21] 2023-06-20 03:02:06,482 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,605 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,713 | INFO     | pilot.util.queuehandling         | abort_jobs_in_queues      | found 0 job(s) in 20 queues
[2023-06-20 04:02:21] 2023-06-20 03:02:06,714 | WARNING  | pilot.control.monitor            | run_checks                | pilot monitor received instruction that args.graceful_stop has been set
[2023-06-20 04:02:21] 2023-06-20 03:02:06,714 | WARNING  | pilot.control.monitor            | run_checks                | will wait for a maximum of 300 s for threads to finish
[2023-06-20 04:02:21] 2023-06-20 03:02:06,798 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:06,850 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:07,179 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:07,270 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:07,298 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:08,179 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-06-20 04:02:21] 2023-06-20 03:02:08,180 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:09,128 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-06-20 04:02:21] 2023-06-20 03:02:12,128 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:15,972 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-06-20 04:02:21] 2023-06-20 03:02:15,972 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-06-20 04:02:21] 2023-06-20 03:02:15,972 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-06-20 04:02:21] 2023-06-20 03:02:15,972 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-06-20 04:02:21] 2023-06-20 03:02:16,765 | INFO     | pilot.util.processes             | threads_aborted           | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140348
[2023-06-20 04:02:21] 2023-06-20 03:02:16,765 | DEBUG    | pilot.workflow.generic           | run                       | will proceed to set job_aborted
[2023-06-20 04:02:21] 2023-06-20 03:02:17,769 | WARNING  | pilot.control.monitor            | run_checks                | job_aborted has been set - aborting pilot monitoring
[2023-06-20 04:02:21] 2023-06-20 03:02:17,770 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-06-20 04:02:21] 2023-06-20 03:02:21,777 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-06-20 04:02:21] 2023-06-20 03:02:21,777 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-06-20 04:02:21] 2023-06-20 03:02:21,778 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:21,778 | INFO     | root                             | wrap_up                   | pilot has finished (exit code=0, shell exit code=0)
[2023-06-20 04:02:21] 2023-06-20 03:02:21,830 [wrapper] ==== pilot stdout END ====
[2023-06-20 04:02:21] 2023-06-20 03:02:21,834 [wrapper] ==== wrapper stdout RESUME ====
[2023-06-20 04:02:21] 2023-06-20 03:02:21,838 [wrapper] pilotpid: 24169
[2023-06-20 04:02:21] 2023-06-20 03:02:21,843 [wrapper] Pilot exit status: 0
[2023-06-20 04:02:21] 2023-06-20 03:02:21,854 [wrapper] pandaids: 5881581257
[2023-06-20 04:02:21] 2023-06-20 03:02:21,861 [wrapper] apfmon messages muted
[2023-06-20 04:02:21] 2023-06-20 03:02:21,865 [wrapper] Test setup, not cleaning
[2023-06-20 04:02:21] 2023-06-20 03:02:21,869 [wrapper] ==== wrapper stdout END ====
[2023-06-20 04:02:21] 2023-06-20 03:02:21,874 [wrapper] ==== wrapper stderr END ====
[2023-06-20 04:02:21] 2023-06-20 03:02:21,883 [wrapper] wrapperexiting ec=0, duration=1532
[2023-06-20 04:02:21] 2023-06-20 03:02:21,888 [wrapper] apfmon messages muted
[2023-06-20 04:02:21]  *** Error codes and diagnostics ***
[2023-06-20 04:02:21]     "exeErrorCode": 0,
[2023-06-20 04:02:21]     "exeErrorDiag": "",
[2023-06-20 04:02:21]     "pilotErrorCode": 0,
[2023-06-20 04:02:21]     "pilotErrorDiag": "",
[2023-06-20 04:02:21]  *** Listing of results directory ***
[2023-06-20 04:02:21] total 46636
[2023-06-20 04:02:21] -rw-r--r-- 1 m m     4388 Jun 20 03:27 queuedata.json
[2023-06-20 04:02:21] -rwx------ 1 m m    27010 Jun 20 03:28 runpilot2-wrapper.sh
[2023-06-20 04:02:21] -rw------- 1 m m   415467 Jun 20 03:28 pilot3.tar.gz
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      107 Jun 20 03:36 wrapper_26015_x86_64-pc-linux-gnu
[2023-06-20 04:02:21] -rwxr-xr-x 1 m m     7986 Jun 20 03:36 run_atlas
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      112 Jun 20 03:36 job.xml
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     5728 Jun 20 03:36 init_data.xml
[2023-06-20 04:02:21] -rw-r--r-- 2 m m 39611081 Jun 20 03:36 EVNT.04972714._000022.pool.root.1
[2023-06-20 04:02:21] -rw-r--r-- 2 m m    17632 Jun 20 03:36 start_atlas.sh
[2023-06-20 04:02:21] drwxrwx--x 2 m m     4096 Jun 20 03:36 shared
[2023-06-20 04:02:21] -rw-r--r-- 2 m m   427191 Jun 20 03:36 input.tar.gz
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m        0 Jun 20 03:36 boinc_lockfile
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     2666 Jun 20 03:36 pandaJob.out
[2023-06-20 04:02:21] -rw------- 1 m m      424 Jun 20 03:36 setup.sh.local
[2023-06-20 04:02:21] -rw------- 1 m m  1017084 Jun 20 03:37 agis_schedconf.cvmfs.json
[2023-06-20 04:02:21] -rw------- 1 m m  1399895 Jun 20 03:37 cric_ddmendpoints.json
[2023-06-20 04:02:21] drwx------ 4 m m     4096 Jun 20 03:38 pilot3
[2023-06-20 04:02:21] -rw------- 1 m m  1549093 Jun 20 03:55 output.1.be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.pool.root
[2023-06-20 04:02:21] -rw------- 1 m m     1016 Jun 20 03:55 memory_monitor_summary.json
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      533 Jun 20 03:56 boinc_task_state.xml
[2023-06-20 04:02:21] -rw------- 1 m m   180472 Jun 20 03:59 be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.1.job.log.tgz
[2023-06-20 04:02:21] -rw------- 1 m m     7349 Jun 20 04:02 heartbeat.json
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m       25 Jun 20 04:02 wrapper_checkpoint.txt
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m     8192 Jun 20 04:02 boinc_mmap_file
[2023-06-20 04:02:21] -rw------- 1 m m     8223 Jun 20 04:02 pilotlog.txt
[2023-06-20 04:02:21] -rw------- 1 m m   593809 Jun 20 04:02 be88c164-3886-4a2a-9b24-dbb4ea7db5ed_35851.1.job.log
[2023-06-20 04:02:21] -rw------- 1 m m      464 Jun 20 04:02 output.list
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m      748 Jun 20 04:02 runtime_log
[2023-06-20 04:02:21] -rw------- 1 m m  2344960 Jun 20 04:02 result.tar.gz
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m    11913 Jun 20 04:02 runtime_log.err
[2023-06-20 04:02:21] -rw------- 1 m m      627 Jun 20 04:02 oLVLDmLHgV3n7Olcko1bjSoqABFKDmABFKDm7AsVDmtnLKDmPr0gxn.diag
[2023-06-20 04:02:21] -rw-rw-r-- 1 m m    28657 Jun 20 04:02 stderr.txt
[2023-06-20 04:02:22] HITS file was successfully produced:
[2023-06-20 04:02:22] -rw------- 1 m m 1549093 Jun 20 03:55 shared/HITS.pool.root.1
[2023-06-20 04:02:22]  *** Contents of shared directory: ***
[2023-06-20 04:02:22] total 42932
[2023-06-20 04:02:22] -rw-r--r-- 2 m m 39611081 Jun 20 03:36 ATLAS.root_0
[2023-06-20 04:02:22] -rw-r--r-- 2 m m    17632 Jun 20 03:36 start_atlas.sh
[2023-06-20 04:02:22] -rw-r--r-- 2 m m   427191 Jun 20 03:36 input.tar.gz
[2023-06-20 04:02:22] -rw------- 1 m m  1549093 Jun 20 03:55 HITS.pool.root.1
[2023-06-20 04:02:22] -rw------- 1 m m  2344960 Jun 20 04:02 result.tar.gz
04:02:23 (20573): run_atlas exited; CPU time 711.624230
04:02:23 (20573): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN