Name 4bzNDmgTj23n7Olcko1bjSoqABFKDmABFKDm7AsVDmXURKDmCaoROm_0
Workunit 2332769
Created 19 Sep 2023, 6:33:28 UTC
Sent 19 Sep 2023, 6:35:40 UTC
Report deadline 26 Sep 2023, 6:35:40 UTC
Received 19 Sep 2023, 7:08:11 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4721
Run time 16 min 24 sec
CPU time 4 min 45 sec
Validate state Valid
Credit 19.47
Device peak FLOPS 5.74 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.58 GB
Peak swap size 2.12 GB
Peak disk usage 76.82 MB

Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
08:51:35 (28963): wrapper (7.7.26015): starting
08:51:35 (28963): wrapper: running run_atlas (--nthreads 1)
[2023-09-19 08:51:35] Arguments: --nthreads 1
[2023-09-19 08:51:35] Threads: 1
[2023-09-19 08:51:35] Checking for CVMFS
[2023-09-19 08:51:35] Probing /cvmfs/atlas.cern.ch... OK
[2023-09-19 08:51:35] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-09-19 08:51:35] Running cvmfs_config stat atlas.cern.ch
[2023-09-19 08:51:35] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2023-09-19 08:51:35] 2.11.0.0 7492 16 43056 123755 3 75 2395788 4096000 0 130560 0 66076 99.999 72 67 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://10.116.178.201:3128 1
[2023-09-19 08:51:35] CVMFS is ok
[2023-09-19 08:51:35] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-09-19 08:51:35] Checking for apptainer binary...
[2023-09-19 08:51:35] Using apptainer found in PATH at /usr/bin/apptainer
[2023-09-19 08:51:35] Running /usr/bin/apptainer --version
[2023-09-19 08:51:35] apptainer version 1.2.2-1.el9
[2023-09-19 08:51:35] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-09-19 08:51:35] P620-CentOS9
[2023-09-19 08:51:35] apptainer works
[2023-09-19 08:51:35] Starting ATLAS job with PandaID=5966750673
[2023-09-19 08:51:35] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-09-19 09:07:55]  *** The last 200 lines of the pilot log: ***
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 402 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 365 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | INFO     | pilot.util.timing                | timing_report             | . log creation = 0 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | DEBUG    | pilot.control.job                | add_timing_and_extracts   | could have reported time_log_creation=0 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,763 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '5966750673', 'state': 'finished', 'timestamp': '2023-09-19T09:07:32+01:00', 'siteNam
[2023-09-19 09:07:55] 2023-09-19 07:07:35,764 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5966750673', 'state': 'finished', 'timestamp': '2023-09-19T09:07:32
[2023-09-19 09:07:55] 2023-09-19 07:07:35,764 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc/slots/2/heartbeat.json
[2023-09-19 09:07:55] 2023-09-19 07:07:35,764 | DEBUG    | pilot.control.job                | queue_monitor             | job.completed=False
[2023-09-19 09:07:55] 2023-09-19 07:07:35,817 | INFO     | pilot.control.job                | make_job_report           | 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,817 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-09-19 09:07:55] 2023-09-19 07:07:35,817 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-09-19 09:07:55] 2023-09-19 07:07:35,817 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5966750673
[2023-09-19 09:07:55] 2023-09-19 07:07:35,817 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 288 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | pid: 39874
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | pgrp: 39874
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | corecount: 1
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2487442, 1: 2487641, 11: 2487787, 22: 2487815, 33: 2487843, 43: 2487871, 54: 2488027, 63:
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.control.job                | make_job_report           | 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc/slots/2:
[2023-09-19 09:07:55] 
[2023-09-19 09:07:55] 2023-09-19 07:07:35,818 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc/slots/2
[2023-09-19 09:07:55] 2023-09-19 07:07:35,825 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | DEBUG    | pilot.control.job                | has_job_completed         | total 41988
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      135 Sep 19 08:51 4bzNDmgTj23n7Olcko1bjSoqABFKDmABFKDm7AsVDmXURKDmCaoROm.diag
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc 36949600 Sep 19 08:51 EVNT.04972714._000039.pool.root.1
[2023-09-19 09:07:55] drwxrwx---. 2 boinc boinc     4096 Sep 19 09:07 PanDA_Pilot-5966750673/
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1003661 Sep 19 08:51 agis_schedconf.cvmfs.json
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   337497 Sep 19 09:07 bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.1.job.log
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   163021 Sep 19 09:04 bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.1.job.log.tgz
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc        0 Sep 19 08:51 boinc_lockfile
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     8192 Sep 19 09:07 boinc_mmap_file
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      532 Sep 19 09:01 boinc_task_state.xml
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1388715 Sep 19 08:52 cric_ddmendpoints.json
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc     7337 Sep 19 09:07 heartbeat.json
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     6185 Sep 19 08:51 init_data.xml
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc   447328 Sep 19 08:51 input.tar.gz
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      112 Sep 19 08:51 job.xml
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc     1004 Sep 19 09:01 memory_monitor_summary.json
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1585223 Sep 19 09:01 output.1.bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.pool.root
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      464 Sep 19 09:07 output.list
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     2663 Sep 19 08:51 pandaJob.out
[2023-09-19 09:07:55] drwx------. 4 boinc boinc     4096 Sep 19 08:53 pilot3/
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   435920 Sep 19 08:33 pilot3.tar.gz
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   322679 Sep 19 09:07 pilotlog.txt
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     4388 Sep 19 08:30 queuedata.json
[2023-09-19 09:07:55] -rwxr-xr-x. 1 boinc boinc     7986 Sep 19 08:51 run_atlas*
[2023-09-19 09:07:55] -rwx------. 1 boinc boinc    27364 Sep 19 08:33 runpilot2-wrapper.sh*
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      407 Sep 19 08:51 runtime_log
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     7727 Sep 19 08:51 runtime_log.err
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      424 Sep 19 08:51 setup.sh.local
[2023-09-19 09:07:55] drwxrwx--x. 2 boinc boinc       68 Sep 19 08:51 shared/
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc    17632 Sep 19 08:51 start_atlas.sh
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     1641 Sep 19 08:51 stderr.txt
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      107 Sep 19 08:51 wrapper_26015_x86_64-pc-linux-gnu
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc       24 Sep 19 09:07 wrapper_checkpoint.txt
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,827 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.control.job                | has_job_completed         | job 5966750673 has completed (purged errors)
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-09-19 09:07:55] 2023-09-19 07:07:35,828 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-09-19 09:07:55] 2023-09-19 07:07:35,829 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc/slots/2/PanDA_Pilot-5966750673
[2023-09-19 09:07:55] 2023-09-19 07:07:36,834 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [39874]
[2023-09-19 09:07:55] 2023-09-19 07:07:36,834 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector waiting for pid 39874
[2023-09-19 09:07:55] 2023-09-19 07:07:36,834 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-09-19 09:07:55] 2023-09-19 07:07:37,839 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-09-19 09:07:55] 2023-09-19 07:07:37,839 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=39874
[2023-09-19 09:07:55] 2023-09-19 07:07:37,847 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-09-19 09:07:55] 2023-09-19 07:07:37,867 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [39874] (in reverse order)
[2023-09-19 09:07:55] 2023-09-19 07:07:37,874 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-09-19 09:07:55] 2023-09-19 07:07:37,883 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-09-19 09:07:55] 2023-09-19 07:07:37,883 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-09-19 09:07:55] 2023-09-19 07:07:37,884 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 39874
[2023-09-19 09:07:55] 2023-09-19 07:07:37,885 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 39874
[2023-09-19 09:07:55] 2023-09-19 07:07:37,885 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-09-19 09:07:55] 2023-09-19 07:07:37,885 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-09-19 09:07:55] 2023-09-19 07:07:37,885 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.6.7.10  ***
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-09-19 09:07:55] 2023-09-19 07:07:37,886 | INFO     | pilot.util.container             | print_executable          | executing command: cat /etc/os-release
[2023-09-19 09:07:55] 2023-09-19 07:07:37,892 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-09-19 09:07:55] 2023-09-19 07:07:37,892 | INFO     | pilot.util.filehandling          | dump                      | cat /etc/os-release:
[2023-09-19 09:07:55] NAME="CentOS Linux"
[2023-09-19 09:07:55] VERSION="7 (Core)"
[2023-09-19 09:07:55] ID="centos"
[2023-09-19 09:07:55] ID_LIKE="rhel fedora"
[2023-09-19 09:07:55] VERSION_ID="7"
[2023-09-19 09:07:55] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-09-19 09:07:55] ANSI_COLOR="0;31"
[2023-09-19 09:07:55] CPE_NAME="cpe:/o:centos:centos:7"
[2023-09-19 09:07:55] HOME_URL="https://www.centos.org/"
[2023-09-19 09:07:55] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-09-19 09:07:55] 
[2023-09-19 09:07:55] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-09-19 09:07:55] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-09-19 09:07:55] REDHAT_SUPPORT_PRODUCT="centos"
[2023-09-19 09:07:55] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-09-19 09:07:55] 
[2023-09-19 09:07:55] 2023-09-19 07:07:37,892 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | **************************************
[2023-09-19 09:07:55] 2023-09-19 07:07:38,395 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc/slots/2
[2023-09-19 09:07:55] 2023-09-19 07:07:38,395 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc/slots/2
[2023-09-19 09:07:55] 2023-09-19 07:07:38,401 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem          1048576-blocks  Used Available Capacity Mounted on
[2023-09-19 09:07:55] /dev/mapper/cs-root          31213  9397     21817      31% /var/lib/boinc/slots/2
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (22876782592 B)
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | WARNING  | pilot.control.job                | retrieve                  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | WARNING  | pilot.util.common                | should_abort              | job:job_monitor:received graceful stop - abort after this iteration
[2023-09-19 09:07:55] 2023-09-19 07:07:38,402 | INFO     | pilot.control.job                | job_monitor               | aborting loop
[2023-09-19 09:07:55] 2023-09-19 07:07:38,805 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-09-19 09:07:55] 2023-09-19 07:07:38,806 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-09-19 09:07:55] 2023-09-19 07:07:38,951 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-09-19 09:07:55] 2023-09-19 07:07:38,970 | INFO     | pilot.util.queuehandling         | abort_jobs_in_queues      | found 0 job(s) in 20 queues
[2023-09-19 09:07:55] 2023-09-19 07:07:38,970 | WARNING  | pilot.control.monitor            | run_checks                | pilot monitor received instruction that args.graceful_stop has been set
[2023-09-19 09:07:55] 2023-09-19 07:07:38,970 | WARNING  | pilot.control.monitor            | run_checks                | will wait for a maximum of 300 s for threads to finish
[2023-09-19 09:07:55] 2023-09-19 07:07:39,403 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,403 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,809 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,809 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,909 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,916 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:39,956 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,101 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,380 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,403 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,633 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,791 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,824 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-09-19 09:07:55] 2023-09-19 07:07:40,866 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:40,968 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-09-19 09:07:55] 2023-09-19 07:07:41,829 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:44,973 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:48,757 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-09-19 09:07:55] 2023-09-19 07:07:48,757 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-09-19 09:07:55] 2023-09-19 07:07:48,757 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-09-19 09:07:55] 2023-09-19 07:07:49,760 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-09-19 09:07:55] 2023-09-19 07:07:50,494 | INFO     | pilot.util.processes             | threads_aborted           | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139985
[2023-09-19 09:07:55] 2023-09-19 07:07:50,494 | DEBUG    | pilot.workflow.generic           | run                       | will proceed to set job_aborted
[2023-09-19 09:07:55] 2023-09-19 07:07:51,017 | WARNING  | pilot.control.monitor            | run_checks                | job_aborted has been set - aborting pilot monitoring
[2023-09-19 09:07:55] 2023-09-19 07:07:51,017 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-09-19 09:07:55] 2023-09-19 07:07:55,508 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-09-19 09:07:55] 2023-09-19 07:07:55,508 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-09-19 09:07:55] 2023-09-19 07:07:55,508 | DEBUG    | root                             | <module>                  | trace=<class 'pilot.workflow.generic.traces'>
[2023-09-19 09:07:55] 2023-09-19 07:07:55,529 | DEBUG    | pilot.util.processgroups         | get_all_child_pids        | python3(32678)---pstree(49983)
[2023-09-19 09:07:55] 
[2023-09-19 09:07:55] 2023-09-19 07:07:55,529 | INFO     | pilot.util.processgroups         | find_defunct_subprocesses | child pids=[32678, 49983]
[2023-09-19 09:07:55] 2023-09-19 07:07:55,541 | DEBUG    | pilot.util.processgroups         | is_defunct                | 32678: return code=0, stdout=SN
[2023-09-19 09:07:55] , stderr=
[2023-09-19 09:07:55] 2023-09-19 07:07:55,551 | DEBUG    | pilot.util.processgroups         | is_defunct                | 49983: return code=1, stdout=, stderr=
[2023-09-19 09:07:55] 2023-09-19 07:07:55,551 | INFO     | root                             | list_zombies              | no defunct processes were found
[2023-09-19 09:07:55] 2023-09-19 07:07:55,551 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:55,551 | INFO     | root                             | wrap_up                   | pilot has finished (exit code=0, shell exit code=0)
[2023-09-19 09:07:55] 2023-09-19 07:07:55,587 [wrapper] ==== pilot stdout END ====
[2023-09-19 09:07:55] 2023-09-19 07:07:55,588 [wrapper] ==== wrapper stdout RESUME ====
[2023-09-19 09:07:55] 2023-09-19 07:07:55,589 [wrapper] pilotpid: 32678
[2023-09-19 09:07:55] 2023-09-19 07:07:55,590 [wrapper] Pilot exit status: 0
[2023-09-19 09:07:55] 2023-09-19 07:07:55,596 [wrapper] pandaids: 5966750673
[2023-09-19 09:07:55] 2023-09-19 07:07:55,598 [wrapper] apfmon messages muted
[2023-09-19 09:07:55] 2023-09-19 07:07:55,599 [wrapper] Test setup, not cleaning
[2023-09-19 09:07:55] 2023-09-19 07:07:55,600 [wrapper] ==== wrapper stdout END ====
[2023-09-19 09:07:55] 2023-09-19 07:07:55,601 [wrapper] ==== wrapper stderr END ====
[2023-09-19 09:07:55] 2023-09-19 07:07:55,603 [wrapper] wrapperexiting ec=0, duration=980
[2023-09-19 09:07:55] 2023-09-19 07:07:55,604 [wrapper] apfmon messages muted
[2023-09-19 09:07:55]  *** Error codes and diagnostics ***
[2023-09-19 09:07:55]     "exeErrorCode": 0,
[2023-09-19 09:07:55]     "exeErrorDiag": "",
[2023-09-19 09:07:55]     "pilotErrorCode": 0,
[2023-09-19 09:07:55]     "pilotErrorDiag": "",
[2023-09-19 09:07:55]  *** Listing of results directory ***
[2023-09-19 09:07:55] insgesamt 43616
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     4388 19. Sep 08:30 queuedata.json
[2023-09-19 09:07:55] -rwx------. 1 boinc boinc    27364 19. Sep 08:33 runpilot2-wrapper.sh
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   435920 19. Sep 08:33 pilot3.tar.gz
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      107 19. Sep 08:51 wrapper_26015_x86_64-pc-linux-gnu
[2023-09-19 09:07:55] -rwxr-xr-x. 1 boinc boinc     7986 19. Sep 08:51 run_atlas
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      112 19. Sep 08:51 job.xml
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     6185 19. Sep 08:51 init_data.xml
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc 36949600 19. Sep 08:51 EVNT.04972714._000039.pool.root.1
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc    17632 19. Sep 08:51 start_atlas.sh
[2023-09-19 09:07:55] drwxrwx--x. 2 boinc boinc       68 19. Sep 08:51 shared
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc   447328 19. Sep 08:51 input.tar.gz
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc        0 19. Sep 08:51 boinc_lockfile
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     2663 19. Sep 08:51 pandaJob.out
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      424 19. Sep 08:51 setup.sh.local
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1003661 19. Sep 08:51 agis_schedconf.cvmfs.json
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1388715 19. Sep 08:52 cric_ddmendpoints.json
[2023-09-19 09:07:55] drwx------. 4 boinc boinc     4096 19. Sep 08:53 pilot3
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1585223 19. Sep 09:01 output.1.bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.pool.root
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      532 19. Sep 09:01 boinc_task_state.xml
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc     1004 19. Sep 09:01 memory_monitor_summary.json
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   163021 19. Sep 09:04 bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.1.job.log.tgz
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc     7337 19. Sep 09:07 heartbeat.json
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc     8192 19. Sep 09:07 boinc_mmap_file
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc       24 19. Sep 09:07 wrapper_checkpoint.txt
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc     9471 19. Sep 09:07 pilotlog.txt
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc   355745 19. Sep 09:07 bd9c9b6d-8dca-4890-a603-cc12ae2b0557_16545.1.job.log
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc      748 19. Sep 09:07 runtime_log
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  2119680 19. Sep 09:07 result.tar.gz
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      464 19. Sep 09:07 output.list
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc    11849 19. Sep 09:07 runtime_log.err
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc      625 19. Sep 09:07 4bzNDmgTj23n7Olcko1bjSoqABFKDmABFKDm7AsVDmXURKDmCaoROm.diag
[2023-09-19 09:07:55] -rw-r--r--. 1 boinc boinc    29016 19. Sep 09:07 stderr.txt
[2023-09-19 09:07:55] HITS file was successfully produced:
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc 1585223 19. Sep 09:01 shared/HITS.pool.root.1
[2023-09-19 09:07:55]  *** Contents of shared directory: ***
[2023-09-19 09:07:55] insgesamt 40168
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc 36949600 19. Sep 08:51 ATLAS.root_0
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc    17632 19. Sep 08:51 start_atlas.sh
[2023-09-19 09:07:55] -rw-r--r--. 2 boinc boinc   447328 19. Sep 08:51 input.tar.gz
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  1585223 19. Sep 09:01 HITS.pool.root.1
[2023-09-19 09:07:55] -rw-------. 1 boinc boinc  2119680 19. Sep 09:07 result.tar.gz
09:07:57 (28963): run_atlas exited; CPU time 285.395278
09:07:57 (28963): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN