Name QTAODmX6OPvnShfckohDCDFpABFKDmABFKDmQ6FKDmvBFKDmFdQMam_0
Workunit 1928615
Created 3 Sep 2019, 14:36:57 UTC
Sent 4 Sep 2019, 7:45:53 UTC
Report deadline 7 Sep 2019, 19:45:53 UTC
Received 4 Sep 2019, 8:44:15 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3931
Run time 17 min 49 sec
CPU time 28 min 21 sec
Validate state Valid
Credit 118.77
Device peak FLOPS 47.99 GFLOPS
Application version ATLAS Simulation v0.80 (vbox64_mt_mcore_atlas)
x86_64-pc-linux-gnu
Peak working set size 180.38 MB
Peak swap size 10.04 GB
Peak disk usage 5.05 GB

Stderr output

<core_client_version>7.16.1</core_client_version>
<![CDATA[
<stderr_txt>
2019-09-04 04:26:07 (4070): vboxwrapper (7.7.26197): starting
2019-09-04 04:26:07 (4070): Feature: Checkpoint interval offset (352 seconds)
2019-09-04 04:26:07 (4070): Detected: VirtualBox VboxManage Interface (Version: 6.0.10)
2019-09-04 04:26:07 (4070): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-09-04 04:26:07 (4070): Successfully copied 'init_data.xml' to the shared directory.
2019-09-04 04:26:08 (4070): Create VM. (boinc_543ec9c7fcb37aa2, slot#18)
2019-09-04 04:26:08 (4070): Setting Memory Size for VM. (10200MB)
2019-09-04 04:26:08 (4070): Setting CPU Count for VM. (8)
2019-09-04 04:26:08 (4070): Setting Chipset Options for VM.
2019-09-04 04:26:08 (4070): Setting Boot Options for VM.
2019-09-04 04:26:08 (4070): Setting Network Configuration for NAT.
2019-09-04 04:26:08 (4070): Enabling VM Network Access.
2019-09-04 04:26:08 (4070): Disabling USB Support for VM.
2019-09-04 04:26:08 (4070): Disabling COM Port Support for VM.
2019-09-04 04:26:08 (4070): Disabling LPT Port Support for VM.
2019-09-04 04:26:08 (4070): Disabling Audio Support for VM.
2019-09-04 04:26:08 (4070): Disabling Clipboard Support for VM.
2019-09-04 04:26:08 (4070): Disabling Drag and Drop Support for VM.
2019-09-04 04:26:08 (4070): Adding storage controller(s) to VM.
2019-09-04 04:26:09 (4070): Adding virtual disk drive to VM. (vm_image.vdi)
2019-09-04 04:26:09 (4070): Adding VirtualBox Guest Additions to VM.
2019-09-04 04:26:09 (4070): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-09-04 04:26:09 (4070): forwarding host port 34847 to guest port 80
2019-09-04 04:26:09 (4070): Enabling remote desktop for VM.
2019-09-04 04:26:09 (4070): Enabling shared directory for VM.
2019-09-04 04:26:09 (4070): Starting VM. (boinc_543ec9c7fcb37aa2, slot#18)
2019-09-04 04:26:10 (4070): Successfully started VM. (PID = '4579')
2019-09-04 04:26:10 (4070): Reporting VM Process ID to BOINC.
2019-09-04 04:26:10 (4070): Guest Log: BIOS: VirtualBox 6.0.10
2019-09-04 04:26:10 (4070): Guest Log: CPUID EDX: 0x178bfbff
2019-09-04 04:26:10 (4070): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-09-04 04:26:11 (4070): VM state change detected. (old = 'poweroff', new = 'running')
2019-09-04 04:26:11 (4070): Detected: Web Application Enabled (http://localhost:34847)
2019-09-04 04:26:11 (4070): Detected: Remote Desktop Enabled (localhost:40445)
2019-09-04 04:26:11 (4070): Preference change detected
2019-09-04 04:26:11 (4070): Setting CPU throttle for VM. (100%)
2019-09-04 04:26:11 (4070): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 900 seconds))
2019-09-04 04:26:13 (4070): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-09-04 04:26:13 (4070): Guest Log: BIOS: Booting from Hard Disk...
2019-09-04 04:26:15 (4070): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-09-04 04:26:15 (4070): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2019-09-04 04:26:15 (4070): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2019-09-04 04:26:20 (4070): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-09-04 04:26:21 (4070): Guest Log: VBoxService 5.2.16 r123759 (verbosity: 0) linux.amd64 (Jul 16 2018 17:06:52) release log
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000113 main     Log opened 2019-09-04T04:26:18.373684000Z
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000158 main     OS Product: Linux
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000175 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000188 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000201 main     Executable: /opt/VBoxGuestAdditions-5.2.16/sbin/VBoxService
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000202 main     Process ID: 1228
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000202 main     Package type: LINUX_64BITS_GENERIC
2019-09-04 04:26:21 (4070): Guest Log: 00:00:00.000656 main     5.2.16 r123759 started. Verbose level = 0
2019-09-04 04:26:22 (4070): Guest Log: Checking CVMFS...
2019-09-04 04:26:25 (4070): Guest Log: CVMFS is ok
2019-09-04 04:26:25 (4070): Guest Log: Mounting shared directory
2019-09-04 04:26:25 (4070): Guest Log: Copying input files
2019-09-04 04:26:27 (4070): Guest Log: Copied input files into RunAtlas.
2019-09-04 04:26:27 (4070): Guest Log: copied the webapp to /var/www
2019-09-04 04:26:27 (4070): Guest Log: This vm does not need to setup an http proxy
2019-09-04 04:26:27 (4070): Guest Log: ATHENA_PROC_NUMBER=8
2019-09-04 04:26:27 (4070): Guest Log:  *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-3) ***
2019-09-04 04:26:30 (4070): Guest Log: 00:00:10.001885 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 411 739 283 000ns (GuestNow=1 567 585 590 114 362 000 ns GuestLast=1 567 571 178 375 079 000 ns fSetTimeLastLoop=true )
2019-09-04 04:43:49 (4070): Guest Log:  *** Job finished ***
2019-09-04 04:43:49 (4070): Guest Log:  *** The last 20 lines of the pilot log: ***
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] ==== pilot stdout END ====
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] ==== wrapper stdout RESUME ====
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] Pilot exit status: 0
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] STATUSCODE: 0
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] apfmon messages muted
2019-09-04 04:43:49 (4070): Guest Log: ---- find pandaID.out ----
2019-09-04 04:43:49 (4070): Guest Log: total 48
2019-09-04 04:43:49 (4070): Guest Log: -rw-------.  1 atlas atlas 11357 Jul 25 14:38 LICENSE
2019-09-04 04:43:49 (4070): Guest Log: -rw-------.  1 atlas atlas     8 Aug 23 13:01 PILOTVERSION
2019-09-04 04:43:49 (4070): Guest Log: -rw-------.  1 atlas atlas  2251 Jul 25 14:38 README.md
2019-09-04 04:43:49 (4070): Guest Log: -rw-------.  1 atlas atlas   221 Jul 25 14:38 TODO.md
2019-09-04 04:43:49 (4070): Guest Log: drwx------. 14 atlas atlas   216 Sep  4 08:26 pilot
2019-09-04 04:43:49 (4070): Guest Log: -rwx------.  1 atlas atlas 20098 Aug 22 09:01 pilot.py
2019-09-04 04:43:49 (4070): Guest Log: -rw-------.  1 atlas atlas   760 Aug 22 09:01 setup.py
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] Test setup, not cleaning
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] ==== wrapper stdout END ====
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] ==== wrapper stderr END ====
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] wrapper wrapperexiting ec=0, duration=1042
2019-09-04 04:43:49 (4070): Guest Log: 2019-09-04 08:43:49 UTC [wrapper] apfmon messages muted
2019-09-04 04:43:49 (4070): Guest Log:  *** Error codes and diagnostics ***
2019-09-04 04:43:49 (4070): Guest Log:     "exeErrorCode": 0,
2019-09-04 04:43:49 (4070): Guest Log:     "exeErrorDiag": "",
2019-09-04 04:43:49 (4070): Guest Log:     "pilotErrorCode": 0,
2019-09-04 04:43:49 (4070): Guest Log:     "pilotErrorDiag": "",
2019-09-04 04:43:49 (4070): Guest Log:  *** Listing of results directory ***
2019-09-04 04:43:49 (4070): Guest Log: total 23472
2019-09-04 04:43:49 (4070): Guest Log: drwx------. 3 atlas atlas     190 Aug 23 13:01 pilot2
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas  255978 Sep  3 13:35 pilot2.tar.gz
2019-09-04 04:43:49 (4070): Guest Log: -rwx------. 1 atlas atlas   12641 Sep  3 14:36 runpilot2-wrapper.sh
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas    2938 Sep  3 14:36 pandaJobData.out
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas    8951 Sep  4 08:26 init_data.xml
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas     815 Sep  4 08:26 RTE.tar.gz
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas  262893 Sep  4 08:26 input.tar.gz
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas    8465 Sep  4 08:26 start_atlas.sh
2019-09-04 04:43:49 (4070): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Sep  4 08:26 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0
2019-09-04 04:43:49 (4070): Guest Log: drwxr-xr-x. 3 atlas atlas      17 Sep  4 08:26 APPS
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas    5077 Sep  4 08:26 queuedata.json
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 4152688 Sep  4 08:26 agis_schedconf.cvmfs.json
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 7487969 Sep  4 08:26 agis_ddmendpoints.json
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 9091322 Sep  4 08:42 HITS.000649-3283290-586._078090.pool.root.1
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas     837 Sep  4 08:42 memory_monitor_summary.json
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 1138149 Sep  4 08:42 log.000649-3283290-586._078090.job.log.tgz.1
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas   11006 Sep  4 08:42 heartbeat.json
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas   13030 Sep  4 08:43 pilotlog.txt
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas  179748 Sep  4 08:43 log.14568781._078090.job.log.1
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas     494 Sep  4 08:43 QTAODmX6OPvnShfckohDCDFpABFKDmABFKDmQ6FKDmvBFKDmFdQMam.diag
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas    6788 Sep  4 08:43 runtime_log.err
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas     421 Sep  4 08:43 output.list
2019-09-04 04:43:49 (4070): Guest Log: -rw-r--r--. 1 atlas atlas     616 Sep  4 08:43 runtime_log
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 1341440 Sep  4 08:43 result.tar.gz
2019-09-04 04:43:49 (4070): Guest Log: Looking for outputfile HITS.000649-3283290-586._078090.pool.root.1
2019-09-04 04:43:49 (4070): Guest Log: HITS file was successfully produced
2019-09-04 04:43:49 (4070): Guest Log: -rw-------. 1 atlas atlas 9091322 Sep  4 08:42 /home/atlas/RunAtlas/HITS.000649-3283290-586._078090.pool.root.1
2019-09-04 04:43:49 (4070): Guest Log: Successfully finished the ATLAS job!
2019-09-04 04:43:49 (4070): Guest Log: Copying the results back to the shared directory!
2019-09-04 04:43:49 (4070): Guest Log:  *** Success! Shutting down the machine. ***
2019-09-04 04:43:49 (4070): VM Completion File Detected.
2019-09-04 04:43:49 (4070): Powering off VM.
2019-09-04 04:43:50 (4070): Successfully stopped VM.
2019-09-04 04:43:50 (4070): Deregistering VM. (boinc_543ec9c7fcb37aa2, slot#18)
2019-09-04 04:43:50 (4070): Removing network bandwidth throttle group from VM.
2019-09-04 04:43:50 (4070): Removing storage controller(s) from VM.
2019-09-04 04:43:50 (4070): Removing VM from VirtualBox.
2019-09-04 04:43:50 (4070): Removing virtual disk drive from VirtualBox.
04:43:55 (4070): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN