Name th5LDmw5LH0n7Olcko1bjSoqABFKDmABFKDm1XmMDmoSFKDmbit3tn_0
Workunit 2147743
Created 14 Dec 2021, 12:28:24 UTC
Sent 14 Dec 2021, 12:29:31 UTC
Report deadline 21 Dec 2021, 12:29:31 UTC
Received 14 Dec 2021, 15:33:07 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4467
Run time 24 min 19 sec
CPU time 16 min 10 sec
Validate state Valid
Credit 14.19
Device peak FLOPS 4.20 GFLOPS
Application version ATLAS Simulation v1.06 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.52 GB
Peak swap size 2.12 GB
Peak disk usage 43.23 MB

Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
15:55:10 (788728): wrapper (7.7.26015): starting
15:55:10 (788728): wrapper: running run_atlas (--nthreads 1)
[2021-12-14 15:55:10] Arguments: --nthreads 1
[2021-12-14 15:55:10] Threads: 1
[2021-12-14 15:55:10] Checking for CVMFS
[2021-12-14 15:55:12] Probing /cvmfs/atlas.cern.ch... OK
[2021-12-14 15:55:13] Probing /cvmfs/atlas-condb.cern.ch... OK
[2021-12-14 15:55:13] Running cvmfs_config stat atlas.cern.ch
[2021-12-14 15:55:13] 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
[2021-12-14 15:55:13] 2.8.1.0 788942 0 27304 97793 3 1 2827679 4194304 0 130560 0 0 0.000 530 1019 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
[2021-12-14 15:55:13] CVMFS is ok
[2021-12-14 15:55:13] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2021-12-14 15:55:13] Small home clusters do not require a local http proxy but it is suggested if
[2021-12-14 15:55:13] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
[2021-12-14 15:55:13] Further information can be found at the LHC@home message board.
[2021-12-14 15:55:13] Using singularity image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2021-12-14 15:55:13] Checking for singularity binary...
[2021-12-14 15:55:13] Using singularity found in PATH at /usr/bin/singularity
[2021-12-14 15:55:13] Running /usr/bin/singularity --version
[2021-12-14 15:55:13] singularity version 3.8.3-1.el8
[2021-12-14 15:55:13] Checking singularity works with /usr/bin/singularity exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2021-12-14 15:55:14] ryzcos8
[2021-12-14 15:55:14] Singularity works
[2021-12-14 15:56:04] Starting ATLAS job with PandaID=5293316366
[2021-12-14 15:56:04] Running command: /usr/bin/singularity exec --pwd /var/lib/boinc/slots/7 -B /cvmfs,/var /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2021-12-14 16:19:26]  *** The last 200 lines of the pilot log: ***
[2021-12-14 16:19:26]       "cpuTimeTotal": 966, 
[2021-12-14 16:19:26]       "externalCpuTime": 12, 
[2021-12-14 16:19:26]       "processedEvents": 2, 
[2021-12-14 16:19:26]       "trfPredata": null, 
[2021-12-14 16:19:26]       "wallTime": 1219
[2021-12-14 16:19:26]     }
[2021-12-14 16:19:26]   }
[2021-12-14 16:19:26] }
[2021-12-14 16:19:26] 2021-12-14 15:18:23,785 | DEBUG    | pilot.user.atlas.common          | update_server             | no need to update logstash for this job
[2021-12-14 16:19:26] 2021-12-14 15:18:23,785 | INFO     | pilot.control.job                | send_state                | pilot will not update the server (heartbeat message will be written to file)
[2021-12-14 16:19:26] 2021-12-14 15:18:23,786 | INFO     | pilot.control.job                | send_state                | job 5293316366 has finished - writing final server update
[2021-12-14 16:19:26] 2021-12-14 15:18:23,786 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics_string    | job definition core count: 1
[2021-12-14 16:19:26] 2021-12-14 15:18:23,787 | INFO     | pilot.user.atlas.jobmetrics      | get_job_metrics_string    | will not add max space = -37412822 B to job metrics
[2021-12-14 16:19:26] 2021-12-14 15:18:23,788 | DEBUG    | pilot.api.analytics              | get_fitted_data           | removing tails from data to be fitted
[2021-12-14 16:19:26] 2021-12-14 15:18:23,788 | INFO     | pilot.api.analytics              | get_fitted_data           | fitting pss+swap vs Time
[2021-12-14 16:19:26] 2021-12-14 15:18:23,789 | INFO     | pilot.api.analytics              | get_fitted_data           | current memory leak: 408.22 B/s (using 14 data points, chi2=0.08)
[2021-12-14 16:19:26] 2021-12-14 15:18:23,791 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics           | job metrics="actualCoreCount=3 nEvents=2 dbTime=32.28 dbData=4274626 leak=408.22 chi2=0.08 eventnumb
[2021-12-14 16:19:26] 2021-12-14 15:18:23,792 | INFO     | pilot.control.job                | get_data_structure        | mean actualcorecount: 2.941176
[2021-12-14 16:19:26] 2021-12-14 15:18:23,792 | INFO     | pilot.control.job                | get_data_structure        | total number of processed events: 2 (read)
[2021-12-14 16:19:26] 2021-12-14 15:18:23,793 | INFO     | pilot.util.container             | execute                   | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2021-12-14 16:19:26] 2021-12-14 15:18:23,891 | INFO     | pilot.user.atlas.utilities       | get_memory_values         | using path: /var/lib/boinc/slots/7/PanDA_Pilot-5293316366/memory_monitor_summary.json (trf name=prmo
[2021-12-14 16:19:26] 2021-12-14 15:18:23,892 | DEBUG    | pilot.user.atlas.utilities       | get_memory_monitor_info   | summary_dictionary={'Avg': {'nprocs': 5.19, 'nthreads': 6.095, 'pss': 1366955.0, 'rchar': 49101415.0
[2021-12-14 16:19:26] 2021-12-14 15:18:23,893 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard info from prmon json
[2021-12-14 16:19:26] 2021-12-14 15:18:23,893 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard memory fields from prmon json
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . Timing measurements:
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . get job = 0 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . initial setup = 0 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . payload setup = 27 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . total setup = 27 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . stage-in = 0 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 1254 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 1 s
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2021-12-14 16:19:26] 2021-12-14 15:18:23,894 | DEBUG    | pilot.control.job                | send_state                | is_harvester_mode(args) : False
[2021-12-14 16:19:26] 2021-12-14 15:18:23,896 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5293316366', 'state': 'finished', 'timestamp': '2021-12-14T16:18:23
[2021-12-14 16:19:26] 2021-12-14 15:18:23,899 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file /var/lib/boinc/slots/7/heartbeat.json
[2021-12-14 16:19:26] 2021-12-14 15:18:23,899 | DEBUG    | pilot.control.job                | queue_monitor             | job 5293316366 was dequeued from the monitored payloads queue
[2021-12-14 16:19:26] 2021-12-14 15:18:23,959 | WARNING  | pilot.control.job                | check_job_monitor_waiting_time | no jobs in monitored_payloads queue (waited for 73 s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,072 | DEBUG    | pilot.control.job                | queue_monitor             | tmp job object deleted
[2021-12-14 16:19:26] 2021-12-14 15:18:24,072 | INFO     | pilot.control.job                | make_job_report           | 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5293316366
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,074 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 1022 s
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | pid: 797305
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | pgrp: 797305
[2021-12-14 16:19:26] 2021-12-14 15:18:24,075 | INFO     | pilot.control.job                | make_job_report           | corecount: 1
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | INFO     | pilot.control.job                | make_job_report           | sizes: {4602468: 3785954, 4602469: 3786060, 4602470: 3786062, 4602480: 3786118, 4603765: 3807048, 46
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | INFO     | pilot.control.job                | make_job_report           | 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc/slots/7:
[2021-12-14 16:19:26] 
[2021-12-14 16:19:26] 2021-12-14 15:18:24,076 | INFO     | pilot.util.container             | execute                   | executing command: ls -lF /var/lib/boinc/slots/7
[2021-12-14 16:19:26] 2021-12-14 15:18:24,173 | DEBUG    | pilot.control.job                | has_job_completed         | total 5692
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      19 Dec 14 15:55 EVNT.04972714._000032.pool.root.1 -> shared/ATLAS.root_0
[2021-12-14 16:19:26] drwxrwx---. 2 boinc boinc    4096 Dec 14 16:18 PanDA_Pilot-5293316366/
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1089445 Dec 14 15:56 agis_schedconf.cvmfs.json
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  197280 Dec 14 16:18 b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.1.job.log
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  166815 Dec 14 16:18 b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.1.job.log.tgz
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc       0 Dec 14 15:55 boinc_lockfile
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    8192 Dec 14 16:17 boinc_mmap_file
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     533 Dec 14 16:17 boinc_task_state.xml
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1919407 Dec 14 15:56 cric_ddmendpoints.json
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc    6623 Dec 14 16:18 heartbeat.json
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    6179 Dec 14 15:55 init_data.xml
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      19 Dec 14 15:55 input.tar.gz -> shared/input.tar.gz
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     112 Dec 14 15:55 job.xml
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc    1018 Dec 14 16:18 memory_monitor_summary.json
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1653300 Dec 14 16:18 output.1.b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.pool.root
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc     536 Dec 14 16:18 output.list
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    2599 Dec 14 15:56 pandaJob.out
[2021-12-14 16:19:26] drwx------. 4 boinc boinc     260 Dec 14 15:56 pilot2/
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc  346481 Dec 14 13:28 pilot2.tar.gz
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  178765 Dec 14 16:18 pilotlog.txt
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    4534 Dec 14 13:28 queuedata.json
[2021-12-14 16:19:26] -rwxr-xr-x. 1 boinc boinc    6970 Dec 14 15:55 run_atlas*
[2021-12-14 16:19:26] -rwx------. 1 boinc boinc   26860 Dec 14 13:28 runpilot2-wrapper.sh*
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     407 Dec 14 15:56 runtime_log
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    5484 Dec 14 15:56 runtime_log.err
[2021-12-14 16:19:26] drwxrwx--x. 2 boinc boinc      68 Dec 14 15:55 shared/
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      21 Dec 14 15:55 start_atlas.sh -> shared/start_atlas.sh
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    2037 Dec 14 15:56 stderr.txt
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc     130 Dec 14 15:56 th5LDmw5LH0n7Olcko1bjSoqABFKDmABFKDm1XmMDmoSFKDmbit3tn.diag
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     107 Dec 14 15:55 wrapper_26015_x86_64-pc-linux-gnu
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc      25 Dec 14 16:17 wrapper_checkpoint.txt
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,174 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in has 1 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,175 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs has 0 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,176 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,176 | INFO     | pilot.control.job                | has_job_completed         | job 5293316366 has completed (purged errors)
[2021-12-14 16:19:26] 2021-12-14 15:18:24,176 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2021-12-14 16:19:26] 2021-12-14 15:18:24,183 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc/slots/7/PanDA_Pilot-5293316366
[2021-12-14 16:19:26] 2021-12-14 15:18:25,191 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [797305]
[2021-12-14 16:19:26] 2021-12-14 15:18:25,192 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector trying to kill pid 797305
[2021-12-14 16:19:26] 2021-12-14 15:18:25,192 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2021-12-14 16:19:26] 2021-12-14 15:18:26,197 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2021-12-14 16:19:26] 2021-12-14 15:18:26,198 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=797305
[2021-12-14 16:19:26] 2021-12-14 15:18:26,370 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [797305] (in reverse order)
[2021-12-14 16:19:26] 2021-12-14 15:18:26,465 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2021-12-14 16:19:26] 2021-12-14 15:18:26,465 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2021-12-14 16:19:26] 2021-12-14 15:18:26,465 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2021-12-14 16:19:26] 2021-12-14 15:18:26,466 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2021-12-14 16:19:26] 2021-12-14 15:18:26,466 | INFO     | root                             | retrieve                  | pilot has finished for previous job - re-establishing logging
[2021-12-14 16:19:26] 2021-12-14 15:18:26,467 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2021-12-14 16:19:26] 2021-12-14 15:18:26,467 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 2.12.8 (1)  ***
[2021-12-14 16:19:26] 2021-12-14 15:18:26,468 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2021-12-14 16:19:26] 2021-12-14 15:18:26,468 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2021-12-14 16:19:26] 2021-12-14 15:18:26,468 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2021-12-14 16:19:26] 2021-12-14 15:18:26,468 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2021-12-14 16:19:26] 2021-12-14 15:18:26,724 | INFO     | pilot.util.auxiliary             | display_architecture_info | 
[2021-12-14 16:19:26] LSB Version:	:core-4.1-amd64:core-4.1-noarch
[2021-12-14 16:19:26] Distributor ID:	CentOS
[2021-12-14 16:19:26] Description:	CentOS Linux release 7.9.2009 (Core)
[2021-12-14 16:19:26] Release:	7.9.2009
[2021-12-14 16:19:26] Codename:	Core
[2021-12-14 16:19:26] 2021-12-14 15:18:26,724 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ****************************************
[2021-12-14 16:19:26] 2021-12-14 15:18:27,227 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc/slots/7
[2021-12-14 16:19:26] 2021-12-14 15:18:27,304 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (31058821120 B)
[2021-12-14 16:19:26] 2021-12-14 15:18:27,305 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2021-12-14 16:19:26] 2021-12-14 15:18:27,305 | DEBUG    | pilot.control.job                | retrieve                  | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:27,305 | DEBUG    | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:27,305 | WARNING  | pilot.control.monitor            | control                   | aborting monitor loop since graceful_stop has been set
[2021-12-14 16:19:26] 2021-12-14 15:18:27,305 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2021-12-14 16:19:26] 2021-12-14 15:18:27,497 | DEBUG    | pilot.control.payload            | validate_post             | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:27,497 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:27,501 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2021-12-14 16:19:26] 2021-12-14 15:18:27,501 | DEBUG    | pilot.control.payload            | control                   | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:27,501 | DEBUG    | pilot.control.payload            | control                   | [payload] control thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:27,659 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2021-12-14 16:19:26] 2021-12-14 15:18:27,660 | DEBUG    | pilot.control.data               | control                   | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:27,661 | DEBUG    | pilot.control.data               | control                   | [data] control thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:27,689 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2021-12-14 16:19:26] 2021-12-14 15:18:27,690 | DEBUG    | pilot.control.job                | control                   | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:27,690 | DEBUG    | pilot.control.job                | control                   | [job] control thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,034 | DEBUG    | pilot.control.payload            | validate_pre              | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,035 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,137 | DEBUG    | pilot.control.payload            | failed_post               | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,137 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,166 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2021-12-14 16:19:26] 2021-12-14 15:18:28,193 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2021-12-14 16:19:26] 2021-12-14 15:18:28,225 | DEBUG    | pilot.control.payload            | execute_payloads          | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,225 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,226 | DEBUG    | pilot.control.job                | validate                  | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,226 | DEBUG    | pilot.control.job                | validate                  | [job] validate thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,584 | DEBUG    | pilot.control.data               | copytool_in               | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,584 | DEBUG    | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:28,807 | DEBUG    | pilot.control.job                | create_data_payload       | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:28,808 | DEBUG    | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:29,088 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2021-12-14 16:19:26] 2021-12-14 15:18:29,089 | DEBUG    | pilot.control.job                | queue_monitor             | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:29,089 | DEBUG    | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:29,167 | DEBUG    | pilot.control.data               | copytool_out              | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:29,167 | DEBUG    | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:18:31,200 | DEBUG    | pilot.control.data               | queue_monitoring          | will not set job_aborted yet
[2021-12-14 16:19:26] 2021-12-14 15:18:31,201 | DEBUG    | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:19:25,578 | WARNING  | pilot.control.job                | check_job_monitor_waiting_time | no jobs in monitored_payloads queue (waited for 135 s)
[2021-12-14 16:19:26] 2021-12-14 15:19:25,578 | DEBUG    | pilot.util.processes             | threads_aborted           | aborting since the last relevant thread is about to finish
[2021-12-14 16:19:26] 2021-12-14 15:19:25,578 | DEBUG    | pilot.control.job                | job_monitor               | will proceed to set job_aborted
[2021-12-14 16:19:26] 2021-12-14 15:19:25,578 | DEBUG    | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2021-12-14 16:19:26] 2021-12-14 15:19:25,968 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2021-12-14 16:19:26] 2021-12-14 15:19:25,969 | INFO     | root                             | wrap_up                   | traces error code: 0
[2021-12-14 16:19:26] 2021-12-14 15:19:25,969 | INFO     | root                             | wrap_up                   | pilot has finished
[2021-12-14 16:19:26] 2021-12-14 15:19:26,120 [wrapper] ==== pilot stdout END ====
[2021-12-14 16:19:26] 2021-12-14 15:19:26,142 [wrapper] ==== wrapper stdout RESUME ====
[2021-12-14 16:19:26] 2021-12-14 15:19:26,175 [wrapper] pilotpid: 794168
[2021-12-14 16:19:26] 2021-12-14 15:19:26,198 [wrapper] Pilot exit status: 0
[2021-12-14 16:19:26] 2021-12-14 15:19:26,252 [wrapper] pandaids: 5293316366
[2021-12-14 16:19:26] 2021-12-14 15:19:26,283 [wrapper] apfmon messages muted
[2021-12-14 16:19:26] 2021-12-14 15:19:26,298 [wrapper] Test setup, not cleaning
[2021-12-14 16:19:26] 2021-12-14 15:19:26,310 [wrapper] ==== wrapper stdout END ====
[2021-12-14 16:19:26] 2021-12-14 15:19:26,324 [wrapper] ==== wrapper stderr END ====
[2021-12-14 16:19:26] 2021-12-14 15:19:26,354 [wrapper] wrapperexiting ec=0, duration=1401
[2021-12-14 16:19:26] 2021-12-14 15:19:26,370 [wrapper] apfmon messages muted
[2021-12-14 16:19:26]  *** Error codes and diagnostics ***
[2021-12-14 16:19:26]     "exeErrorCode": 0,
[2021-12-14 16:19:26]     "exeErrorDiag": "",
[2021-12-14 16:19:26]     "pilotErrorCode": 0,
[2021-12-14 16:19:26]     "pilotErrorDiag": "",
[2021-12-14 16:19:26]  *** Listing of results directory ***
[2021-12-14 16:19:26] insgesamt 7424
[2021-12-14 16:19:26] -rwx------. 1 boinc boinc   26860 14. Dez 13:28 runpilot2-wrapper.sh
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    4534 14. Dez 13:28 queuedata.json
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc  346481 14. Dez 13:28 pilot2.tar.gz
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     107 14. Dez 15:55 wrapper_26015_x86_64-pc-linux-gnu
[2021-12-14 16:19:26] -rwxr-xr-x. 1 boinc boinc    6970 14. Dez 15:55 run_atlas
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     112 14. Dez 15:55 job.xml
[2021-12-14 16:19:26] drwxrwx--x. 2 boinc boinc      68 14. Dez 15:55 shared
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    6179 14. Dez 15:55 init_data.xml
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc       0 14. Dez 15:55 boinc_lockfile
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      19 14. Dez 15:55 input.tar.gz -> shared/input.tar.gz
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      19 14. Dez 15:55 EVNT.04972714._000032.pool.root.1 -> shared/ATLAS.root_0
[2021-12-14 16:19:26] lrwxrwxrwx. 1 boinc boinc      21 14. Dez 15:55 start_atlas.sh -> shared/start_atlas.sh
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    2599 14. Dez 15:56 pandaJob.out
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1089445 14. Dez 15:56 agis_schedconf.cvmfs.json
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1919407 14. Dez 15:56 cric_ddmendpoints.json
[2021-12-14 16:19:26] drwx------. 4 boinc boinc     260 14. Dez 15:56 pilot2
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1653300 14. Dez 16:18 output.1.b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.pool.root
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc    1018 14. Dez 16:18 memory_monitor_summary.json
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  166815 14. Dez 16:18 b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.1.job.log.tgz
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc    6623 14. Dez 16:18 heartbeat.json
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     533 14. Dez 16:18 boinc_task_state.xml
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    8192 14. Dez 16:19 boinc_mmap_file
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc      25 14. Dez 16:19 wrapper_checkpoint.txt
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc    7636 14. Dez 16:19 pilotlog.txt
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  212341 14. Dez 16:19 b602ec88-7bbc-472e-b347-e0d41a1e07b3_84236.1.job.log
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc     536 14. Dez 16:19 output.list
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc     748 14. Dez 16:19 runtime_log
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 2048000 14. Dez 16:19 result.tar.gz
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc     558 14. Dez 16:19 th5LDmw5LH0n7Olcko1bjSoqABFKDmABFKDm1XmMDmoSFKDmbit3tn.diag
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    9325 14. Dez 16:19 runtime_log.err
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc   29797 14. Dez 16:19 stderr.txt
[2021-12-14 16:19:26] HITS file was successfully produced:
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc 1653300 14. Dez 16:18 shared/HITS.pool.root.1
[2021-12-14 16:19:26]  *** Contents of shared directory: ***
[2021-12-14 16:19:26] insgesamt 41380
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc   358340 14. Dez 15:55 input.tar.gz
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc 38288972 14. Dez 15:55 ATLAS.root_0
[2021-12-14 16:19:26] -rw-r--r--. 1 boinc boinc    16611 14. Dez 15:55 start_atlas.sh
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  1653300 14. Dez 16:18 HITS.pool.root.1
[2021-12-14 16:19:26] -rw-------. 1 boinc boinc  2048000 14. Dez 16:19 result.tar.gz
16:19:27 (788728): run_atlas exited; CPU time 970.820612
16:19:27 (788728): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN