Name rqNMDmNQrh1n7Olcko1bjSoqABFKDmABFKDmKFbSDmWfIKDmIEtC0n_1
Workunit 2204421
Created 15 Aug 2022, 15:55:49 UTC
Sent 15 Aug 2022, 15:59:55 UTC
Report deadline 22 Aug 2022, 15:59:55 UTC
Received 15 Aug 2022, 16:10:28 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4636
Run time 9 min 41 sec
CPU time 4 min 36 sec
Validate state Valid
Credit 39.97
Device peak FLOPS 29.69 GFLOPS
Application version ATLAS Simulation v1.22 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.51 GB
Peak swap size 3.39 GB
Peak disk usage 81.12 MB

Stderr output

<core_client_version>7.16.17</core_client_version>
<![CDATA[
<stderr_txt>
18:00:01 (912486): wrapper (7.7.26015): starting
18:00:01 (912486): wrapper: running run_atlas (--nthreads 4)
[2022-08-15 18:00:01] Arguments: --nthreads 4
[2022-08-15 18:00:01] Threads: 4
[2022-08-15 18:00:01] Checking for CVMFS
[2022-08-15 18:00:01] Probing /cvmfs/atlas.cern.ch... OK
[2022-08-15 18:00:01] Probing /cvmfs/atlas-condb.cern.ch... OK
[2022-08-15 18:00:01] Running cvmfs_config stat atlas.cern.ch
[2022-08-15 18:00:01] 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
[2022-08-15 18:00:01] 2.8.2.0 912115 0 26144 108203 4 3 3891879 4096001 24 130560 0 443 100.000 0 0 http://cvmfs-stratum-one.cern.ch:8000/cvmfs/atlas.cern.ch http://137.138.150.196:3128 1
[2022-08-15 18:00:01] CVMFS is ok
[2022-08-15 18:00:01] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2022-08-15 18:00:01] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2022-08-15 18:00:01] Further information can be found at the LHC@home message board.
[2022-08-15 18:00:01] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2022-08-15 18:00:01] Checking for apptainer binary...
[2022-08-15 18:00:01] apptainer is not installed, using version from CVMFS
[2022-08-15 18:00:01] 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
[2022-08-15 18:00:02] pcoslo6
[2022-08-15 18:00:02] apptainer works
[2022-08-15 18:00:02] Set ATHENA_PROC_NUMBER=4
[2022-08-15 18:00:02] Starting ATLAS job with PandaID=5563203869
[2022-08-15 18:00:02] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc-client/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2022-08-15 18:09:40]  *** The last 200 lines of the pilot log: ***
[2022-08-15 18:09:40] 
[2022-08-15 18:09:40]   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
[2022-08-15 18:09:40]   0  2853    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
[2022-08-15 18:09:40] 100  2855  100     2  100  2853      2   3672  0:00:01 --:--:--  0:00:01  3671
[2022-08-15 18:09:40] 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,428 | DEBUG    | pilot.control.job                | send_state                | REACHED_MAXTIME=None
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | INFO     | pilot.control.job                | send_state                | pilot will not update the server (heartbeat message will be written to file)
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | INFO     | pilot.control.job                | is_final_update           | job 5563203869 has finished - writing final server update
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | DEBUG    | pilot.control.job                | get_data_structure        | state=finished
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics_string    | job definition core count: 4
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | DEBUG    | pilot.api.analytics              | get_fitted_data           | removing tails from data to be fitted
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | WARNING  | pilot.api.analytics              | get_fitted_data           | wrong length of table data, x=[1660579539.0, 1660579600.0], y=[1207345.0, 1598866.0] (must be same a
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics           | job metrics="actualCoreCount=0.38 nEvents=2 dbTime=36.69 dbData=4274626 workDirSize=917292 eventnumb
[2022-08-15 18:09:40] 2022-08-15 16:09:23,429 | INFO     | pilot.control.job                | get_data_structure        | total number of processed events: 2 (read)
[2022-08-15 18:09:40] 2022-08-15 16:09:23,453 | INFO     | pilot.util.container             | print_executable          | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.user.atlas.utilities       | get_memory_values         | using path: /var/lib/boinc-client/slots/1/PanDA_Pilot-5563203869/memory_monitor_summary.json (trf na
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | DEBUG    | pilot.user.atlas.utilities       | get_memory_monitor_info   | summary_dictionary={'Avg': {'nprocs': 4.555, 'nthreads': 5.444, 'pss': 1107133.0, 'rchar': 119011727
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard info from prmon json
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard memory fields from prmon json
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.util.timing                | timing_report             | . Timing measurements:
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.util.timing                | timing_report             | . get job = 0 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,487 | INFO     | pilot.util.timing                | timing_report             | . initial setup = 0 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | INFO     | pilot.util.timing                | timing_report             | . payload setup = 4 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | INFO     | pilot.util.timing                | timing_report             | . stage-in = 0 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 526 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 0 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '5563203869', 'state': 'finished', 'timestamp': '2022-08-15T18:09:23+01:00', 'siteNam
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5563203869', 'state': 'finished', 'timestamp': '2022-08-15T18:09:23
[2022-08-15 18:09:40] 2022-08-15 16:09:23,488 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc-client/slots/1/heartbeat.json
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5563203869
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 278 s
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | pid: 927053
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | pgrp: 927053
[2022-08-15 18:09:40] 2022-08-15 16:09:23,987 | INFO     | pilot.control.job                | make_job_report           | corecount: 4
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2648681, 1: 2648887, 11: 2648915, 534: 2678807, 536: 2678807, 537: 2679709}
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | INFO     | pilot.control.job                | make_job_report           | 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc-client/slots/1:
[2022-08-15 18:09:40] 
[2022-08-15 18:09:40] 2022-08-15 16:09:23,988 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc-client/slots/1
[2022-08-15 18:09:40] 2022-08-15 16:09:23,996 | DEBUG    | pilot.control.job                | has_job_completed         | total 43980
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   172656 Aug 15 18:09 66cacba2-4238-454f-bcf8-46f876462af5_55302.1.job.log
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   162968 Aug 15 18:09 66cacba2-4238-454f-bcf8-46f876462af5_55302.1.job.log.tgz
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc 38971704 Aug 15 18:00 EVNT.04972714._000035.pool.root.1
[2022-08-15 18:09:40] drwxrwx--- 2 boinc boinc     4096 Aug 15 18:09 PanDA_Pilot-5563203869/
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1778794 Aug 15 18:00 agis_ddmendpoints.agis.ALL.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1020985 Aug 15 18:00 agis_schedconf.cvmfs.json
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc        0 Aug 15 18:00 boinc_lockfile
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     8192 Aug 15 18:09 boinc_mmap_file
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      532 Aug 15 18:09 boinc_task_state.xml
[2022-08-15 18:09:40] -rw------- 1 boinc boinc     7287 Aug 15 18:09 heartbeat.json
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     6564 Aug 15 18:00 init_data.xml
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc   389590 Aug 15 18:00 input.tar.gz
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      112 Aug 15 18:00 job.xml
[2022-08-15 18:09:40] -rw------- 1 boinc boinc     1007 Aug 15 18:09 memory_monitor_summary.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1827773 Aug 15 18:09 output.1.66cacba2-4238-454f-bcf8-46f876462af5_55302.pool.root
[2022-08-15 18:09:40] -rw------- 1 boinc boinc      464 Aug 15 18:09 output.list
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     2651 Aug 15 18:00 pandaJob.out
[2022-08-15 18:09:40] drwx------ 4 boinc boinc     4096 Aug 15 18:00 pilot3/
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   378739 Aug 15 17:43 pilot3.tar.gz
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   153764 Aug 15 18:09 pilotlog.txt
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     4534 Aug 15 17:43 queuedata.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc      138 Aug 15 18:00 rqNMDmNQrh1n7Olcko1bjSoqABFKDmABFKDmKFbSDmWfIKDmIEtC0n.diag
[2022-08-15 18:09:40] -rwxr-xr-x 1 boinc boinc     7811 Aug 15 18:00 run_atlas*
[2022-08-15 18:09:40] -rwx------ 1 boinc boinc    26743 Aug 15 17:43 runpilot2-wrapper.sh*
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      407 Aug 15 18:00 runtime_log
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     5599 Aug 15 18:00 runtime_log.err
[2022-08-15 18:09:40] drwxrwx--x 2 boinc boinc     4096 Aug 15 18:00 shared/
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc    16664 Aug 15 18:00 start_atlas.sh
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     2004 Aug 15 18:00 stderr.txt
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      107 Aug 15 18:00 wrapper_26015_x86_64-pc-linux-gnu
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc       24 Aug 15 18:09 wrapper_checkpoint.txt
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | INFO     | pilot.control.job                | has_job_completed         | job 5563203869 has completed (purged errors)
[2022-08-15 18:09:40] 2022-08-15 16:09:23,997 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2022-08-15 18:09:40] 2022-08-15 16:09:23,998 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2022-08-15 18:09:40] 2022-08-15 16:09:23,998 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc-client/slots/1/PanDA_Pilot-5563203869
[2022-08-15 18:09:40] 2022-08-15 16:09:25,000 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [927053]
[2022-08-15 18:09:40] 2022-08-15 16:09:25,000 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector trying to kill pid 927053
[2022-08-15 18:09:40] 2022-08-15 16:09:25,000 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2022-08-15 18:09:40] 2022-08-15 16:09:26,004 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2022-08-15 18:09:40] 2022-08-15 16:09:26,004 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=927053
[2022-08-15 18:09:40] 2022-08-15 16:09:26,047 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [927053] (in reverse order)
[2022-08-15 18:09:40] 2022-08-15 16:09:26,067 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2022-08-15 18:09:40] 2022-08-15 16:09:26,067 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2022-08-15 18:09:40] 2022-08-15 16:09:26,067 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.3.4 (69)  ***
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2022-08-15 18:09:40] 2022-08-15 16:09:26,068 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2022-08-15 18:09:40] 2022-08-15 16:09:26,089 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2022-08-15 18:09:40] 2022-08-15 16:09:26,124 | INFO     | pilot.util.auxiliary             | display_architecture_info | 
[2022-08-15 18:09:40] LSB Version:	:core-4.1-amd64:core-4.1-noarch
[2022-08-15 18:09:40] Distributor ID:	CentOS
[2022-08-15 18:09:40] Description:	CentOS Linux release 7.9.2009 (Core)
[2022-08-15 18:09:40] Release:	7.9.2009
[2022-08-15 18:09:40] Codename:	Core
[2022-08-15 18:09:40] 2022-08-15 16:09:26,124 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2022-08-15 18:09:40] 2022-08-15 16:09:26,627 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc-client/slots/1
[2022-08-15 18:09:40] 2022-08-15 16:09:26,627 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc-client/slots/1
[2022-08-15 18:09:40] 2022-08-15 16:09:26,637 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem     1048576-blocks  Used Available Capacity Mounted on
[2022-08-15 18:09:40] /dev/nvme0n1p2         238837 74258    152379      33% /var/lib/boinc-client/slots/1
[2022-08-15 18:09:40] 2022-08-15 16:09:26,637 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2022-08-15 18:09:40] 2022-08-15 16:09:26,637 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (159780962304 B)
[2022-08-15 18:09:40] 2022-08-15 16:09:26,637 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2022-08-15 18:09:40] 2022-08-15 16:09:26,637 | DEBUG    | pilot.control.job                | retrieve                  | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:26,638 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2022-08-15 18:09:40] 2022-08-15 16:09:26,638 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:26,956 | DEBUG    | pilot.control.payload            | validate_post             | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:26,956 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,128 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2022-08-15 18:09:40] 2022-08-15 16:09:27,208 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2022-08-15 18:09:40] 2022-08-15 16:09:27,208 | DEBUG    | pilot.control.data               | control                   | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,208 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,239 | DEBUG    | pilot.control.job                | create_data_payload       | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,239 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,427 | DEBUG    | pilot.control.payload            | validate_pre              | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,427 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,460 | DEBUG    | pilot.control.job                | validate                  | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,460 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,600 | DEBUG    | pilot.control.data               | copytool_in               | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,600 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,636 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2022-08-15 18:09:40] 2022-08-15 16:09:27,636 | DEBUG    | pilot.control.payload            | control                   | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,636 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,638 | DEBUG    | pilot.control.data               | copytool_out              | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,638 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:27,859 | DEBUG    | pilot.control.payload            | execute_payloads          | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:27,859 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:28,004 | DEBUG    | pilot.control.payload            | failed_post               | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:28,004 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:28,044 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2022-08-15 18:09:40] 2022-08-15 16:09:28,044 | DEBUG    | pilot.control.job                | control                   | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:28,044 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:28,440 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2022-08-15 18:09:40] 2022-08-15 16:09:28,527 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2022-08-15 18:09:40] 2022-08-15 16:09:28,527 | DEBUG    | pilot.control.job                | queue_monitor             | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:28,527 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:31,441 | DEBUG    | pilot.control.data               | queue_monitoring          | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:31,441 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:37,418 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2022-08-15 18:09:40] 2022-08-15 16:09:37,418 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2022-08-15 18:09:40] 2022-08-15 16:09:37,418 | DEBUG    | pilot.control.payload            | run_realtimelog           | will not set job_aborted yet
[2022-08-15 18:09:40] 2022-08-15 16:09:37,418 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:40,282 | WARNING  | pilot.control.job                | check_job_monitor_waiting_time | no jobs in monitored_payloads queue (waited for 72 s)
[2022-08-15 18:09:40] 2022-08-15 16:09:40,282 | DEBUG    | pilot.util.processes             | threads_aborted           | aborting since the last relevant thread is about to finish
[2022-08-15 18:09:40] 2022-08-15 16:09:40,283 | DEBUG    | pilot.control.job                | job_monitor               | will proceed to set job_aborted
[2022-08-15 18:09:40] 2022-08-15 16:09:40,283 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:40,320 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2022-08-15 18:09:40] 2022-08-15 16:09:40,320 | INFO     | root                             | wrap_up                   | traces error code: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:40,320 | INFO     | root                             | wrap_up                   | pilot has finished
[2022-08-15 18:09:40] 2022-08-15 16:09:40,345 [wrapper] ==== pilot stdout END ====
[2022-08-15 18:09:40] 2022-08-15 16:09:40,347 [wrapper] ==== wrapper stdout RESUME ====
[2022-08-15 18:09:40] 2022-08-15 16:09:40,349 [wrapper] pilotpid: 922219
[2022-08-15 18:09:40] 2022-08-15 16:09:40,351 [wrapper] Pilot exit status: 0
[2022-08-15 18:09:40] 2022-08-15 16:09:40,358 [wrapper] pandaids: 5563203869
[2022-08-15 18:09:40] 2022-08-15 16:09:40,361 [wrapper] apfmon messages muted
[2022-08-15 18:09:40] 2022-08-15 16:09:40,363 [wrapper] Test setup, not cleaning
[2022-08-15 18:09:40] 2022-08-15 16:09:40,365 [wrapper] ==== wrapper stdout END ====
[2022-08-15 18:09:40] 2022-08-15 16:09:40,367 [wrapper] ==== wrapper stderr END ====
[2022-08-15 18:09:40] 2022-08-15 16:09:40,370 [wrapper] wrapperexiting ec=0, duration=578
[2022-08-15 18:09:40] 2022-08-15 16:09:40,372 [wrapper] apfmon messages muted
[2022-08-15 18:09:40]  *** Error codes and diagnostics ***
[2022-08-15 18:09:40]     "exeErrorCode": 0,
[2022-08-15 18:09:40]     "exeErrorDiag": "",
[2022-08-15 18:09:40]     "pilotErrorCode": 0,
[2022-08-15 18:09:40]     "pilotErrorDiag": "",
[2022-08-15 18:09:40]  *** Listing of results directory ***
[2022-08-15 18:09:40] total 46032
[2022-08-15 18:09:40] -rwx------ 1 boinc boinc    26743 Aug 15 17:43 runpilot2-wrapper.sh
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     4534 Aug 15 17:43 queuedata.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   378739 Aug 15 17:43 pilot3.tar.gz
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      107 Aug 15 18:00 wrapper_26015_x86_64-pc-linux-gnu
[2022-08-15 18:09:40] -rwxr-xr-x 1 boinc boinc     7811 Aug 15 18:00 run_atlas
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      112 Aug 15 18:00 job.xml
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc    16664 Aug 15 18:00 start_atlas.sh
[2022-08-15 18:09:40] drwxrwx--x 2 boinc boinc     4096 Aug 15 18:00 shared
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc   389590 Aug 15 18:00 input.tar.gz
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     6564 Aug 15 18:00 init_data.xml
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc 38971704 Aug 15 18:00 EVNT.04972714._000035.pool.root.1
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc        0 Aug 15 18:00 boinc_lockfile
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     2651 Aug 15 18:00 pandaJob.out
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1020985 Aug 15 18:00 agis_schedconf.cvmfs.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1778794 Aug 15 18:00 agis_ddmendpoints.agis.ALL.json
[2022-08-15 18:09:40] drwx------ 4 boinc boinc     4096 Aug 15 18:00 pilot3
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1827773 Aug 15 18:09 output.1.66cacba2-4238-454f-bcf8-46f876462af5_55302.pool.root
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      532 Aug 15 18:09 boinc_task_state.xml
[2022-08-15 18:09:40] -rw------- 1 boinc boinc     1007 Aug 15 18:09 memory_monitor_summary.json
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   162968 Aug 15 18:09 66cacba2-4238-454f-bcf8-46f876462af5_55302.1.job.log.tgz
[2022-08-15 18:09:40] -rw------- 1 boinc boinc     7287 Aug 15 18:09 heartbeat.json
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc       24 Aug 15 18:09 wrapper_checkpoint.txt
[2022-08-15 18:09:40] -rw------- 1 boinc boinc     8445 Aug 15 18:09 pilotlog.txt
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     8192 Aug 15 18:09 boinc_mmap_file
[2022-08-15 18:09:40] -rw------- 1 boinc boinc   189047 Aug 15 18:09 66cacba2-4238-454f-bcf8-46f876462af5_55302.1.job.log
[2022-08-15 18:09:40] -rw------- 1 boinc boinc      464 Aug 15 18:09 output.list
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc     9607 Aug 15 18:09 runtime_log.err
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc      748 Aug 15 18:09 runtime_log
[2022-08-15 18:09:40] -rw------- 1 boinc boinc      557 Aug 15 18:09 rqNMDmNQrh1n7Olcko1bjSoqABFKDmABFKDmKFbSDmWfIKDmIEtC0n.diag
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  2201600 Aug 15 18:09 result.tar.gz
[2022-08-15 18:09:40] -rw-r--r-- 1 boinc boinc    30416 Aug 15 18:09 stderr.txt
[2022-08-15 18:09:40] HITS file was successfully produced:
[2022-08-15 18:09:40] -rw------- 1 boinc boinc 1827773 Aug 15 18:09 shared/HITS.pool.root.1
[2022-08-15 18:09:40]  *** Contents of shared directory: ***
[2022-08-15 18:09:40] total 42404
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc    16664 Aug 15 18:00 start_atlas.sh
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc   389590 Aug 15 18:00 input.tar.gz
[2022-08-15 18:09:40] -rw-r--r-- 2 boinc boinc 38971704 Aug 15 18:00 ATLAS.root_0
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  1827773 Aug 15 18:09 HITS.pool.root.1
[2022-08-15 18:09:40] -rw------- 1 boinc boinc  2201600 Aug 15 18:09 result.tar.gz
18:09:42 (912486): run_atlas exited; CPU time 276.061880
18:09:42 (912486): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN