Name IueNDmXPh32n7Olcko1bjSoqABFKDmABFKDm7AsVDmViGKDmJ14tRn_1
Workunit 2293504
Created 3 Apr 2023, 22:08:22 UTC
Sent 3 Apr 2023, 22:09:04 UTC
Report deadline 10 Apr 2023, 22:09:04 UTC
Received 3 Apr 2023, 22:46:53 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4851
Run time 15 min 41 sec
CPU time 6 min 38 sec
Validate state Valid
Credit 8.62
Device peak FLOPS 9.71 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.52 GB
Peak swap size 2.12 GB
Peak disk usage 80.93 MB

Stderr output

<core_client_version>7.20.5</core_client_version>
<![CDATA[
<stderr_txt>
00:30:12 (2141355): wrapper (7.7.26015): starting
00:30:12 (2141355): wrapper: running run_atlas (--nthreads 2)
[2023-04-04 00:30:12] Arguments: --nthreads 2
[2023-04-04 00:30:12] Threads: 2
[2023-04-04 00:30:12] Checking for CVMFS
[2023-04-04 00:30:12] Probing /cvmfs/atlas.cern.ch... OK
[2023-04-04 00:30:12] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-04-04 00:30:12] Running cvmfs_config stat atlas.cern.ch
[2023-04-04 00:30:12] 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-04-04 00:30:12] 2.10.0.0 2102875 6267 53252 117537 2 64 6338979 10240001 1562 130560 0 26120929 99.991 736958 3804 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2023-04-04 00:30:12] CVMFS is ok
[2023-04-04 00:30:12] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-04-04 00:30:12] Checking for apptainer binary...
[2023-04-04 00:30:12] Using apptainer found in PATH at /usr/bin/apptainer
[2023-04-04 00:30:12] Running /usr/bin/apptainer --version
[2023-04-04 00:30:12] apptainer version 1.1.0-rc.2
[2023-04-04 00:30:12] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-04-04 00:30:13] atlas7l2
[2023-04-04 00:30:13] apptainer works
[2023-04-04 00:30:13] Set ATHENA_PROC_NUMBER=2
[2023-04-04 00:30:13] Set ATHENA_CORE_NUMBER=2
[2023-04-04 00:30:13] Starting ATLAS job with PandaID=5808139478
[2023-04-04 00:30:13] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-04-04 00:45:50]  *** The last 200 lines of the pilot log: ***
[2023-04-04 00:45:50] L2 cache:              1280K
[2023-04-04 00:45:50] L3 cache:              24576K
[2023-04-04 00:45:50] NUMA node0 CPU(s):     0-15
[2023-04-04 00:45:50] Flags:                 fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush mmx fxsr sse sse2 ss syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon nopl xtopology tsc_re
[2023-04-04 00:45:50] 2023-04-03 22:45:36,356 | INFO     | pilot.util.workernode            | get_cpu_cores             | found 16 cores (1 cores per socket, 16 sockets)
[2023-04-04 00:45:50] 2023-04-03 22:45:36,356 | DEBUG    | pilot.util.workernode            | get_cpu_cores             | current model string: Intel(R) Xeon(R) Silver 4314 CPU @ 2.40GHz 24576 KB
[2023-04-04 00:45:50] 2023-04-03 22:45:36,356 | DEBUG    | pilot.util.workernode            | get_cpu_cores             | updated model string: Intel(R) Xeon(R) Silver 4314 CPU @ 2.40GHz 24576 KB 16-Core Processor
[2023-04-04 00:45:50] 2023-04-03 22:45:36,356 | INFO     | pilot.util.container             | print_executable          | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-04-04 00:45:50] 2023-04-03 22:45:36,370 | INFO     | pilot.util.container             | print_executable          | executing command: python3 /var/lib/boinc_data/boinc-01/slots/2/pilot3/pilot/scripts/cpu_arch.py --a
[2023-04-04 00:45:50] 2023-04-03 22:45:36,470 | DEBUG    | pilot.util.workernode            | get_cpu_arch              | CPU arch script returned: x86-64-v4
[2023-04-04 00:45:50] 2023-04-03 22:45:36,471 | INFO     | pilot.user.atlas.utilities       | get_memory_values         | using path: /var/lib/boinc_data/boinc-01/slots/2/PanDA_Pilot-5808139478/memory_monitor_summary.json 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,473 | DEBUG    | pilot.user.atlas.utilities       | get_memory_monitor_info   | summary_dictionary={'Avg': {'nprocs': 5.333, 'nthreads': 6.166, 'pss': 1182981.0, 'rchar': 206177057
[2023-04-04 00:45:50] 2023-04-03 22:45:36,473 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard info from prmon json
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard memory fields from prmon json
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.util.timing                | timing_report             | . Timing measurements:
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.util.timing                | timing_report             | . get job = 56 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.util.timing                | timing_report             | . initial setup = 82 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,474 | INFO     | pilot.util.timing                | timing_report             | . payload setup = 6 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,475 | INFO     | pilot.util.timing                | timing_report             | . stage-in = 60 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,475 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 362 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,475 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 343 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,475 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-04-04 00:45:50] 2023-04-03 22:45:36,475 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '5808139478', 'state': 'finished', 'timestamp': '2023-04-04T00:45:36+01:00', 'siteNam
[2023-04-04 00:45:50] 2023-04-03 22:45:36,477 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5808139478', 'state': 'finished', 'timestamp': '2023-04-04T00:45:36
[2023-04-04 00:45:50] 2023-04-03 22:45:36,477 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc_data/boinc-01/slots/2/heartbeat.json
[2023-04-04 00:45:50] 2023-04-03 22:45:36,522 | INFO     | pilot.control.job                | make_job_report           | 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,522 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-04-04 00:45:50] 2023-04-03 22:45:36,522 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-04-04 00:45:50] 2023-04-03 22:45:36,522 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5808139478
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:36,523 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 408 s
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | pid: 2148391
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | pgrp: 2148391
[2023-04-04 00:45:50] 2023-04-03 22:45:36,524 | INFO     | pilot.control.job                | make_job_report           | corecount: 2
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2551223, 1: 2551223, 11: 2551397, 22: 2551425, 32: 2551453, 43: 2551481, 53: 2551637, 61:
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | INFO     | pilot.control.job                | make_job_report           | 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc_data/boinc-01/slots/2:
[2023-04-04 00:45:50] 
[2023-04-04 00:45:50] 2023-04-03 22:45:36,525 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc_data/boinc-01/slots/2
[2023-04-04 00:45:50] 2023-04-03 22:45:36,541 | DEBUG    | pilot.control.job                | has_job_completed         | total 43292
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   295400 Apr  4 00:45 56c42a9a-92bb-443c-9706-4686d752fde4_95119.1.job.log
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   430717 Apr  4 00:43 56c42a9a-92bb-443c-9706-4686d752fde4_95119.1.job.log.tgz
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti 38019645 Apr  4 00:30 EVNT.04972714._000023.pool.root.1
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      144 Apr  4 00:30 IueNDmXPh32n7Olcko1bjSoqABFKDmABFKDm7AsVDmViGKDmJ14tRn.diag
[2023-04-04 00:45:50] drwxrwx--- 3 yeti yeti     4096 Apr  4 00:45 PanDA_Pilot-5808139478/
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1007893 Apr  4 00:31 agis_schedconf.cvmfs.json
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti        0 Apr  4 00:30 boinc_lockfile
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     8192 Apr  4 00:45 boinc_mmap_file
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      532 Apr  4 00:37 boinc_task_state.xml
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1432739 Apr  4 00:31 cric_ddmendpoints.json
[2023-04-04 00:45:50] -rw------- 1 yeti yeti     7811 Apr  4 00:45 heartbeat.json
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     6443 Apr  4 00:30 init_data.xml
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti   412394 Apr  4 00:30 input.tar.gz
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      112 Apr  4 00:30 job.xml
[2023-04-04 00:45:50] -rw------- 1 yeti yeti     1010 Apr  4 00:39 memory_monitor_summary.json
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1859642 Apr  4 00:39 output.1.56c42a9a-92bb-443c-9706-4686d752fde4_95119.pool.root
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      464 Apr  4 00:45 output.list
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     2666 Apr  4 00:30 pandaJob.out
[2023-04-04 00:45:50] drwx------ 4 yeti yeti     4096 Apr  4 00:32 pilot3/
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   401189 Apr  4 00:00 pilot3.tar.gz
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   281851 Apr  4 00:45 pilotlog.txt
[2023-04-04 00:45:50] -rw-r--r-- 1 yeti yeti     4388 Apr  4 00:00 queuedata.json
[2023-04-04 00:45:50] -rwxr-xr-x 1 yeti yeti     7986 Apr  4 00:30 run_atlas*
[2023-04-04 00:45:50] -rwx------ 1 yeti yeti    27540 Apr  4 00:00 runpilot2-wrapper.sh*
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      407 Apr  4 00:30 runtime_log
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     8344 Apr  4 00:30 runtime_log.err
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      462 Apr  4 00:30 setup.sh.local
[2023-04-04 00:45:50] drwxrwx--x 2 yeti yeti     4096 Apr  4 00:30 shared/
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti    17632 Apr  4 00:30 start_atlas.sh
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     1768 Apr  4 00:30 stderr.txt
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      107 Apr  4 00:30 wrapper_26015_x86_64-pc-linux-gnu
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti       24 Apr  4 00:45 wrapper_checkpoint.txt
[2023-04-04 00:45:50] 2023-04-03 22:45:36,541 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,541 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,542 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.control.job                | has_job_completed         | job 5808139478 has completed (purged errors)
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-04-04 00:45:50] 2023-04-03 22:45:36,543 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-04-04 00:45:50] 2023-04-03 22:45:36,549 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc_data/boinc-01/slots/2/PanDA_Pilot-5808139478
[2023-04-04 00:45:50] 2023-04-03 22:45:37,555 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [2148391]
[2023-04-04 00:45:50] 2023-04-03 22:45:37,555 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector trying to kill pid 2148391
[2023-04-04 00:45:50] 2023-04-03 22:45:37,555 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-04-04 00:45:50] 2023-04-03 22:45:38,292 | WARNING  | pilot.control.monitor            | get_max_running_time      | queuedata could not be extracted from queues, will use default for max running time (324000s)
[2023-04-04 00:45:50] 2023-04-03 22:45:38,557 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-04-04 00:45:50] 2023-04-03 22:45:38,557 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=2148391
[2023-04-04 00:45:50] 2023-04-03 22:45:38,596 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [2148391] (in reverse order)
[2023-04-04 00:45:50] 2023-04-03 22:45:38,631 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-04-04 00:45:50] 2023-04-03 22:45:38,631 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-04-04 00:45:50] 2023-04-03 22:45:38,631 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-04-04 00:45:50] 2023-04-03 22:45:38,631 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-04-04 00:45:50] 2023-04-03 22:45:38,631 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.5.2 (29)  ***
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2023-04-04 00:45:50] 2023-04-03 22:45:38,632 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-04-04 00:45:50] 2023-04-03 22:45:38,670 | INFO     | pilot.util.auxiliary             | display_architecture_info | 
[2023-04-04 00:45:50] LSB Version:	:core-4.1-amd64:core-4.1-noarch
[2023-04-04 00:45:50] Distributor ID:	CentOS
[2023-04-04 00:45:50] Description:	CentOS Linux release 7.9.2009 (Core)
[2023-04-04 00:45:50] Release:	7.9.2009
[2023-04-04 00:45:50] Codename:	Core
[2023-04-04 00:45:50] 2023-04-03 22:45:38,671 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2023-04-04 00:45:50] 2023-04-03 22:45:39,173 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc_data/boinc-01/slots/2
[2023-04-04 00:45:50] 2023-04-03 22:45:39,173 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc_data/boinc-01/slots/2
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem     1048576-blocks  Used Available Capacity Mounted on
[2023-04-04 00:45:50] /dev/sda5               62572 27827     31536      47% /var/lib/boinc_data/boinc-01/slots/2
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (33067892736 B)
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | DEBUG    | pilot.control.job                | retrieve                  | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,182 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,183 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-04-04 00:45:50] 2023-04-03 22:45:39,190 | DEBUG    | pilot.control.job                | validate                  | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,191 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,226 | DEBUG    | pilot.control.payload            | failed_post               | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,226 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,298 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-04-04 00:45:50] 2023-04-03 22:45:39,339 | DEBUG    | pilot.control.data               | copytool_in               | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,339 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,339 | DEBUG    | pilot.control.payload            | execute_payloads          | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,339 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,508 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-04-04 00:45:50] 2023-04-03 22:45:39,509 | DEBUG    | pilot.control.payload            | control                   | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,509 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,809 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-04-04 00:45:50] 2023-04-03 22:45:39,810 | DEBUG    | pilot.control.data               | control                   | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,810 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,872 | DEBUG    | pilot.control.job                | create_data_payload       | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,872 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:39,878 | DEBUG    | pilot.control.payload            | validate_pre              | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:39,878 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:40,136 | DEBUG    | pilot.control.payload            | validate_post             | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:40,136 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:40,183 | DEBUG    | pilot.control.data               | copytool_out              | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:40,183 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:40,590 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-04-04 00:45:50] 2023-04-03 22:45:40,590 | DEBUG    | pilot.control.job                | control                   | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:40,590 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:41,530 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-04-04 00:45:50] 2023-04-03 22:45:41,531 | DEBUG    | pilot.control.job                | queue_monitor             | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:41,531 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:41,655 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-04-04 00:45:50] 2023-04-03 22:45:44,656 | DEBUG    | pilot.control.data               | queue_monitoring          | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:44,656 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:46,936 | WARNING  | pilot.control.job                | check_job_monitor_waiting_time | no jobs in monitored_payloads queue (waited for 61 s)
[2023-04-04 00:45:50] 2023-04-03 22:45:46,937 | DEBUG    | pilot.control.job                | job_monitor               | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:46,937 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:50,447 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-04-04 00:45:50] 2023-04-03 22:45:50,447 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-04-04 00:45:50] 2023-04-03 22:45:50,447 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-04-04 00:45:50] 2023-04-03 22:45:50,447 | DEBUG    | pilot.control.payload            | run_realtimelog           | will not set job_aborted yet
[2023-04-04 00:45:50] 2023-04-03 22:45:50,447 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:50,806 | DEBUG    | pilot.util.processes             | threads_aborted           | aborting since only the main Pilot thread is still running (total thread count=1 with 0 daemon threa
[2023-04-04 00:45:50] 2023-04-03 22:45:50,807 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-04-04 00:45:50] 2023-04-03 22:45:50,807 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-04-04 00:45:50] 2023-04-03 22:45:50,807 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:50,807 | INFO     | root                             | wrap_up                   | pilot has finished
[2023-04-04 00:45:50] 2023-04-03 22:45:50,858 [wrapper] ==== pilot stdout END ====
[2023-04-04 00:45:50] 2023-04-03 22:45:50,861 [wrapper] ==== wrapper stdout RESUME ====
[2023-04-04 00:45:50] 2023-04-03 22:45:50,864 [wrapper] pilotpid: 2144845
[2023-04-04 00:45:50] 2023-04-03 22:45:50,866 [wrapper] Pilot exit status: 0
[2023-04-04 00:45:50] 2023-04-03 22:45:50,877 [wrapper] pandaids: 5808139478
[2023-04-04 00:45:50] 2023-04-03 22:45:50,885 [wrapper] apfmon messages muted
[2023-04-04 00:45:50] 2023-04-03 22:45:50,887 [wrapper] Test setup, not cleaning
[2023-04-04 00:45:50] 2023-04-03 22:45:50,888 [wrapper] ==== wrapper stdout END ====
[2023-04-04 00:45:50] 2023-04-03 22:45:50,890 [wrapper] ==== wrapper stderr END ====
[2023-04-04 00:45:50] 2023-04-03 22:45:50,895 [wrapper] wrapperexiting ec=0, duration=937
[2023-04-04 00:45:50] 2023-04-03 22:45:50,896 [wrapper] apfmon messages muted
[2023-04-04 00:45:50]  *** Error codes and diagnostics ***
[2023-04-04 00:45:50]     "exeErrorCode": 0,
[2023-04-04 00:45:50]     "exeErrorDiag": "",
[2023-04-04 00:45:50]     "pilotErrorCode": 0,
[2023-04-04 00:45:50]     "pilotErrorDiag": "",
[2023-04-04 00:45:50]  *** Listing of results directory ***
[2023-04-04 00:45:50] insgesamt 45628
[2023-04-04 00:45:50] -rwx------ 1 yeti yeti    27540 Apr  4 00:00 runpilot2-wrapper.sh
[2023-04-04 00:45:50] -rw-r--r-- 1 yeti yeti     4388 Apr  4 00:00 queuedata.json
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   401189 Apr  4 00:00 pilot3.tar.gz
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      107 Apr  4 00:30 wrapper_26015_x86_64-pc-linux-gnu
[2023-04-04 00:45:50] -rwxr-xr-x 1 yeti yeti     7986 Apr  4 00:30 run_atlas
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      112 Apr  4 00:30 job.xml
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti    17632 Apr  4 00:30 start_atlas.sh
[2023-04-04 00:45:50] drwxrwx--x 2 yeti yeti     4096 Apr  4 00:30 shared
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti   412394 Apr  4 00:30 input.tar.gz
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     6443 Apr  4 00:30 init_data.xml
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti 38019645 Apr  4 00:30 EVNT.04972714._000023.pool.root.1
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti        0 Apr  4 00:30 boinc_lockfile
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     2666 Apr  4 00:30 pandaJob.out
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      462 Apr  4 00:30 setup.sh.local
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1432739 Apr  4 00:31 cric_ddmendpoints.json
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1007893 Apr  4 00:31 agis_schedconf.cvmfs.json
[2023-04-04 00:45:50] drwx------ 4 yeti yeti     4096 Apr  4 00:32 pilot3
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      532 Apr  4 00:37 boinc_task_state.xml
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1859642 Apr  4 00:39 output.1.56c42a9a-92bb-443c-9706-4686d752fde4_95119.pool.root
[2023-04-04 00:45:50] -rw------- 1 yeti yeti     1010 Apr  4 00:39 memory_monitor_summary.json
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   430717 Apr  4 00:43 56c42a9a-92bb-443c-9706-4686d752fde4_95119.1.job.log.tgz
[2023-04-04 00:45:50] -rw------- 1 yeti yeti     7811 Apr  4 00:45 heartbeat.json
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti     8192 Apr  4 00:45 boinc_mmap_file
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti       24 Apr  4 00:45 wrapper_checkpoint.txt
[2023-04-04 00:45:50] -rw------- 1 yeti yeti     8919 Apr  4 00:45 pilotlog.txt
[2023-04-04 00:45:50] -rw------- 1 yeti yeti   312460 Apr  4 00:45 56c42a9a-92bb-443c-9706-4686d752fde4_95119.1.job.log
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      464 Apr  4 00:45 output.list
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti      748 Apr  4 00:45 runtime_log
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  2621440 Apr  4 00:45 result.tar.gz
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti    12605 Apr  4 00:45 runtime_log.err
[2023-04-04 00:45:50] -rw------- 1 yeti yeti      621 Apr  4 00:45 IueNDmXPh32n7Olcko1bjSoqABFKDmABFKDm7AsVDmViGKDmJ14tRn.diag
[2023-04-04 00:45:50] -rw-rw-r-- 1 yeti yeti    30404 Apr  4 00:45 stderr.txt
[2023-04-04 00:45:50] HITS file was successfully produced:
[2023-04-04 00:45:50] -rw------- 1 yeti yeti 1859642 Apr  4 00:39 shared/HITS.pool.root.1
[2023-04-04 00:45:50]  *** Contents of shared directory: ***
[2023-04-04 00:45:50] insgesamt 41936
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti    17632 Apr  4 00:30 start_atlas.sh
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti   412394 Apr  4 00:30 input.tar.gz
[2023-04-04 00:45:50] -rw-r--r-- 2 yeti yeti 38019645 Apr  4 00:30 ATLAS.root_0
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  1859642 Apr  4 00:39 HITS.pool.root.1
[2023-04-04 00:45:50] -rw------- 1 yeti yeti  2621440 Apr  4 00:45 result.tar.gz
00:45:52 (2141355): run_atlas exited; CPU time 398.056907
00:45:52 (2141355): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN