Name 1RSMDmp3pH4n7Olcko1bjSoqABFKDmABFKDmyeZQDmtPFKDmYqQ1To_0
Workunit 2342304
Created 30 Oct 2023, 22:37:12 UTC
Sent 30 Oct 2023, 22:39:12 UTC
Report deadline 6 Nov 2023, 22:39:12 UTC
Received 31 Oct 2023, 2:08:50 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4008
Run time 32 min 19 sec
CPU time 17 min 12 sec
Validate state Valid
Credit 19.21
Device peak FLOPS 3.13 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.42 GB
Peak swap size 3.12 GB
Peak disk usage 79.20 MB

Stderr output

<core_client_version>7.16.1</core_client_version>
<![CDATA[
<stderr_txt>
02:19:15 (29803): wrapper (7.7.26015): starting
02:19:15 (29803): wrapper: running run_atlas (--nthreads 1)
[2023-10-31 02:19:15] Arguments: --nthreads 1
[2023-10-31 02:19:15] Threads: 1
[2023-10-31 02:19:15] Checking for CVMFS
[2023-10-31 02:19:18] Probing /cvmfs/atlas.cern.ch... OK
[2023-10-31 02:19:20] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-10-31 02:19:20] Running cvmfs_config stat atlas.cern.ch
[2023-10-31 02:19:20] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2023-10-31 02:19:20] 2.6.3.0 30047 0 28384 125398 3 1 2072466 2816000 0 65024 0 0 n/a 961 2420 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://10.116.178.201:3128 1
[2023-10-31 02:19:20] CVMFS is ok
[2023-10-31 02:19:20] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-10-31 02:19:20] Checking for apptainer binary...
[2023-10-31 02:19:20] which: no apptainer in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin)
[2023-10-31 02:19:20] apptainer is not installed, using version from CVMFS
[2023-10-31 02:19:20] 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-10-31 02:19:22] HPi7COS7
[2023-10-31 02:19:22] apptainer works
[2023-10-31 02:19:22] Starting ATLAS job with PandaID=6004904436
[2023-10-31 02:19:22] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-10-31 02:51:31]  *** The last 200 lines of the pilot log: ***
[2023-10-31 02:51:31] 2023-10-31 01:51:09,535 | INFO     | pilot.util.timing                | timing_report             | . log creation = 0 s
[2023-10-31 02:51:31] 2023-10-31 01:51:09,535 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-10-31 02:51:31] 2023-10-31 01:51:09,535 | DEBUG    | pilot.control.job                | add_timing_and_extracts   | could have reported time_log_creation=0 s
[2023-10-31 02:51:31] 2023-10-31 01:51:09,535 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '6004904436', 'state': 'finished', 'timestamp': '2023-10-31T02:50:51+01:00', 'siteNam
[2023-10-31 02:51:31] 2023-10-31 01:51:09,537 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '6004904436', 'state': 'finished', 'timestamp': '2023-10-31T02:50:51
[2023-10-31 02:51:31] 2023-10-31 01:51:09,537 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc/slots/1/heartbeat.json
[2023-10-31 02:51:31] 2023-10-31 01:51:09,538 | DEBUG    | pilot.control.job                | queue_monitor             | job.completed=False
[2023-10-31 02:51:31] 2023-10-31 01:51:10,320 | INFO     | pilot.control.job                | make_job_report           | 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,320 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-10-31 02:51:31] 2023-10-31 01:51:10,321 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-10-31 02:51:31] 2023-10-31 01:51:10,321 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 6004904436
[2023-10-31 02:51:31] 2023-10-31 01:51:10,321 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-10-31 02:51:31] 2023-10-31 01:51:10,322 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-10-31 02:51:31] 2023-10-31 01:51:10,322 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,322 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,323 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:10,323 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:10,323 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,324 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:10,324 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-10-31 02:51:31] 2023-10-31 01:51:10,324 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 1083 s
[2023-10-31 02:51:31] 2023-10-31 01:51:10,325 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-10-31 02:51:31] 2023-10-31 01:51:10,325 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:10,325 | INFO     | pilot.control.job                | make_job_report           | pid: 8773
[2023-10-31 02:51:31] 2023-10-31 01:51:10,326 | INFO     | pilot.control.job                | make_job_report           | pgrp: 8773
[2023-10-31 02:51:31] 2023-10-31 01:51:10,326 | INFO     | pilot.control.job                | make_job_report           | corecount: 1
[2023-10-31 02:51:31] 2023-10-31 01:51:10,326 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-10-31 02:51:31] 2023-10-31 01:51:10,327 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2430050, 1: 2430985, 2: 2431013, 13: 2431013, 23: 2431215, 34: 2431243, 45: 2431399, 51: 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,327 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-10-31 02:51:31] 2023-10-31 01:51:10,327 | INFO     | pilot.control.job                | make_job_report           | 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,328 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc/slots/1:
[2023-10-31 02:51:31] 
[2023-10-31 02:51:31] 2023-10-31 01:51:10,328 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc/slots/1
[2023-10-31 02:51:31] 2023-10-31 01:51:10,355 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-10-31 02:51:31] 2023-10-31 01:51:10,377 | DEBUG    | pilot.control.job                | has_job_completed         | total 42620
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      123 Oct 31 02:19 1RSMDmp3pH4n7Olcko1bjSoqABFKDmABFKDmyeZQDmtPFKDmYqQ1To.diag
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   590963 Oct 31 02:51 807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.1.job.log
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   183278 Oct 31 02:47 807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.1.job.log.tgz
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc 37073557 Oct 31 02:19 EVNT.04972714._000021.pool.root.1
[2023-10-31 02:51:31] drwxrwx---. 2 boinc boinc     4096 Oct 31 02:50 PanDA_Pilot-6004904436/
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   967915 Oct 31 02:21 agis_schedconf.cvmfs.json
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc        0 Oct 31 02:19 boinc_lockfile
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     8192 Oct 31 02:51 boinc_mmap_file
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      533 Oct 31 02:44 boinc_task_state.xml
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  1359822 Oct 31 02:21 cric_ddmendpoints.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc     7421 Oct 31 02:51 heartbeat.json
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     6047 Oct 31 02:19 init_data.xml
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc   478831 Oct 31 02:19 input.tar.gz
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      112 Oct 31 02:19 job.xml
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc     1017 Oct 31 02:44 memory_monitor_summary.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  1440079 Oct 31 02:44 output.1.807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.pool.root
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      464 Oct 31 02:50 output.list
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     2660 Oct 31 02:19 pandaJob.out
[2023-10-31 02:51:31] drwx------. 4 boinc boinc     4096 Oct 31 02:21 pilot3/
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   468209 Oct 30 23:37 pilot3.tar.gz
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   560601 Oct 31 02:51 pilotlog.txt
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     4388 Oct 30 23:37 queuedata.json
[2023-10-31 02:51:31] -rwxr-xr-x. 1 boinc boinc     7986 Oct 31 02:19 run_atlas*
[2023-10-31 02:51:31] -rwx------. 1 boinc boinc    27437 Oct 30 23:37 runpilot2-wrapper.sh*
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      407 Oct 31 02:19 runtime_log
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     7753 Oct 31 02:19 runtime_log.err
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      424 Oct 31 02:19 setup.sh.local
[2023-10-31 02:51:31] drwxrwx--x. 2 boinc boinc       68 Oct 31 02:19 shared/
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc    17646 Oct 31 02:19 start_atlas.sh
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     1745 Oct 31 02:19 stderr.txt
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      107 Oct 31 02:19 wrapper_26015_x86_64-pc-linux-gnu
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc       25 Oct 31 02:51 wrapper_checkpoint.txt
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,378 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,379 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,379 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,379 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-10-31 02:51:31] 2023-10-31 01:51:10,380 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,381 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-10-31 02:51:31] 2023-10-31 01:51:10,381 | INFO     | pilot.control.job                | has_job_completed         | job 6004904436 has completed (purged errors)
[2023-10-31 02:51:31] 2023-10-31 01:51:10,381 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-10-31 02:51:31] 2023-10-31 01:51:10,381 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-10-31 02:51:31] 2023-10-31 01:51:10,384 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc/slots/1/PanDA_Pilot-6004904436
[2023-10-31 02:51:31] 2023-10-31 01:51:11,392 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [8773]
[2023-10-31 02:51:31] 2023-10-31 01:51:11,392 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector waiting for pid 8773
[2023-10-31 02:51:31] 2023-10-31 01:51:11,392 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-10-31 02:51:31] 2023-10-31 01:51:12,392 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-10-31 02:51:31] 2023-10-31 01:51:12,393 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=8773
[2023-10-31 02:51:31] 2023-10-31 01:51:12,411 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-10-31 02:51:31] 2023-10-31 01:51:12,511 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [8773] (in reverse order)
[2023-10-31 02:51:31] 2023-10-31 01:51:12,528 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-10-31 02:51:31] 2023-10-31 01:51:12,569 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-10-31 02:51:31] 2023-10-31 01:51:12,569 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-10-31 02:51:31] 2023-10-31 01:51:12,571 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 8773
[2023-10-31 02:51:31] 2023-10-31 01:51:12,573 | INFO     | pilot.util.processes             | kill_defunct_children     | did not find any defunct processes belonging to 8773
[2023-10-31 02:51:31] 2023-10-31 01:51:12,573 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-10-31 02:51:31] 2023-10-31 01:51:12,573 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-10-31 02:51:31] 2023-10-31 01:51:12,573 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-10-31 02:51:31] 2023-10-31 01:51:12,574 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-10-31 02:51:31] 2023-10-31 01:51:12,574 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.6.10.27  ***
[2023-10-31 02:51:31] 2023-10-31 01:51:12,574 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-10-31 02:51:31] 2023-10-31 01:51:12,574 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-10-31 02:51:31] 2023-10-31 01:51:12,575 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2023-10-31 02:51:31] 2023-10-31 01:51:12,575 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-10-31 02:51:31] 2023-10-31 01:51:12,575 | INFO     | pilot.util.container             | print_executable          | executing command: cat /etc/os-release
[2023-10-31 02:51:31] 2023-10-31 01:51:12,582 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-10-31 02:51:31] 2023-10-31 01:51:12,594 | INFO     | pilot.util.filehandling          | dump                      | cat /etc/os-release:
[2023-10-31 02:51:31] NAME="CentOS Linux"
[2023-10-31 02:51:31] VERSION="7 (Core)"
[2023-10-31 02:51:31] ID="centos"
[2023-10-31 02:51:31] ID_LIKE="rhel fedora"
[2023-10-31 02:51:31] VERSION_ID="7"
[2023-10-31 02:51:31] PRETTY_NAME="CentOS Linux 7 (Core)"
[2023-10-31 02:51:31] ANSI_COLOR="0;31"
[2023-10-31 02:51:31] CPE_NAME="cpe:/o:centos:centos:7"
[2023-10-31 02:51:31] HOME_URL="https://www.centos.org/"
[2023-10-31 02:51:31] BUG_REPORT_URL="https://bugs.centos.org/"
[2023-10-31 02:51:31] 
[2023-10-31 02:51:31] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2023-10-31 02:51:31] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2023-10-31 02:51:31] REDHAT_SUPPORT_PRODUCT="centos"
[2023-10-31 02:51:31] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2023-10-31 02:51:31] 
[2023-10-31 02:51:31] 2023-10-31 01:51:12,595 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-10-31 02:51:31] 2023-10-31 01:51:13,099 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc/slots/1
[2023-10-31 02:51:31] 2023-10-31 01:51:13,100 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc/slots/1
[2023-10-31 02:51:31] 2023-10-31 01:51:13,120 | DEBUG    | pilot.util.container             | execute                   | subprocess.communicate() will use timeout=864000 s
[2023-10-31 02:51:31] 2023-10-31 01:51:13,141 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem              1048576-blocks  Used Available Capacity Mounted on
[2023-10-31 02:51:31] /dev/mapper/centos-root          22002 11135     10868      51% /var/lib/boinc/slots/1
[2023-10-31 02:51:31] 2023-10-31 01:51:13,141 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-10-31 02:51:31] 2023-10-31 01:51:13,141 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (11395923968 B)
[2023-10-31 02:51:31] 2023-10-31 01:51:13,141 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-10-31 02:51:31] 2023-10-31 01:51:13,141 | WARNING  | pilot.control.job                | retrieve                  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2023-10-31 02:51:31] 2023-10-31 01:51:13,142 | WARNING  | pilot.control.monitor            | control                   | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2023-10-31 02:51:31] 2023-10-31 01:51:13,142 | INFO     | pilot.util.queuehandling         | abort_jobs_in_queues      | found 0 job(s) in 20 queues
[2023-10-31 02:51:31] 2023-10-31 01:51:13,142 | WARNING  | pilot.control.monitor            | run_checks                | pilot monitor received instruction that args.graceful_stop has been set
[2023-10-31 02:51:31] 2023-10-31 01:51:13,142 | WARNING  | pilot.control.monitor            | run_checks                | will wait for a maximum of 300 s for threads to finish
[2023-10-31 02:51:31] 2023-10-31 01:51:13,335 | WARNING  | pilot.control.job                | check_for_abort_job       | job monitor detected an abort_job request (signal=args.signal)
[2023-10-31 02:51:31] 2023-10-31 01:51:13,336 | WARNING  | pilot.control.job                | job_monitor               | cannot recover job monitoring - aborting pilot
[2023-10-31 02:51:31] 2023-10-31 01:51:13,336 | WARNING  | pilot.util.common                | should_abort              | job:job_monitor:received graceful stop - abort after this iteration
[2023-10-31 02:51:31] 2023-10-31 01:51:13,336 | INFO     | pilot.control.job                | job_monitor               | will abort loop
[2023-10-31 02:51:31] 2023-10-31 01:51:13,799 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-10-31 02:51:31] 2023-10-31 01:51:13,911 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-10-31 02:51:31] 2023-10-31 01:51:13,912 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-10-31 02:51:31] 2023-10-31 01:51:14,155 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,224 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,286 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,350 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,742 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-10-31 02:51:31] 2023-10-31 01:51:14,881 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-10-31 02:51:31] 2023-10-31 01:51:14,887 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,922 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,925 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:14,925 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,042 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,304 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-10-31 02:51:31] 2023-10-31 01:51:15,544 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,576 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,753 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,816 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:15,886 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:19,335 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:23,433 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-10-31 02:51:31] 2023-10-31 01:51:23,434 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-10-31 02:51:31] 2023-10-31 01:51:23,434 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-10-31 02:51:31] 2023-10-31 01:51:24,446 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-10-31 02:51:31] 2023-10-31 01:51:24,780 | INFO     | pilot.util.processes             | threads_aborted           | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140322
[2023-10-31 02:51:31] 2023-10-31 01:51:24,781 | DEBUG    | pilot.workflow.generic           | run                       | will proceed to set job_aborted
[2023-10-31 02:51:31] 2023-10-31 01:51:25,252 | WARNING  | pilot.control.monitor            | run_checks                | job_aborted has been set - aborting pilot monitoring
[2023-10-31 02:51:31] 2023-10-31 01:51:25,256 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-10-31 02:51:31] 2023-10-31 01:51:29,802 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-10-31 02:51:31] 2023-10-31 01:51:29,803 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-10-31 02:51:31] 2023-10-31 01:51:29,868 | DEBUG    | pilot.util.processgroups         | get_all_child_pids        | python3(1677)---pstree(18493)
[2023-10-31 02:51:31] 
[2023-10-31 02:51:31] 2023-10-31 01:51:29,871 | INFO     | pilot.util.processgroups         | find_defunct_subprocesses | child pids=[1677, 18493]
[2023-10-31 02:51:31] 2023-10-31 01:51:29,977 | DEBUG    | pilot.util.processgroups         | is_defunct                | 1677: return code=0, stdout=SN
[2023-10-31 02:51:31] , stderr=
[2023-10-31 02:51:31] 2023-10-31 01:51:30,091 | DEBUG    | pilot.util.processgroups         | is_defunct                | 18493: return code=1, stdout=, stderr=
[2023-10-31 02:51:31] 2023-10-31 01:51:30,091 | INFO     | root                             | list_zombies              | no defunct processes were found
[2023-10-31 02:51:31] 2023-10-31 01:51:30,092 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:30,092 | INFO     | root                             | wrap_up                   | pilot has finished (exit code=0, shell exit code=0)
[2023-10-31 02:51:31] 2023-10-31 01:51:30,232 [wrapper] ==== pilot stdout END ====
[2023-10-31 02:51:31] 2023-10-31 01:51:30,239 [wrapper] ==== wrapper stdout RESUME ====
[2023-10-31 02:51:31] 2023-10-31 01:51:30,245 [wrapper] pilotpid: 1677
[2023-10-31 02:51:31] 2023-10-31 01:51:30,259 [wrapper] Pilot exit status: 0
[2023-10-31 02:51:31] 2023-10-31 01:51:30,284 [wrapper] pandaids: 6004904436
[2023-10-31 02:51:31] 2023-10-31 01:51:30,309 [wrapper] apfmon messages muted
[2023-10-31 02:51:31] 2023-10-31 01:51:30,316 [wrapper] Test setup, not cleaning
[2023-10-31 02:51:31] 2023-10-31 01:51:30,340 [wrapper] ==== wrapper stdout END ====
[2023-10-31 02:51:31] 2023-10-31 01:51:30,359 [wrapper] ==== wrapper stderr END ====
[2023-10-31 02:51:31] 2023-10-31 01:51:30,381 [wrapper] wrapperexiting ec=0, duration=1927
[2023-10-31 02:51:31] 2023-10-31 01:51:30,387 [wrapper] apfmon messages muted
[2023-10-31 02:51:31]  *** Error codes and diagnostics ***
[2023-10-31 02:51:31]     "exeErrorCode": 0,
[2023-10-31 02:51:31]     "exeErrorDiag": "",
[2023-10-31 02:51:31]     "pilotErrorCode": 0,
[2023-10-31 02:51:31]     "pilotErrorDiag": "",
[2023-10-31 02:51:31]  *** Listing of results directory ***
[2023-10-31 02:51:31] insgesamt 43984
[2023-10-31 02:51:31] -rwx------. 1 boinc boinc    27437 30. Okt 23:37 runpilot2-wrapper.sh
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     4388 30. Okt 23:37 queuedata.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   468209 30. Okt 23:37 pilot3.tar.gz
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      107 31. Okt 02:19 wrapper_26015_x86_64-pc-linux-gnu
[2023-10-31 02:51:31] -rwxr-xr-x. 1 boinc boinc     7986 31. Okt 02:19 run_atlas
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      112 31. Okt 02:19 job.xml
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc    17646 31. Okt 02:19 start_atlas.sh
[2023-10-31 02:51:31] drwxrwx--x. 2 boinc boinc       68 31. Okt 02:19 shared
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc   478831 31. Okt 02:19 input.tar.gz
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     6047 31. Okt 02:19 init_data.xml
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc 37073557 31. Okt 02:19 EVNT.04972714._000021.pool.root.1
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc        0 31. Okt 02:19 boinc_lockfile
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     2660 31. Okt 02:19 pandaJob.out
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      424 31. Okt 02:19 setup.sh.local
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  1359822 31. Okt 02:21 cric_ddmendpoints.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   967915 31. Okt 02:21 agis_schedconf.cvmfs.json
[2023-10-31 02:51:31] drwx------. 4 boinc boinc     4096 31. Okt 02:21 pilot3
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  1440079 31. Okt 02:44 output.1.807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.pool.root
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      533 31. Okt 02:44 boinc_task_state.xml
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc     1017 31. Okt 02:44 memory_monitor_summary.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   183278 31. Okt 02:47 807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.1.job.log.tgz
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc       25 31. Okt 02:51 wrapper_checkpoint.txt
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc     8192 31. Okt 02:51 boinc_mmap_file
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc     7421 31. Okt 02:51 heartbeat.json
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc     9832 31. Okt 02:51 pilotlog.txt
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc   609415 31. Okt 02:51 807c920f-2a0a-478e-9e76-4b3adcad45f9_11523.1.job.log
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      464 31. Okt 02:51 output.list
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc      748 31. Okt 02:51 runtime_log
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  2252800 31. Okt 02:51 result.tar.gz
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc    11864 31. Okt 02:51 runtime_log.err
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc      635 31. Okt 02:51 1RSMDmp3pH4n7Olcko1bjSoqABFKDmABFKDmyeZQDmtPFKDmYqQ1To.diag
[2023-10-31 02:51:31] -rw-r--r--. 1 boinc boinc    29226 31. Okt 02:51 stderr.txt
[2023-10-31 02:51:31] HITS file was successfully produced:
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc 1440079 31. Okt 02:44 shared/HITS.pool.root.1
[2023-10-31 02:51:31]  *** Contents of shared directory: ***
[2023-10-31 02:51:31] insgesamt 40304
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc    17646 31. Okt 02:19 start_atlas.sh
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc   478831 31. Okt 02:19 input.tar.gz
[2023-10-31 02:51:31] -rw-r--r--. 2 boinc boinc 37073557 31. Okt 02:19 ATLAS.root_0
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  1440079 31. Okt 02:44 HITS.pool.root.1
[2023-10-31 02:51:31] -rw-------. 1 boinc boinc  2252800 31. Okt 02:51 result.tar.gz
02:51:33 (29803): run_atlas exited; CPU time 1032.844844
02:51:33 (29803): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN