Name 3Y9KDmq70d4n7Olcko1bjSoqABFKDmABFKDmyeZQDmqgIKDm2kwyln_0
Workunit 2373104
Created 31 Dec 2023, 2:53:05 UTC
Sent 31 Dec 2023, 2:54:39 UTC
Report deadline 7 Jan 2024, 2:54:39 UTC
Received 31 Dec 2023, 3:23:21 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4008
Run time 25 min 53 sec
CPU time 20 min 28 sec
Validate state Valid
Credit 18.95
Device peak FLOPS 3.12 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.45 GB
Peak swap size 2.14 GB
Peak disk usage 84.12 MB

Stderr output

<core_client_version>7.16.1</core_client_version>
<![CDATA[
<stderr_txt>
03:57:18 (19731): wrapper (7.7.26015): starting
03:57:18 (19731): wrapper: running run_atlas (--nthreads 1)
[2023-12-31 03:57:18] Arguments: --nthreads 1
[2023-12-31 03:57:18] Threads: 1
[2023-12-31 03:57:18] Checking for CVMFS
[2023-12-31 03:57:20] Probing /cvmfs/atlas.cern.ch... OK
[2023-12-31 03:57:21] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-12-31 03:57:21] Running cvmfs_config stat atlas.cern.ch
[2023-12-31 03:57:21] 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-12-31 03:57:21] 2.6.3.0 19975 0 28296 127636 3 1 2678515 2816000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://10.116.178.201:3128 1
[2023-12-31 03:57:21] CVMFS is ok
[2023-12-31 03:57:21] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-12-31 03:57:21] Checking for apptainer binary...
[2023-12-31 03:57:21] which: no apptainer in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin)
[2023-12-31 03:57:21] apptainer is not installed, using version from CVMFS
[2023-12-31 03:57:21] 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-12-31 03:57:22] HPi7COS7
[2023-12-31 03:57:22] apptainer works
[2023-12-31 03:57:22] Starting ATLAS job with PandaID=6065583230
[2023-12-31 03:57:22] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-12-31 04:23:09]  *** The last 200 lines of the pilot log: ***
[2023-12-31 04:23:09] 2023-12-31 03:22:46,950 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '6065583230', 'state': 'finished', 'timestamp': '2023-12-31T04:22:34+01:00', 'siteNam
[2023-12-31 04:23:09] 2023-12-31 03:22:46,952 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '6065583230', 'state': 'finished', 'timestamp': '2023-12-31T04:22:34
[2023-12-31 04:23:09] 2023-12-31 03:22:46,953 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc/slots/0/heartbeat.json
[2023-12-31 04:23:09] 2023-12-31 03:22:46,954 | DEBUG    | pilot.control.job                | queue_monitor             | job.completed=False
[2023-12-31 04:23:09] 2023-12-31 03:22:47,106 | INFO     | pilot.control.job                | make_job_report           | 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,107 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-12-31 04:23:09] 2023-12-31 03:22:47,107 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-12-31 04:23:09] 2023-12-31 03:22:47,107 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 6065583230
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-12-31 04:23:09] 2023-12-31 03:22:47,108 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 1295 s
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-12-31 04:23:09] 2023-12-31 03:22:47,109 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-12-31 04:23:09] 2023-12-31 03:22:47,110 | INFO     | pilot.control.job                | make_job_report           | pid: 30893
[2023-12-31 04:23:09] 2023-12-31 03:22:47,110 | INFO     | pilot.control.job                | make_job_report           | pgrp: 30893
[2023-12-31 04:23:09] 2023-12-31 03:22:47,110 | INFO     | pilot.control.job                | make_job_report           | corecount: 1
[2023-12-31 04:23:09] 2023-12-31 03:22:47,110 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-12-31 04:23:09] 2023-12-31 03:22:47,110 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2399197, 1: 2399197, 9: 2399431, 12: 2399459, 1465: 2422352, 1468: 2431586, 1481: 2431752
[2023-12-31 04:23:09] 2023-12-31 03:22:47,111 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-12-31 04:23:09] 2023-12-31 03:22:47,111 | INFO     | pilot.control.job                | make_job_report           | 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,111 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc/slots/0:
[2023-12-31 04:23:09] 
[2023-12-31 04:23:09] 2023-12-31 03:22:47,111 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc/slots/0
[2023-12-31 04:23:09] 2023-12-31 03:22:47,141 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout 864000 s
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | DEBUG    | pilot.control.job                | has_job_completed         | total 44140
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      131 Dec 31 03:57 3Y9KDmq70d4n7Olcko1bjSoqABFKDmABFKDmyeZQDmqgIKDm2kwyln.diag
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc 37965264 Dec 31 03:57 EVNT.04972714._000027.pool.root.1
[2023-12-31 04:23:09] drwxrwx---. 2 boinc boinc     4096 Dec 31 04:22 PanDA_Pilot-6065583230/
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc        0 Dec 31 03:57 agis_ddmendpoints.agis.ALL.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   983529 Dec 31 03:57 agis_schedconf.cvmfs.json
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc        0 Dec 31 03:57 boinc_lockfile
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     8192 Dec 31 04:22 boinc_mmap_file
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      534 Dec 31 04:22 boinc_task_state.xml
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   677350 Dec 31 04:22 c6dba656-c93f-4e70-acc3-3a222425f730_27573.1.job.log
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   195848 Dec 31 04:22 c6dba656-c93f-4e70-acc3-3a222425f730_27573.1.job.log.tgz
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  1338505 Dec 31 03:57 cric_ddmendpoints.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc     8793 Dec 31 04:22 heartbeat.json
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     6046 Dec 31 03:57 init_data.xml
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc   488883 Dec 31 03:57 input.tar.gz
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      112 Dec 31 03:57 job.xml
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc     1021 Dec 31 04:22 memory_monitor_summary.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  1808603 Dec 31 04:22 output.1.c6dba656-c93f-4e70-acc3-3a222425f730_27573.pool.root
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      464 Dec 31 04:22 output.list
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     2663 Dec 31 03:57 pandaJob.out
[2023-12-31 04:23:09] drwx------. 5 boinc boinc     4096 Dec 31 03:57 pilot3/
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   477391 Dec 31 03:52 pilot3.tar.gz
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc       47 Dec 31 03:57 pilot_heartbeat.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   647773 Dec 31 04:22 pilotlog.txt
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     4388 Dec 31 03:52 queuedata.json
[2023-12-31 04:23:09] -rwxr-xr-x. 1 boinc boinc     7986 Dec 31 03:57 run_atlas*
[2023-12-31 04:23:09] -rwx------. 1 boinc boinc    27437 Dec 31 03:52 runpilot2-wrapper.sh*
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      407 Dec 31 03:57 runtime_log
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     7733 Dec 31 03:57 runtime_log.err
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      424 Dec 31 03:57 setup.sh.local
[2023-12-31 04:23:09] drwxrwx--x. 2 boinc boinc       68 Dec 31 03:57 shared/
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc    17646 Dec 31 03:57 start_atlas.sh
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     1740 Dec 31 03:57 stderr.txt
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      107 Dec 31 03:57 wrapper_26015_x86_64-pc-linux-gnu
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc       26 Dec 31 04:22 wrapper_checkpoint.txt
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,167 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,168 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-12-31 04:23:09] 2023-12-31 03:22:47,169 | INFO     | pilot.control.job                | has_job_completed         | job 6065583230 has completed (purged errors)
[2023-12-31 04:23:09] 2023-12-31 03:22:47,170 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-12-31 04:23:09] 2023-12-31 03:22:47,170 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-12-31 04:23:09] 2023-12-31 03:22:47,172 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc/slots/0/PanDA_Pilot-6065583230
[2023-12-31 04:23:09] 2023-12-31 03:22:47,338 | WARNING  | pilot.control.monitor            | run_checks                | too much time has passed since last successful pilot heartbeat (1504.5352959632874 s) - must update 
[2023-12-31 04:23:09] 2023-12-31 03:22:48,221 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [30893]
[2023-12-31 04:23:09] 2023-12-31 03:22:48,221 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector waiting for pid 30893
[2023-12-31 04:23:09] 2023-12-31 03:22:48,221 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-12-31 04:23:09] 2023-12-31 03:22:49,238 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-12-31 04:23:09] 2023-12-31 03:22:49,239 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=30893
[2023-12-31 04:23:09] 2023-12-31 03:22:49,269 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout 864000 s
[2023-12-31 04:23:09] 2023-12-31 03:22:49,347 | WARNING  | pilot.control.monitor            | run_checks                | too much time has passed since last successful pilot heartbeat (1506.5437030792236 s) - must update 
[2023-12-31 04:23:09] 2023-12-31 03:22:49,350 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [30893] (in reverse order)
[2023-12-31 04:23:09] 2023-12-31 03:22:49,366 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout 864000 s
[2023-12-31 04:23:09] 2023-12-31 03:22:49,440 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-12-31 04:23:09] 2023-12-31 03:22:49,440 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-12-31 04:23:09] 2023-12-31 03:22:49,444 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 30893
[2023-12-31 04:23:09] 2023-12-31 03:22:49,447 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 30893
[2023-12-31 04:23:09] 2023-12-31 03:22:49,447 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-12-31 04:23:09] 2023-12-31 03:22:49,447 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-12-31 04:23:09] 2023-12-31 03:22:49,447 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-12-31 04:23:09] 2023-12-31 03:22:49,449 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-12-31 04:23:09] 2023-12-31 03:22:49,449 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.7.1.22  ***
[2023-12-31 04:23:09] 2023-12-31 03:22:49,449 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-12-31 04:23:09] 2023-12-31 03:22:49,449 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-12-31 04:23:09] 2023-12-31 03:22:49,449 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2023-12-31 04:23:09] 2023-12-31 03:22:49,450 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-12-31 04:23:09] 2023-12-31 03:22:49,450 | INFO     | pilot.util.container             | print_executable          | executing command: cat /etc/os-release
[2023-12-31 04:23:09] 2023-12-31 03:22:49,461 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout 864000 s
[2023-12-31 04:23:09] 2023-12-31 03:22:49,476 | INFO     | pilot.util.filehandling          | dump                      | cat /etc/os-release:
[2023-12-31 04:23:09] NAME="CentOS Linux"
[2023-12-31 04:23:09] VERSION="7 (Core)"
[2023-12-31 04:23:09] ID="centos"
[2023-12-31 04:23:09] ID_LIKE="rhel fedora"
[2023-12-31 04:23:09] VERSION_ID="7"
[2023-12-31 04:23:09] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-12-31 04:23:09] ANSI_COLOR="0;31"
[2023-12-31 04:23:09] CPE_NAME="cpe:/o:centos:centos:7"
[2023-12-31 04:23:09] HOME_URL="https://www.centos.org/"
[2023-12-31 04:23:09] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-12-31 04:23:09] 
[2023-12-31 04:23:09] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-12-31 04:23:09] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-12-31 04:23:09] REDHAT_SUPPORT_PRODUCT="centos"
[2023-12-31 04:23:09] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-12-31 04:23:09] 
[2023-12-31 04:23:09] 2023-12-31 03:22:49,477 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-12-31 04:23:09] 2023-12-31 03:22:49,978 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc/slots/0
[2023-12-31 04:23:09] 2023-12-31 03:22:49,979 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc/slots/0
[2023-12-31 04:23:09] 2023-12-31 03:22:50,010 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout 864000 s
[2023-12-31 04:23:09] 2023-12-31 03:22:50,035 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem              1048576-blocks  Used Available Capacity Mounted on
[2023-12-31 04:23:09] /dev/mapper/centos-root          22002 12211      9792      56% /var/lib/boinc/slots/0
[2023-12-31 04:23:09] 2023-12-31 03:22:50,035 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-12-31 04:23:09] 2023-12-31 03:22:50,036 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (10267656192 B)
[2023-12-31 04:23:09] 2023-12-31 03:22:50,036 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-12-31 04:23:09] 2023-12-31 03:22:50,036 | WARNING  | pilot.control.job                | retrieve                  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-12-31 04:23:09] 2023-12-31 03:22:50,037 | WARNING  | pilot.util.common                | should_abort              | job:job_monitor:received graceful stop - abort after this iteration
[2023-12-31 04:23:09] 2023-12-31 03:22:50,037 | INFO     | pilot.control.job                | job_monitor               | aborting loop
[2023-12-31 04:23:09] 2023-12-31 03:22:50,037 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-12-31 04:23:09] 2023-12-31 03:22:50,037 | WARNING  | pilot.control.monitor            | control                   | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2023-12-31 04:23:09] 2023-12-31 03:22:50,037 | WARNING  | pilot.control.monitor            | run_checks                | too much time has passed since last successful pilot heartbeat (1507.2342841625214 s) - must update 
[2023-12-31 04:23:09] 2023-12-31 03:22:50,038 | INFO     | pilot.util.queuehandling         | abort_jobs_in_queues      | found 0 job(s) in 20 queues
[2023-12-31 04:23:09] 2023-12-31 03:22:50,038 | WARNING  | pilot.control.monitor            | run_checks                | pilot monitor received instruction that args.graceful_stop has been set
[2023-12-31 04:23:09] 2023-12-31 03:22:50,038 | WARNING  | pilot.control.monitor            | run_checks                | will wait for a maximum of 300 s for threads to finish
[2023-12-31 04:23:09] 2023-12-31 03:22:50,107 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-12-31 04:23:09] 2023-12-31 03:22:50,302 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-12-31 04:23:09] 2023-12-31 03:22:51,038 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,051 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,121 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,122 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,123 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,166 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,153 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,325 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,343 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-12-31 04:23:09] 2023-12-31 03:22:51,613 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:51,952 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:52,038 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:52,128 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-12-31 04:23:09] 2023-12-31 03:22:52,349 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:52,609 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:53,136 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:22:53,541 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-12-31 04:23:09] 2023-12-31 03:22:57,549 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:23:00,107 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-12-31 04:23:09] 2023-12-31 03:23:00,107 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-12-31 04:23:09] 2023-12-31 03:23:00,107 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-12-31 04:23:09] 2023-12-31 03:23:01,109 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-12-31 04:23:09] 2023-12-31 03:23:02,890 | INFO     | pilot.util.processes             | threads_aborted           | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140534
[2023-12-31 04:23:09] 2023-12-31 03:23:02,890 | DEBUG    | pilot.workflow.generic           | run                       | will proceed to set job_aborted
[2023-12-31 04:23:09] 2023-12-31 03:23:03,125 | WARNING  | pilot.control.monitor            | run_checks                | job_aborted has been set - aborting pilot monitoring
[2023-12-31 04:23:09] 2023-12-31 03:23:03,126 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-12-31 04:23:09] 2023-12-31 03:23:07,912 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-12-31 04:23:09] 2023-12-31 03:23:07,912 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-12-31 04:23:09] 2023-12-31 03:23:07,994 | DEBUG    | pilot.util.processgroups         | get_all_child_pids        | python3(23975)---pstree(8477)
[2023-12-31 04:23:09] 
[2023-12-31 04:23:09] 2023-12-31 03:23:07,995 | INFO     | pilot.util.processgroups         | find_defunct_subprocesses | child pids=[23975, 8477]
[2023-12-31 04:23:09] 2023-12-31 03:23:08,039 | DEBUG    | pilot.util.processgroups         | is_defunct                | 23975: return code=0, stdout=SN
[2023-12-31 04:23:09] , stderr=
[2023-12-31 04:23:09] 2023-12-31 03:23:08,093 | DEBUG    | pilot.util.processgroups         | is_defunct                | 8477: return code=1, stdout=, stderr=
[2023-12-31 04:23:09] 2023-12-31 03:23:08,095 | INFO     | root                             | list_zombies              | no defunct processes were found
[2023-12-31 04:23:09] 2023-12-31 03:23:08,096 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-12-31 04:23:09] 2023-12-31 03:23:08,097 | INFO     | root                             | wrap_up                   | pilot has finished (exit code=0, shell exit code=0)
[2023-12-31 04:23:09] 2023-12-31 03:23:08,233 [wrapper] ==== pilot stdout END ====
[2023-12-31 04:23:09] 2023-12-31 03:23:08,260 [wrapper] ==== wrapper stdout RESUME ====
[2023-12-31 04:23:09] 2023-12-31 03:23:08,271 [wrapper] pilotpid: 23975
[2023-12-31 04:23:09] 2023-12-31 03:23:08,280 [wrapper] Pilot exit status: 0
[2023-12-31 04:23:09] 2023-12-31 03:23:08,306 [wrapper] pandaids: 6065583230
[2023-12-31 04:23:09] 2023-12-31 03:23:08,322 [wrapper] apfmon messages muted
[2023-12-31 04:23:09] 2023-12-31 03:23:08,327 [wrapper] Test setup, not cleaning
[2023-12-31 04:23:09] 2023-12-31 03:23:08,332 [wrapper] ==== wrapper stdout END ====
[2023-12-31 04:23:09] 2023-12-31 03:23:08,337 [wrapper] ==== wrapper stderr END ====
[2023-12-31 04:23:09] 2023-12-31 03:23:08,357 [wrapper] wrapperexiting ec=0, duration=1545
[2023-12-31 04:23:09] 2023-12-31 03:23:08,364 [wrapper] apfmon messages muted
[2023-12-31 04:23:09]  *** Error codes and diagnostics ***
[2023-12-31 04:23:09]     "exeErrorCode": 0,
[2023-12-31 04:23:09]     "exeErrorDiag": "",
[2023-12-31 04:23:09]     "pilotErrorCode": 0,
[2023-12-31 04:23:09]     "pilotErrorDiag": "",
[2023-12-31 04:23:09]  *** Listing of results directory ***
[2023-12-31 04:23:09] insgesamt 45792
[2023-12-31 04:23:09] -rwx------. 1 boinc boinc    27437 31. Dez 03:52 runpilot2-wrapper.sh
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     4388 31. Dez 03:52 queuedata.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   477391 31. Dez 03:52 pilot3.tar.gz
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      107 31. Dez 03:57 wrapper_26015_x86_64-pc-linux-gnu
[2023-12-31 04:23:09] -rwxr-xr-x. 1 boinc boinc     7986 31. Dez 03:57 run_atlas
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      112 31. Dez 03:57 job.xml
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc    17646 31. Dez 03:57 start_atlas.sh
[2023-12-31 04:23:09] drwxrwx--x. 2 boinc boinc       68 31. Dez 03:57 shared
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc   488883 31. Dez 03:57 input.tar.gz
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     6046 31. Dez 03:57 init_data.xml
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc 37965264 31. Dez 03:57 EVNT.04972714._000027.pool.root.1
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc        0 31. Dez 03:57 boinc_lockfile
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     2663 31. Dez 03:57 pandaJob.out
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      424 31. Dez 03:57 setup.sh.local
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   983529 31. Dez 03:57 agis_schedconf.cvmfs.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc        0 31. Dez 03:57 agis_ddmendpoints.agis.ALL.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  1338505 31. Dez 03:57 cric_ddmendpoints.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc       47 31. Dez 03:57 pilot_heartbeat.json
[2023-12-31 04:23:09] drwx------. 5 boinc boinc     4096 31. Dez 03:57 pilot3
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  1808603 31. Dez 04:22 output.1.c6dba656-c93f-4e70-acc3-3a222425f730_27573.pool.root
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc     1021 31. Dez 04:22 memory_monitor_summary.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   195848 31. Dez 04:22 c6dba656-c93f-4e70-acc3-3a222425f730_27573.1.job.log.tgz
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc     8192 31. Dez 04:22 boinc_mmap_file
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc       26 31. Dez 04:22 wrapper_checkpoint.txt
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      534 31. Dez 04:22 boinc_task_state.xml
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc     8793 31. Dez 04:22 heartbeat.json
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc     9720 31. Dez 04:23 pilotlog.txt
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc   696254 31. Dez 04:23 c6dba656-c93f-4e70-acc3-3a222425f730_27573.1.job.log
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      464 31. Dez 04:23 output.list
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc      748 31. Dez 04:23 runtime_log
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  2723840 31. Dez 04:23 result.tar.gz
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc    11844 31. Dez 04:23 runtime_log.err
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc      634 31. Dez 04:23 3Y9KDmq70d4n7Olcko1bjSoqABFKDmABFKDmyeZQDmqgIKDm2kwyln.diag
[2023-12-31 04:23:09] -rw-r--r--. 1 boinc boinc    29272 31. Dez 04:23 stderr.txt
[2023-12-31 04:23:09] HITS file was successfully produced:
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc 1808603 31. Dez 04:22 shared/HITS.pool.root.1
[2023-12-31 04:23:09]  *** Contents of shared directory: ***
[2023-12-31 04:23:09] insgesamt 42004
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc    17646 31. Dez 03:57 start_atlas.sh
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc   488883 31. Dez 03:57 input.tar.gz
[2023-12-31 04:23:09] -rw-r--r--. 2 boinc boinc 37965264 31. Dez 03:57 ATLAS.root_0
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  1808603 31. Dez 04:22 HITS.pool.root.1
[2023-12-31 04:23:09] -rw-------. 1 boinc boinc  2723840 31. Dez 04:23 result.tar.gz
04:23:10 (19731): run_atlas exited; CPU time 1228.907071
04:23:10 (19731): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN