Name 05JODmcDXc2n7Olcko1bjSoqABFKDmABFKDmgZyRDmDwLKDmcpw5ym_0
Workunit 2273280
Created 18 Jan 2023, 23:40:21 UTC
Sent 18 Jan 2023, 23:44:52 UTC
Report deadline 25 Jan 2023, 23:44:52 UTC
Received 19 Jan 2023, 0:02:35 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4721
Run time 9 min 19 sec
CPU time 7 min 0 sec
Validate state Valid
Credit 19.46
Device peak FLOPS 6.86 GFLOPS
Application version ATLAS Simulation v1.25 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.58 GB
Peak swap size 2.12 GB
Peak disk usage 81.43 MB

Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
00:53:01 (2781267): wrapper (7.7.26015): starting
00:53:01 (2781267): wrapper: running run_atlas (--nthreads 1)
[2023-01-19 00:53:01] Arguments: --nthreads 1
[2023-01-19 00:53:01] Threads: 1
[2023-01-19 00:53:01] Checking for CVMFS
[2023-01-19 00:53:04] Probing /cvmfs/atlas.cern.ch... OK
[2023-01-19 00:53:10] Probing /cvmfs/atlas-condb.cern.ch... OK
[2023-01-19 00:53:10] Running cvmfs_config stat atlas.cern.ch
[2023-01-19 00:53:14] 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-01-19 00:53:14] 2.10.0.0 2767614 8 38608 114720 0 80 2422136 4096001 0 130560 0 47889 99.937 17460 3357 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://10.116.178.201:3128 1
[2023-01-19 00:53:14] CVMFS is ok
[2023-01-19 00:53:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2023-01-19 00:53:14] Checking for apptainer binary...
[2023-01-19 00:53:14] Using apptainer found in PATH at /usr/bin/apptainer
[2023-01-19 00:53:14] Running /usr/bin/apptainer --version
[2023-01-19 00:53:14] apptainer version 1.1.4-2.el9
[2023-01-19 00:53:14] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2023-01-19 00:53:14] P620-CentOS9
[2023-01-19 00:53:14] apptainer works
[2023-01-19 00:53:14] Starting ATLAS job with PandaID=5725198586
[2023-01-19 00:53:14] Try creating a directory in /tmp
[2023-01-19 00:53:14] /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/65 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7  mktemp /tmp/tmp.XXXXX
[2023-01-19 00:53:15] /usr/bin/mktemp: failed to create file via template '/tmp/tmp.XXXXX': Read-only file system
[2023-01-19 00:53:15] mktemp /tmp failed
[2023-01-19 00:53:15] Try creating a directory in /var/tmp
[2023-01-19 00:53:15] /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/65 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7  mktemp /var/tmp/tmp.XXXXX
[2023-01-19 00:53:15] /usr/bin/mktemp: failed to create file via template '/var/tmp/tmp.XXXXX': Read-only file system
[2023-01-19 00:53:15] mktemp /var/tmp failed
[2023-01-19 00:53:15] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc/slots/65 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2023-01-19 01:02:17]  *** The last 200 lines of the pilot log: ***
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | DEBUG    | pilot.control.job                | send_state                | REACHED_MAXTIME=None
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | INFO     | pilot.control.job                | send_state                | pilot will not update the server (heartbeat message will be written to file)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | INFO     | pilot.control.job                | is_final_update           | job 5725198586 has finished - writing final server update
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics_string    | job definition core count: 1
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | DEBUG    | pilot.api.analytics              | get_fitted_data           | removing tails from data to be fitted
[2023-01-19 01:02:17] 2023-01-19 00:02:03,777 | WARNING  | pilot.api.analytics              | get_fitted_data           | wrong length of table data, x=[1674086348.0], y=[1737559.0] (must be same and length>=4)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,778 | DEBUG    | pilot.user.atlas.jobmetrics      | get_job_metrics           | job metrics="actualCoreCount=0.79 nEvents=2 dbTime=5.99 dbData=4274626 workDirSize=846924 eventnumbe
[2023-01-19 01:02:17] 2023-01-19 00:02:03,778 | INFO     | pilot.control.job                | get_data_structure        | total number of processed events: 2 (read)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,778 | INFO     | pilot.util.container             | print_executable          | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2023-01-19 01:02:17] 2023-01-19 00:02:03,792 | INFO     | pilot.user.atlas.utilities       | get_memory_values         | using path: /var/lib/boinc/slots/65/PanDA_Pilot-5725198586/memory_monitor_summary.json (trf name=prm
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | DEBUG    | pilot.user.atlas.utilities       | get_memory_monitor_info   | summary_dictionary={'Avg': {'nprocs': 4.875, 'nthreads': 5.75, 'pss': 1375921.0, 'rchar': 130840784.
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard info from prmon json
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.user.atlas.utilities       | get_memory_monitor_info   | extracted standard memory fields from prmon json
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . Timing measurements:
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . get job = 0 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . initial setup = 3 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . payload setup = 5 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . stage-in = 5 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . payload execution = 472 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | . stage-out = 5 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | INFO     | pilot.util.timing                | timing_report             | ..............................
[2023-01-19 01:02:17] 2023-01-19 00:02:03,793 | DEBUG    | pilot.control.job                | send_state                | data={'jobId': '5725198586', 'state': 'finished', 'timestamp': '2023-01-19T01:02:03+01:00', 'siteNam
[2023-01-19 01:02:17] 2023-01-19 00:02:03,794 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | heartbeat dictionary: {'jobId': '5725198586', 'state': 'finished', 'timestamp': '2023-01-19T01:02:03
[2023-01-19 01:02:17] 2023-01-19 00:02:03,794 | DEBUG    | pilot.control.job                | write_heartbeat_to_file   | wrote heartbeat to file: /var/lib/boinc/slots/65/heartbeat.json
[2023-01-19 01:02:17] 2023-01-19 00:02:03,852 | INFO     | pilot.control.job                | make_job_report           | 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,852 | INFO     | pilot.control.job                | make_job_report           | job summary report
[2023-01-19 01:02:17] 2023-01-19 00:02:03,852 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-01-19 01:02:17] 2023-01-19 00:02:03,852 | INFO     | pilot.control.job                | make_job_report           | PanDA job id: 5725198586
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | task id: NULL
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | errors: (none)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | status: LOG_TRANSFER = DONE 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | pilot state: finished 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | transexitcode: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | exeerrorcode: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | exeerrordiag: 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | exitcode: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | exitmsg: OK
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | cpuconsumptiontime: 425 s
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | nevents: 2
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | neventsw: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | pid: 2789705
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | pgrp: 2789705
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | corecount: 1
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | event service: False
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | sizes: {0: 2526946, 6: 2527152, 11: 2527180, 480: 2546424, 481: 2546423, 487: 2555531, 490: 2555715,
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | --------------------------------------------------
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.control.job                | make_job_report           | 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | DEBUG    | pilot.control.job                | has_job_completed         | ls -lF /var/lib/boinc/slots/65:
[2023-01-19 01:02:17] 
[2023-01-19 01:02:17] 2023-01-19 00:02:03,853 | INFO     | pilot.util.container             | print_executable          | executing command: ls -lF /var/lib/boinc/slots/65
[2023-01-19 01:02:17] 2023-01-19 00:02:03,856 | WARNING  | pilot.control.job                | check_job_monitor_waiting_time | no jobs in monitored_payloads queue (waited for 72 s)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | DEBUG    | pilot.control.job                | has_job_completed         | total 43996
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      145 Jan 19 00:53 05JODmcDXc2n7Olcko1bjSoqABFKDmABFKDmgZyRDmDwLKDmcpw5ym.diag
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   163333 Jan 19 01:02 14faea69-79e2-4efe-98a5-0fe364b51b11_62275.1.job.log
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   155549 Jan 19 01:01 14faea69-79e2-4efe-98a5-0fe364b51b11_62275.1.job.log.tgz
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc 38971704 Jan 19 00:53 EVNT.04972714._000035.pool.root.1
[2023-01-19 01:02:17] drwxrwx---. 2 boinc boinc     4096 Jan 19 01:01 PanDA_Pilot-5725198586/
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1697825 Jan 19 00:53 agis_ddmendpoints.agis.ALL.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1040896 Jan 19 00:53 agis_schedconf.cvmfs.json
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc        0 Jan 19 00:53 boinc_lockfile
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     8192 Jan 19 01:02 boinc_mmap_file
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      532 Jan 19 01:01 boinc_task_state.xml
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc     6522 Jan 19 01:02 heartbeat.json
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     6199 Jan 19 00:53 init_data.xml
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc   402910 Jan 19 00:53 input.tar.gz
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      112 Jan 19 00:53 job.xml
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc     1010 Jan 19 01:01 memory_monitor_summary.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1762150 Jan 19 01:01 output.1.14faea69-79e2-4efe-98a5-0fe364b51b11_62275.pool.root
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      464 Jan 19 01:01 output.list
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     2652 Jan 19 00:53 pandaJob.out
[2023-01-19 01:02:17] drwx------. 4 boinc boinc     4096 Jan 19 00:53 pilot3/
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   392447 Jan 19 00:40 pilot3.tar.gz
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   144823 Jan 19 01:02 pilotlog.txt
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     4540 Jan 19 00:40 queuedata.json
[2023-01-19 01:02:17] -rwxr-xr-x. 1 boinc boinc     8273 Jan 19 00:53 run_atlas*
[2023-01-19 01:02:17] -rwx------. 1 boinc boinc    26433 Jan 19 00:40 runpilot2-wrapper.sh*
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      407 Jan 19 00:53 runtime_log
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     6813 Jan 19 00:53 runtime_log.err
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      464 Jan 19 00:53 setup.sh.local
[2023-01-19 01:02:17] drwxrwx--x. 2 boinc boinc       68 Jan 19 00:53 shared/
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc    17790 Jan 19 00:53 start_atlas.sh
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     2430 Jan 19 00:53 stderr.txt
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      107 Jan 19 00:53 wrapper_26015_x86_64-pc-linux-gnu
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc       24 Jan 19 01:02 wrapper_checkpoint.txt
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue jobs had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_in had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue data_out had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue current_data_in had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_jobs had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue validated_payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue monitored_payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_jobs had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,864 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_in had 1 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue finished_data_out had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_jobs had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_in had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue failed_data_out had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobs had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue completed_jobids has 1 job(s)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue realtimelog_payloads had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.queuehandling         | queue_report              | queue messages had 0 job(s) [purged]
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.control.job                | has_job_completed         | job 5725198586 has completed (purged errors)
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | DEBUG    | pilot.util.realtimelogger        | cleanup                   | attempting real-time logger cleanup
[2023-01-19 01:02:17] 2023-01-19 00:02:03,865 | INFO     | pilot.util.processes             | cleanup                   | overall cleanup function is called
[2023-01-19 01:02:17] 2023-01-19 00:02:03,866 | DEBUG    | pilot.util.processes             | cleanup                   | work directory was removed: /var/lib/boinc/slots/65/PanDA_Pilot-5725198586
[2023-01-19 01:02:17] 2023-01-19 00:02:04,871 | INFO     | pilot.info.jobdata               | collect_zombies           | --- collectZombieJob: --- 10, [2789705]
[2023-01-19 01:02:17] 2023-01-19 00:02:04,872 | INFO     | pilot.info.jobdata               | collect_zombies           | zombie collector trying to kill pid 2789705
[2023-01-19 01:02:17] 2023-01-19 00:02:04,872 | INFO     | pilot.info.jobdata               | collect_zombies           | harmless exception when collecting zombies: [Errno 10] No child processes
[2023-01-19 01:02:17] 2023-01-19 00:02:05,878 | INFO     | pilot.util.processes             | cleanup                   | collected zombie processes
[2023-01-19 01:02:17] 2023-01-19 00:02:05,878 | INFO     | pilot.util.processes             | cleanup                   | will now attempt to kill all subprocesses of pid=2789705
[2023-01-19 01:02:17] 2023-01-19 00:02:05,909 | INFO     | pilot.util.processes             | kill_processes            | process IDs to be killed: [2789705] (in reverse order)
[2023-01-19 01:02:17] 2023-01-19 00:02:05,925 | WARNING  | pilot.util.processes             | kill_processes            | found no corresponding commands to process id(s)
[2023-01-19 01:02:17] 2023-01-19 00:02:05,925 | INFO     | pilot.util.processes             | kill_orphans              | Do not look for orphan processes in BOINC jobs
[2023-01-19 01:02:17] 2023-01-19 00:02:05,925 | DEBUG    | pilot.util.queuehandling         | purge_queue               | queue purged
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.control.job                | retrieve                  | ready for new job
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | root                             | retrieve                  | pilot has finished with previous job - re-establishing logging
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***  PanDA Pilot version 3.4.9 (3)  ***
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | 
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | pilot is running in a VM
[2023-01-19 01:02:17] 2023-01-19 00:02:05,926 | INFO     | pilot.util.auxiliary             | display_architecture_info | architecture information:
[2023-01-19 01:02:17] 2023-01-19 00:02:05,953 | INFO     | pilot.util.auxiliary             | display_architecture_info | 
[2023-01-19 01:02:17] LSB Version:	:core-4.1-amd64:core-4.1-noarch
[2023-01-19 01:02:17] Distributor ID:	CentOS
[2023-01-19 01:02:17] Description:	CentOS Linux release 7.9.2009 (Core)
[2023-01-19 01:02:17] Release:	7.9.2009
[2023-01-19 01:02:17] Codename:	Core
[2023-01-19 01:02:17] 2023-01-19 00:02:05,953 | INFO     | pilot.util.auxiliary             | pilot_version_banner      | ***************************************
[2023-01-19 01:02:17] 2023-01-19 00:02:06,456 | DEBUG    | pilot.util.monitoring            | check_local_space         | checking local space on /var/lib/boinc/slots/65
[2023-01-19 01:02:17] 2023-01-19 00:02:06,456 | INFO     | pilot.util.container             | print_executable          | executing command: df -mP /var/lib/boinc/slots/65
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stdout=Filesystem          1048576-blocks  Used Available Capacity Mounted on
[2023-01-19 01:02:17] /dev/mapper/cs-root          31213  9737     21477      32% /var/lib/boinc/slots/65
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | DEBUG    | pilot.util.workernode            | get_local_disk_space      | stderr=
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | INFO     | pilot.util.monitoring            | check_local_space         | sufficient remaining disk space (22520266752 B)
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | WARNING  | pilot.control.job                | proceed_with_getjob       | since timefloor is set to 0, pilot was only allowed to run one job
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | DEBUG    | pilot.control.job                | retrieve                  | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,464 | INFO     | pilot.control.job                | retrieve                  | [job] retrieve thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,465 | WARNING  | pilot.util.common                | should_abort              | data:copytool_out:received graceful stop - abort after this iteration
[2023-01-19 01:02:17] 2023-01-19 00:02:06,465 | WARNING  | pilot.control.monitor            | control                   | aborting monitor loop since graceful_stop has been set
[2023-01-19 01:02:17] 2023-01-19 00:02:06,465 | INFO     | pilot.control.monitor            | control                   | [monitor] control thread has ended
[2023-01-19 01:02:17] 2023-01-19 00:02:06,470 | DEBUG    | pilot.control.data               | control                   | data control ending since graceful_stop has been set
[2023-01-19 01:02:17] 2023-01-19 00:02:06,471 | DEBUG    | pilot.control.data               | control                   | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,471 | INFO     | pilot.control.data               | control                   | [data] control thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,686 | DEBUG    | pilot.control.payload            | execute_payloads          | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,686 | INFO     | pilot.control.payload            | execute_payloads          | [payload] execute_payloads thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,739 | DEBUG    | pilot.control.job                | validate                  | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,740 | INFO     | pilot.control.job                | validate                  | [job] validate thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,740 | DEBUG    | pilot.control.payload            | validate_pre              | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,740 | INFO     | pilot.control.payload            | validate_pre              | [payload] validate_pre thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,740 | DEBUG    | pilot.control.job                | create_data_payload       | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,740 | INFO     | pilot.control.job                | create_data_payload       | [job] create_data_payload thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,744 | DEBUG    | pilot.control.data               | copytool_in               | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:06,744 | INFO     | pilot.control.data               | copytool_in               | [data] copytool_in thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:06,867 | WARNING  | pilot.util.common                | should_abort              | job:job_monitor:received graceful stop - abort after this iteration
[2023-01-19 01:02:17] 2023-01-19 00:02:07,465 | DEBUG    | pilot.control.data               | copytool_out              | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:07,465 | INFO     | pilot.control.data               | copytool_out              | [data] copytool_out thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:07,515 | DEBUG    | pilot.control.payload            | failed_post               | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:07,516 | INFO     | pilot.control.payload            | failed_post               | [payload] failed_post thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:07,778 | DEBUG    | pilot.control.payload            | control                   | payload control ending since graceful_stop has been set
[2023-01-19 01:02:17] 2023-01-19 00:02:07,779 | DEBUG    | pilot.control.payload            | control                   | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:07,779 | INFO     | pilot.control.payload            | control                   | [payload] control thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:07,873 | DEBUG    | pilot.control.job                | job_monitor               | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:07,873 | INFO     | pilot.control.job                | job_monitor               | [job] job monitor thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:07,879 | DEBUG    | pilot.control.job                | control                   | job control ending since graceful_stop has been set
[2023-01-19 01:02:17] 2023-01-19 00:02:07,879 | DEBUG    | pilot.control.job                | control                   | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:07,879 | INFO     | pilot.control.job                | control                   | [job] control thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:08,047 | DEBUG    | pilot.control.payload            | validate_post             | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:08,047 | INFO     | pilot.control.payload            | validate_post             | [payload] validate_post thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:08,658 | WARNING  | pilot.util.common                | should_abort              | data:queue_monitoring:received graceful stop - abort after this iteration
[2023-01-19 01:02:17] 2023-01-19 00:02:08,862 | WARNING  | pilot.util.common                | should_abort              | job:queue_monitor:received graceful stop - abort after this iteration
[2023-01-19 01:02:17] 2023-01-19 00:02:08,862 | DEBUG    | pilot.control.job                | queue_monitor             | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:08,862 | INFO     | pilot.control.job                | queue_monitor             | [job] queue monitor thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:11,659 | DEBUG    | pilot.control.data               | queue_monitoring          | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:11,659 | INFO     | pilot.control.data               | queue_monitoring          | [data] queue_monitor thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:16,639 | INFO     | pilot.control.payload            | get_logging_info          | job.realtimelogging is not enabled
[2023-01-19 01:02:17] 2023-01-19 00:02:16,639 | DEBUG    | pilot.control.payload            | run_realtimelog           | real-time logging not needed at this point
[2023-01-19 01:02:17] 2023-01-19 00:02:16,639 | DEBUG    | pilot.control.payload            | run_realtimelog           | realtime logger was not found, waiting ..
[2023-01-19 01:02:17] 2023-01-19 00:02:16,639 | DEBUG    | pilot.control.payload            | run_realtimelog           | will not set job_aborted yet
[2023-01-19 01:02:17] 2023-01-19 00:02:16,639 | INFO     | pilot.control.payload            | run_realtimelog           | [payload] run_realtimelog thread has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:17,576 | 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-01-19 01:02:17] 2023-01-19 00:02:17,576 | DEBUG    | pilot.workflow.generic           | run                       | all relevant threads have aborted (thread count=1)
[2023-01-19 01:02:17] 2023-01-19 00:02:17,576 | INFO     | pilot.workflow.generic           | run                       | end of generic workflow (traces error code: 0)
[2023-01-19 01:02:17] 2023-01-19 00:02:17,576 | INFO     | root                             | wrap_up                   | traces error code: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:17,576 | INFO     | root                             | wrap_up                   | pilot has finished
[2023-01-19 01:02:17] 2023-01-19 00:02:17,619 [wrapper] ==== pilot stdout END ====
[2023-01-19 01:02:17] 2023-01-19 00:02:17,620 [wrapper] ==== wrapper stdout RESUME ====
[2023-01-19 01:02:17] 2023-01-19 00:02:17,621 [wrapper] pilotpid: 2786688
[2023-01-19 01:02:17] 2023-01-19 00:02:17,623 [wrapper] Pilot exit status: 0
[2023-01-19 01:02:17] 2023-01-19 00:02:17,630 [wrapper] pandaids: 5725198586
[2023-01-19 01:02:17] 2023-01-19 00:02:17,632 [wrapper] apfmon messages muted
[2023-01-19 01:02:17] 2023-01-19 00:02:17,633 [wrapper] Test setup, not cleaning
[2023-01-19 01:02:17] 2023-01-19 00:02:17,634 [wrapper] ==== wrapper stdout END ====
[2023-01-19 01:02:17] 2023-01-19 00:02:17,635 [wrapper] ==== wrapper stderr END ====
[2023-01-19 01:02:17] 2023-01-19 00:02:17,638 [wrapper] wrapperexiting ec=0, duration=537
[2023-01-19 01:02:17] 2023-01-19 00:02:17,639 [wrapper] apfmon messages muted
[2023-01-19 01:02:17]  *** Error codes and diagnostics ***
[2023-01-19 01:02:17]     "exeErrorCode": 0,
[2023-01-19 01:02:17]     "exeErrorDiag": "",
[2023-01-19 01:02:17]     "pilotErrorCode": 0,
[2023-01-19 01:02:17]     "pilotErrorDiag": "",
[2023-01-19 01:02:17]  *** Listing of results directory ***
[2023-01-19 01:02:17] insgesamt 45840
[2023-01-19 01:02:17] -rwx------. 1 boinc boinc    26433 19. Jan 00:40 runpilot2-wrapper.sh
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     4540 19. Jan 00:40 queuedata.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   392447 19. Jan 00:40 pilot3.tar.gz
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      107 19. Jan 00:53 wrapper_26015_x86_64-pc-linux-gnu
[2023-01-19 01:02:17] -rwxr-xr-x. 1 boinc boinc     8273 19. Jan 00:53 run_atlas
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      112 19. Jan 00:53 job.xml
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     6199 19. Jan 00:53 init_data.xml
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc 38971704 19. Jan 00:53 EVNT.04972714._000035.pool.root.1
[2023-01-19 01:02:17] drwxrwx--x. 2 boinc boinc       68 19. Jan 00:53 shared
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc   402910 19. Jan 00:53 input.tar.gz
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc    17790 19. Jan 00:53 start_atlas.sh
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc        0 19. Jan 00:53 boinc_lockfile
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     2652 19. Jan 00:53 pandaJob.out
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      464 19. Jan 00:53 setup.sh.local
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1040896 19. Jan 00:53 agis_schedconf.cvmfs.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1697825 19. Jan 00:53 agis_ddmendpoints.agis.ALL.json
[2023-01-19 01:02:17] drwx------. 4 boinc boinc     4096 19. Jan 00:53 pilot3
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1762150 19. Jan 01:01 output.1.14faea69-79e2-4efe-98a5-0fe364b51b11_62275.pool.root
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc     1010 19. Jan 01:01 memory_monitor_summary.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   155549 19. Jan 01:01 14faea69-79e2-4efe-98a5-0fe364b51b11_62275.1.job.log.tgz
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      532 19. Jan 01:01 boinc_task_state.xml
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc     8192 19. Jan 01:02 boinc_mmap_file
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc       24 19. Jan 01:02 wrapper_checkpoint.txt
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc     6522 19. Jan 01:02 heartbeat.json
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc     9050 19. Jan 01:02 pilotlog.txt
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc   180422 19. Jan 01:02 14faea69-79e2-4efe-98a5-0fe364b51b11_62275.1.job.log
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      464 19. Jan 01:02 output.list
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc    10936 19. Jan 01:02 runtime_log.err
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc      748 19. Jan 01:02 runtime_log
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  2119680 19. Jan 01:02 result.tar.gz
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc      627 19. Jan 01:02 05JODmcDXc2n7Olcko1bjSoqABFKDmABFKDmgZyRDmDwLKDmcpw5ym.diag
[2023-01-19 01:02:17] -rw-r--r--. 1 boinc boinc    31327 19. Jan 01:02 stderr.txt
[2023-01-19 01:02:17] HITS file was successfully produced:
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc 1762150 19. Jan 01:01 shared/HITS.pool.root.1
[2023-01-19 01:02:17]  *** Contents of shared directory: ***
[2023-01-19 01:02:17] insgesamt 42272
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc 38971704 19. Jan 00:53 ATLAS.root_0
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc   402910 19. Jan 00:53 input.tar.gz
[2023-01-19 01:02:17] -rw-r--r--. 2 boinc boinc    17790 19. Jan 00:53 start_atlas.sh
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  1762150 19. Jan 01:01 HITS.pool.root.1
[2023-01-19 01:02:17] -rw-------. 1 boinc boinc  2119680 19. Jan 01:02 result.tar.gz
01:02:19 (2781267): run_atlas exited; CPU time 420.370061
01:02:19 (2781267): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN