Name 514KDm1JGN0n7Olcko1bjSoqABFKDmABFKDm1XmMDmL7FKDmmXloSm_0
Workunit 2151786
Created 30 Dec 2021, 19:31:17 UTC
Sent 30 Dec 2021, 19:33:51 UTC
Report deadline 6 Jan 2022, 19:33:51 UTC
Received 8 Jan 2022, 4:44:55 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3903
Run time 6 days 2 hours 34 min 38 sec
CPU time 1 hours 26 min 2 sec
Validate state Valid
Credit 627.51
Device peak FLOPS 3.53 GFLOPS
Application version ATLAS Simulation v1.08 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 86.63 MB
Peak swap size 120.56 MB
Peak disk usage 2.57 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2021-12-30 12:35:07 (16152): Detected: vboxwrapper 26202
2021-12-30 12:35:07 (16152): Detected: BOINC client v7.14.2
2021-12-30 12:35:08 (16152): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2021-12-30 12:35:08 (16152): Successfully copied 'init_data.xml' to the shared directory.
2021-12-30 12:35:11 (16152): Create VM. (boinc_f0610f18c1f63976, slot#6)
2021-12-30 12:35:13 (16152): Setting Memory Size for VM. (3900MB)
2021-12-30 12:35:14 (16152): Setting CPU Count for VM. (1)
2021-12-30 12:35:14 (16152): Setting Chipset Options for VM.
2021-12-30 12:35:15 (16152): Setting Boot Options for VM.
2021-12-30 12:35:15 (16152): Setting Network Configuration for NAT.
2021-12-30 12:35:16 (16152): Enabling VM Network Access.
2021-12-30 12:35:16 (16152): Disabling USB Support for VM.
2021-12-30 12:35:17 (16152): Disabling COM Port Support for VM.
2021-12-30 12:35:17 (16152): Disabling LPT Port Support for VM.
2021-12-30 12:35:17 (16152): Disabling Audio Support for VM.
2021-12-30 12:35:18 (16152): Disabling Clipboard Support for VM.
2021-12-30 12:35:18 (16152): Disabling Drag and Drop Support for VM.
2021-12-30 12:35:18 (16152): Adding storage controller(s) to VM.
2021-12-30 12:35:18 (16152): Adding virtual disk drive to VM. (vm_image.vdi)
2021-12-30 12:35:19 (16152): Adding VirtualBox Guest Additions to VM.
2021-12-30 12:35:19 (16152): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-12-30 12:35:19 (16152): forwarding host port 65424 to guest port 80
2021-12-30 12:35:20 (16152): Enabling remote desktop for VM.
2021-12-30 12:35:21 (16152): Enabling shared directory for VM.
2021-12-30 12:35:21 (16152): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2021-12-30 12:35:27 (16152): Successfully started VM. (PID = '5332')
2021-12-30 12:35:27 (16152): Reporting VM Process ID to BOINC.
2021-12-30 12:35:27 (16152): Guest Log: BIOS: VirtualBox 6.0.16
2021-12-30 12:35:27 (16152): Guest Log: CPUID EDX: 0x178bfbff
2021-12-30 12:35:27 (16152): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2021-12-30 12:35:27 (16152): VM state change detected. (old = 'poweredoff', new = 'running')
2021-12-30 12:35:27 (16152): Detected: Web Application Enabled (http://localhost:65424)
2021-12-30 12:35:27 (16152): Detected: Remote Desktop Enabled (localhost:65433)
2021-12-30 12:35:27 (16152): Preference change detected
2021-12-30 12:35:27 (16152): Setting CPU throttle for VM. (70%)
2021-12-30 12:35:28 (16152): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2021-12-30 12:35:29 (16152): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2021-12-30 12:35:29 (16152): Guest Log: BIOS: Booting from Hard Disk...
2021-12-30 12:35:33 (16152): Guest Log: BIOS: KBD: unsupported int 16h function 03
2021-12-30 12:35:33 (16152): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2021-12-30 12:35:33 (16152): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2021-12-30 12:35:44 (16152): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2021-12-30 12:35:44 (16152): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2021-12-30 12:35:57 (16152): Guest Log: Checking CVMFS...
2021-12-30 12:36:16 (16152): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000284 main     Log opened 2021-12-30T12:36:14.496655000Z
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000416 main     OS Product: Linux
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000468 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000511 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000555 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000557 main     Process ID: 1388
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.000559 main     Package type: LINUX_64BITS_GENERIC
2021-12-30 12:36:16 (16152): Guest Log: 00:00:00.002339 main     5.2.32 r132073 started. Verbose level = 0
2021-12-30 12:36:26 (16152): Guest Log: 00:00:10.053627 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 211 682 520 000ns (GuestNow=1 640 892 986 232 249 000 ns GuestLast=1 640 867 774 549 729 000 ns fSetTimeLastLoop=true )
2021-12-30 14:15:34 (16152): Status Report: Elapsed Time: '6000.015368'
2021-12-30 14:15:34 (16152): Status Report: CPU Time: '91.500000'
2021-12-30 15:55:40 (16152): Status Report: Elapsed Time: '12000.015368'
2021-12-30 15:55:40 (16152): Status Report: CPU Time: '125.828125'
2021-12-30 17:35:47 (16152): Status Report: Elapsed Time: '18000.015368'
2021-12-30 17:35:47 (16152): Status Report: CPU Time: '164.625000'
2021-12-30 19:15:54 (16152): Status Report: Elapsed Time: '24000.015368'
2021-12-30 19:15:54 (16152): Status Report: CPU Time: '213.406250'
2021-12-30 20:56:00 (16152): Status Report: Elapsed Time: '30000.015368'
2021-12-30 20:56:00 (16152): Status Report: CPU Time: '262.921875'
2021-12-30 22:36:06 (16152): Status Report: Elapsed Time: '36000.015368'
2021-12-30 22:36:06 (16152): Status Report: CPU Time: '303.078125'
2021-12-31 00:16:13 (16152): Status Report: Elapsed Time: '42000.015368'
2021-12-31 00:16:13 (16152): Status Report: CPU Time: '339.781250'
2021-12-31 01:56:20 (16152): Status Report: Elapsed Time: '48000.015368'
2021-12-31 01:56:20 (16152): Status Report: CPU Time: '373.171875'
2021-12-31 03:36:27 (16152): Status Report: Elapsed Time: '54000.015368'
2021-12-31 03:36:27 (16152): Status Report: CPU Time: '407.937500'
2021-12-31 05:16:35 (16152): Status Report: Elapsed Time: '60000.015368'
2021-12-31 05:16:35 (16152): Status Report: CPU Time: '446.046875'
2021-12-31 06:56:41 (16152): Status Report: Elapsed Time: '66000.015368'
2021-12-31 06:56:41 (16152): Status Report: CPU Time: '477.015625'
2021-12-31 08:36:48 (16152): Status Report: Elapsed Time: '72000.015368'
2021-12-31 08:36:48 (16152): Status Report: CPU Time: '514.593750'
2021-12-31 10:16:55 (16152): Status Report: Elapsed Time: '78000.015368'
2021-12-31 10:16:55 (16152): Status Report: CPU Time: '549.843750'
2021-12-31 11:57:03 (16152): Status Report: Elapsed Time: '84000.015368'
2021-12-31 11:57:03 (16152): Status Report: CPU Time: '591.968750'
2021-12-31 13:37:11 (16152): Status Report: Elapsed Time: '90000.015368'
2021-12-31 13:37:11 (16152): Status Report: CPU Time: '628.859375'
2021-12-31 15:17:18 (16152): Status Report: Elapsed Time: '96000.015368'
2021-12-31 15:17:18 (16152): Status Report: CPU Time: '664.046875'
2021-12-31 16:57:25 (16152): Status Report: Elapsed Time: '102000.015368'
2021-12-31 16:57:25 (16152): Status Report: CPU Time: '702.281250'
2021-12-31 18:37:32 (16152): Status Report: Elapsed Time: '108000.015368'
2021-12-31 18:37:32 (16152): Status Report: CPU Time: '733.937500'
2021-12-31 20:17:39 (16152): Status Report: Elapsed Time: '114000.015368'
2021-12-31 20:17:39 (16152): Status Report: CPU Time: '772.375000'
2021-12-31 21:57:46 (16152): Status Report: Elapsed Time: '120000.015368'
2021-12-31 21:57:46 (16152): Status Report: CPU Time: '806.328125'
2021-12-31 23:37:54 (16152): Status Report: Elapsed Time: '126000.015368'
2021-12-31 23:37:54 (16152): Status Report: CPU Time: '841.703125'
2022-01-01 01:18:01 (16152): Status Report: Elapsed Time: '132000.015368'
2022-01-01 01:18:01 (16152): Status Report: CPU Time: '879.359375'
2022-01-01 02:58:08 (16152): Status Report: Elapsed Time: '138000.015368'
2022-01-01 02:58:08 (16152): Status Report: CPU Time: '910.234375'
2022-01-01 04:38:16 (16152): Status Report: Elapsed Time: '144000.015368'
2022-01-01 04:38:16 (16152): Status Report: CPU Time: '946.734375'
2022-01-01 06:18:23 (16152): Status Report: Elapsed Time: '150000.015368'
2022-01-01 06:18:23 (16152): Status Report: CPU Time: '981.343750'
2022-01-01 07:58:30 (16152): Status Report: Elapsed Time: '156000.015368'
2022-01-01 07:58:30 (16152): Status Report: CPU Time: '1012.265625'
2022-01-01 09:38:37 (16152): Status Report: Elapsed Time: '162000.015368'
2022-01-01 09:38:37 (16152): Status Report: CPU Time: '1048.531250'
2022-01-01 11:18:44 (16152): Status Report: Elapsed Time: '168000.015368'
2022-01-01 11:18:44 (16152): Status Report: CPU Time: '1081.093750'
2022-01-01 12:58:52 (16152): Status Report: Elapsed Time: '174000.015368'
2022-01-01 12:58:52 (16152): Status Report: CPU Time: '1115.656250'
2022-01-01 14:38:59 (16152): Status Report: Elapsed Time: '180000.015368'
2022-01-01 14:38:59 (16152): Status Report: CPU Time: '1151.359375'
2022-01-01 16:19:06 (16152): Status Report: Elapsed Time: '186000.015368'
2022-01-01 16:19:06 (16152): Status Report: CPU Time: '1189.703125'
2022-01-01 17:59:13 (16152): Status Report: Elapsed Time: '192000.015368'
2022-01-01 17:59:13 (16152): Status Report: CPU Time: '1225.406250'
2022-01-01 19:39:20 (16152): Status Report: Elapsed Time: '198000.015368'
2022-01-01 19:39:20 (16152): Status Report: CPU Time: '1267.984375'
2022-01-01 21:19:27 (16152): Status Report: Elapsed Time: '204000.015368'
2022-01-01 21:19:27 (16152): Status Report: CPU Time: '1316.656250'
2022-01-01 22:59:34 (16152): Status Report: Elapsed Time: '210000.015368'
2022-01-01 22:59:34 (16152): Status Report: CPU Time: '1367.500000'
2022-01-02 00:36:48 (16152): VM state change detected. (old = 'running', new = 'paused')
2022-01-02 01:37:41 (16152): VM state change detected. (old = 'paused', new = 'running')
2022-01-02 01:37:42 (16152): Guest Log: 60:00:33.449463 timesync vgsvcTimeSyncWorker: Radical host time change: 3 663 059 000 000ns (HostNow=1 641 112 662 684 000 000 ns HostLast=1 641 108 999 625 000 000 ns)
2022-01-02 01:37:52 (16152): Guest Log: 60:00:43.450196 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 663 056 610 000ns (GuestNow=1 641 112 672 684 744 000 ns GuestLast=1 641 109 009 628 134 000 ns fSetTimeLastLoop=true )
2022-01-02 01:40:35 (16152): Status Report: Elapsed Time: '216000.015368'
2022-01-02 01:40:35 (16152): Status Report: CPU Time: '1416.656250'
2022-01-02 03:20:41 (16152): Status Report: Elapsed Time: '222000.015368'
2022-01-02 03:20:41 (16152): Status Report: CPU Time: '1455.140625'
2022-01-02 05:00:49 (16152): Status Report: Elapsed Time: '228000.015368'
2022-01-02 05:00:49 (16152): Status Report: CPU Time: '1491.156250'
2022-01-02 06:40:56 (16152): Status Report: Elapsed Time: '234000.015368'
2022-01-02 06:40:56 (16152): Status Report: CPU Time: '1522.656250'
2022-01-02 08:21:03 (16152): Status Report: Elapsed Time: '240000.015368'
2022-01-02 08:21:03 (16152): Status Report: CPU Time: '1560.281250'
2022-01-02 10:01:11 (16152): Status Report: Elapsed Time: '246000.015368'
2022-01-02 10:01:11 (16152): Status Report: CPU Time: '1595.468750'
2022-01-02 11:41:18 (16152): Status Report: Elapsed Time: '252000.015368'
2022-01-02 11:41:18 (16152): Status Report: CPU Time: '1625.890625'
2022-01-02 13:21:27 (16152): Status Report: Elapsed Time: '258000.015368'
2022-01-02 13:21:27 (16152): Status Report: CPU Time: '1660.515625'
2022-01-02 15:01:34 (16152): Status Report: Elapsed Time: '264000.015368'
2022-01-02 15:01:34 (16152): Status Report: CPU Time: '1699.375000'
2022-01-02 16:41:41 (16152): Status Report: Elapsed Time: '270000.015368'
2022-01-02 16:41:41 (16152): Status Report: CPU Time: '1736.000000'
2022-01-02 17:57:07 (16152): VM state change detected. (old = 'running', new = 'paused')
2022-01-02 19:50:33 (16152): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_f0610f18c1f63976" resume
Output:
VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 409 of file VBoxManageControlVM.cpp

2022-01-02 19:50:33 (16152): Guest Log: 76:20:07.006736 timesync vgsvcTimeSyncWorker: Radical host time change: 6 806 750 000 000ns (HostNow=1 641 178 232 990 000 000 ns HostLast=1 641 171 426 240 000 000 ns)
2022-01-02 19:50:33 (16152): VM state change detected. (old = 'paused', new = 'running')
2022-01-02 19:50:43 (16152): Guest Log: 76:20:17.007304 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 806 749 297 000ns (GuestNow=1 641 178 242 990 573 000 ns GuestLast=1 641 171 436 241 276 000 ns fSetTimeLastLoop=true )
2022-01-02 20:01:07 (16152): VM state change detected. (old = 'running', new = 'paused')
2022-01-02 20:10:59 (16152): VM state change detected. (old = 'paused', new = 'running')
2022-01-02 20:25:09 (16152): Status Report: Elapsed Time: '276000.015368'
2022-01-02 20:25:09 (16152): Status Report: CPU Time: '1771.750000'
2022-01-02 21:11:19 (16152): VM state change detected. (old = 'running', new = 'paused')
2022-01-02 21:43:20 (16152): VM state change detected. (old = 'paused', new = 'running')
2022-01-02 21:43:25 (16152): Guest Log: 77:31:07.267065 timesync vgsvcTimeSyncWorker: Radical host time change: 1 930 301 000 000ns (HostNow=1 641 185 004 254 000 000 ns HostLast=1 641 183 073 953 000 000 ns)
2022-01-02 21:43:35 (16152): Guest Log: 77:31:17.268305 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 521 004 936 000ns (GuestNow=1 641 185 014 255 253 000 ns GuestLast=1 641 182 493 250 317 000 ns fSetTimeLastLoop=true )
2022-01-02 22:37:17 (16152): Status Report: Elapsed Time: '282000.015368'
2022-01-02 22:37:17 (16152): Status Report: CPU Time: '1815.156250'
2022-01-03 00:17:25 (16152): Status Report: Elapsed Time: '288000.015368'
2022-01-03 00:17:25 (16152): Status Report: CPU Time: '1853.578125'
2022-01-03 01:57:32 (16152): Status Report: Elapsed Time: '294000.015368'
2022-01-03 01:57:32 (16152): Status Report: CPU Time: '1889.515625'
2022-01-03 03:37:39 (16152): Status Report: Elapsed Time: '300000.015368'
2022-01-03 03:37:39 (16152): Status Report: CPU Time: '1922.921875'
2022-01-03 05:17:46 (16152): Status Report: Elapsed Time: '306000.015368'
2022-01-03 05:17:46 (16152): Status Report: CPU Time: '1962.656250'
2022-01-03 06:57:53 (16152): Status Report: Elapsed Time: '312000.015368'
2022-01-03 06:57:53 (16152): Status Report: CPU Time: '1994.250000'
2022-01-03 08:38:00 (16152): Status Report: Elapsed Time: '318000.015368'
2022-01-03 08:38:00 (16152): Status Report: CPU Time: '2029.500000'
2022-01-03 10:18:07 (16152): Status Report: Elapsed Time: '324000.015368'
2022-01-03 10:18:07 (16152): Status Report: CPU Time: '2067.656250'
2022-01-03 11:58:14 (16152): Status Report: Elapsed Time: '330000.015368'
2022-01-03 11:58:14 (16152): Status Report: CPU Time: '2099.546875'
2022-01-03 13:38:22 (16152): Status Report: Elapsed Time: '336000.781610'
2022-01-03 13:38:22 (16152): Status Report: CPU Time: '2130.875000'
2022-01-03 15:18:29 (16152): Status Report: Elapsed Time: '342000.781610'
2022-01-03 15:18:29 (16152): Status Report: CPU Time: '2167.796875'
2022-01-03 16:58:36 (16152): Status Report: Elapsed Time: '348000.781610'
2022-01-03 16:58:36 (16152): Status Report: CPU Time: '2206.796875'
2022-01-03 18:38:43 (16152): Status Report: Elapsed Time: '354000.781610'
2022-01-03 18:38:43 (16152): Status Report: CPU Time: '2237.656250'
2022-01-03 20:18:51 (16152): Status Report: Elapsed Time: '360000.781610'
2022-01-03 20:18:51 (16152): Status Report: CPU Time: '2273.093750'
2022-01-03 21:58:58 (16152): Status Report: Elapsed Time: '366000.781610'
2022-01-03 21:58:58 (16152): Status Report: CPU Time: '2305.093750'
2022-01-03 23:19:45 (16152): Stopping VM.
2022-01-03 23:20:00 (16152): Successfully stopped VM.
2022-01-03 23:36:00 (15172): Detected: vboxwrapper 26202
2022-01-03 23:36:00 (15172): Detected: BOINC client v7.14.2
2022-01-03 23:36:01 (15172): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2022-01-03 23:36:02 (15172): Guest Log: BIOS: VirtualBox 6.0.16
2022-01-03 23:36:02 (15172): Guest Log: CPUID EDX: 0x178bfbff
2022-01-03 23:36:02 (15172): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-03 23:36:02 (15172): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-03 23:36:02 (15172): Guest Log: BIOS: Booting from Hard Disk...
2022-01-03 23:36:02 (15172): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-03 23:36:02 (15172): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2022-01-03 23:36:02 (15172): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2022-01-03 23:36:02 (15172): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-03 23:36:02 (15172): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-03 23:36:02 (15172): Guest Log: Checking CVMFS...
2022-01-03 23:36:02 (15172): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000284 main     Log opened 2021-12-30T12:36:14.496655000Z
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000416 main     OS Product: Linux
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000468 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000511 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000555 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000557 main     Process ID: 1388
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.000559 main     Package type: LINUX_64BITS_GENERIC
2022-01-03 23:36:02 (15172): Guest Log: 00:00:00.002339 main     5.2.32 r132073 started. Verbose level = 0
2022-01-03 23:36:02 (15172): Guest Log: 00:00:10.053627 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 211 682 520 000ns (GuestNow=1 640 892 986 232 249 000 ns GuestLast=1 640 867 774 549 729 000 ns fSetTimeLastLoop=true )
2022-01-03 23:36:02 (15172): Guest Log: 60:00:33.449463 timesync vgsvcTimeSyncWorker: Radical host time change: 3 663 059 000 000ns (HostNow=1 641 112 662 684 000 000 ns HostLast=1 641 108 999 625 000 000 ns)
2022-01-03 23:36:02 (15172): Guest Log: 60:00:43.450196 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 663 056 610 000ns (GuestNow=1 641 112 672 684 744 000 ns GuestLast=1 641 109 009 628 134 000 ns fSetTimeLastLoop=true )
2022-01-03 23:36:02 (15172): Guest Log: 76:20:07.006736 timesync vgsvcTimeSyncWorker: Radical host time change: 6 806 750 000 000ns (HostNow=1 641 178 232 990 000 000 ns HostLast=1 641 171 426 240 000 000 ns)
2022-01-03 23:36:02 (15172): Guest Log: 76:20:17.007304 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 806 749 297 000ns (GuestNow=1 641 178 242 990 573 000 ns GuestLast=1 641 171 436 241 276 000 ns fSetTimeLastLoop=true )
2022-01-03 23:36:02 (15172): Guest Log: 77:31:07.267065 timesync vgsvcTimeSyncWorker: Radical host time change: 1 930 301 000 000ns (HostNow=1 641 185 004 254 000 000 ns HostLast=1 641 183 073 953 000 000 ns)
2022-01-03 23:36:02 (15172): Guest Log: 77:31:17.268305 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 521 004 936 000ns (GuestNow=1 641 185 014 255 253 000 ns GuestLast=1 641 182 493 250 317 000 ns fSetTimeLastLoop=true )
2022-01-03 23:36:02 (15172): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2022-01-03 23:36:16 (15172): Successfully started VM. (PID = '16920')
2022-01-03 23:36:16 (15172): Reporting VM Process ID to BOINC.
2022-01-03 23:36:16 (15172): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-03 23:36:16 (15172): Detected: Web Application Enabled (http://localhost:65424)
2022-01-03 23:36:16 (15172): Detected: Remote Desktop Enabled (localhost:65433)
2022-01-03 23:36:16 (15172): Status Report: Elapsed Time: '370841.781610'
2022-01-03 23:36:16 (15172): Status Report: CPU Time: '2334.765625'
2022-01-03 23:36:16 (15172): Preference change detected
2022-01-03 23:36:16 (15172): Setting CPU throttle for VM. (70%)
2022-01-03 23:36:16 (15172): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-04 00:36:58 (15172): VM state change detected. (old = 'running', new = 'paused')
2022-01-04 01:01:33 (15172): VM state change detected. (old = 'paused', new = 'running')
2022-01-04 01:40:59 (15172): Status Report: Elapsed Time: '376841.781610'
2022-01-04 01:40:59 (15172): Status Report: CPU Time: '2389.609375'
2022-01-04 03:21:06 (15172): Status Report: Elapsed Time: '382841.781610'
2022-01-04 03:21:06 (15172): Status Report: CPU Time: '2428.812500'
2022-01-04 05:01:13 (15172): Status Report: Elapsed Time: '388841.781610'
2022-01-04 05:01:13 (15172): Status Report: CPU Time: '2465.234375'
2022-01-04 06:41:20 (15172): Status Report: Elapsed Time: '394841.781610'
2022-01-04 06:41:20 (15172): Status Report: CPU Time: '2505.000000'
2022-01-04 08:21:28 (15172): Status Report: Elapsed Time: '400841.781610'
2022-01-04 08:21:28 (15172): Status Report: CPU Time: '2539.093750'
2022-01-04 10:01:35 (15172): Status Report: Elapsed Time: '406841.781610'
2022-01-04 10:01:35 (15172): Status Report: CPU Time: '2579.000000'
2022-01-04 11:41:42 (15172): Status Report: Elapsed Time: '412841.781610'
2022-01-04 11:41:42 (15172): Status Report: CPU Time: '2617.640625'
2022-01-04 12:56:15 (15172): Stopping VM.
2022-01-04 12:56:29 (15172): Successfully stopped VM.
2022-01-04 13:31:19 (15952): Detected: vboxwrapper 26202
2022-01-04 13:31:19 (15952): Detected: BOINC client v7.14.2
2022-01-04 13:31:20 (15952): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2022-01-04 13:31:21 (15952): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2022-01-04 13:31:35 (15952): Successfully started VM. (PID = '6128')
2022-01-04 13:31:35 (15952): Reporting VM Process ID to BOINC.
2022-01-04 13:31:35 (15952): Guest Log: 116:02:55.674633 timesync vgsvcTimeSyncWorker: Radical host time change: 2 129 204 000 000ns (HostNow=1 641 328 295 322 000 000 ns HostLast=1 641 326 166 118 000 000 ns)
2022-01-04 13:31:35 (15952): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-04 13:31:35 (15952): Detected: Web Application Enabled (http://localhost:65424)
2022-01-04 13:31:35 (15952): Detected: Remote Desktop Enabled (localhost:65433)
2022-01-04 13:31:35 (15952): Status Report: Elapsed Time: '417309.781610'
2022-01-04 13:31:35 (15952): Status Report: CPU Time: '2641.296875'
2022-01-04 13:31:35 (15952): Preference change detected
2022-01-04 13:31:35 (15952): Setting CPU throttle for VM. (70%)
2022-01-04 13:31:36 (15952): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-04 13:31:45 (15952): Guest Log: 116:03:05.675282 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 129 203 103 000ns (GuestNow=1 641 328 305 322 898 000 ns GuestLast=1 641 326 176 119 795 000 ns fSetTimeLastLoop=true )
2022-01-04 14:31:59 (15952): VM state change detected. (old = 'running', new = 'paused')
2022-01-04 14:54:45 (15952): VM state change detected. (old = 'paused', new = 'running')
2022-01-04 15:34:29 (15952): Status Report: Elapsed Time: '423309.781610'
2022-01-04 15:34:29 (15952): Status Report: CPU Time: '2698.781250'
2022-01-04 17:14:36 (15952): Status Report: Elapsed Time: '429309.950960'
2022-01-04 17:14:36 (15952): Status Report: CPU Time: '2734.328125'
2022-01-04 18:54:43 (15952): Status Report: Elapsed Time: '435309.950960'
2022-01-04 18:54:43 (15952): Status Report: CPU Time: '2771.078125'
2022-01-04 20:34:51 (15952): Status Report: Elapsed Time: '441309.950960'
2022-01-04 20:34:51 (15952): Status Report: CPU Time: '2813.859375'
2022-01-04 22:14:57 (15952): Status Report: Elapsed Time: '447309.950960'
2022-01-04 22:14:57 (15952): Status Report: CPU Time: '2862.718750'
2022-01-04 23:55:04 (15952): Status Report: Elapsed Time: '453309.950960'
2022-01-04 23:55:04 (15952): Status Report: CPU Time: '2916.390625'
2022-01-05 01:35:11 (15952): Status Report: Elapsed Time: '459310.716115'
2022-01-05 01:35:11 (15952): Status Report: CPU Time: '2970.234375'
2022-01-05 03:15:18 (15952): Status Report: Elapsed Time: '465310.716115'
2022-01-05 03:15:18 (15952): Status Report: CPU Time: '3023.687500'
2022-01-05 04:55:24 (15952): Status Report: Elapsed Time: '471310.716115'
2022-01-05 04:55:24 (15952): Status Report: CPU Time: '3074.812500'
2022-01-05 06:35:30 (15952): Status Report: Elapsed Time: '477310.716115'
2022-01-05 06:35:30 (15952): Status Report: CPU Time: '3128.437500'
2022-01-05 08:15:36 (15952): Status Report: Elapsed Time: '483310.716115'
2022-01-05 08:15:36 (15952): Status Report: CPU Time: '3181.578125'
2022-01-05 08:59:30 (15952): VM state change detected. (old = 'running', new = 'paused')
2022-01-05 10:31:40 (15952): VM state change detected. (old = 'paused', new = 'running')
2022-01-05 10:31:46 (15952): Guest Log: 135:08:10.241630 timesync vgsvcTimeSyncWorker: Radical host time change: 5 540 764 000 000ns (HostNow=1 641 403 906 171 000 000 ns HostLast=1 641 398 365 407 000 000 ns)
2022-01-05 10:31:56 (15952): Guest Log: 135:08:20.242664 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 540 762 406 000ns (GuestNow=1 641 403 916 172 087 000 ns GuestLast=1 641 398 375 409 681 000 ns fSetTimeLastLoop=true )
2022-01-05 11:27:54 (15952): Status Report: Elapsed Time: '489310.716115'
2022-01-05 11:27:54 (15952): Status Report: CPU Time: '3227.843750'
2022-01-05 11:57:34 (15952): Stopping VM.
2022-01-05 11:57:48 (15952): Successfully stopped VM.
2022-01-05 12:34:07 (8916): Detected: vboxwrapper 26202
2022-01-05 12:34:07 (8916): Detected: BOINC client v7.14.2
2022-01-05 12:34:08 (8916): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2022-01-05 12:34:09 (8916): Guest Log: 116:02:55.674633 timesync vgsvcTimeSyncWorker: Radical host time change: 2 129 204 000 000ns (HostNow=1 641 328 295 322 000 000 ns HostLast=1 641 326 166 118 000 000 ns)
2022-01-05 12:34:09 (8916): Guest Log: 116:03:05.675282 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 129 203 103 000ns (GuestNow=1 641 328 305 322 898 000 ns GuestLast=1 641 326 176 119 795 000 ns fSetTimeLastLoop=true )
2022-01-05 12:34:09 (8916): Guest Log: 135:08:10.241630 timesync vgsvcTimeSyncWorker: Radical host time change: 5 540 764 000 000ns (HostNow=1 641 403 906 171 000 000 ns HostLast=1 641 398 365 407 000 000 ns)
2022-01-05 12:34:09 (8916): Guest Log: 135:08:20.242664 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 540 762 406 000ns (GuestNow=1 641 403 916 172 087 000 ns GuestLast=1 641 398 375 409 681 000 ns fSetTimeLastLoop=true )
2022-01-05 12:34:09 (8916): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2022-01-05 12:34:22 (8916): Successfully started VM. (PID = '11332')
2022-01-05 12:34:22 (8916): Reporting VM Process ID to BOINC.
2022-01-05 12:34:22 (8916): Guest Log: 136:34:00.592339 timesync vgsvcTimeSyncWorker: Radical host time change: 2 215 473 000 000ns (HostNow=1 641 411 261 970 000 000 ns HostLast=1 641 409 046 497 000 000 ns)
2022-01-05 12:34:22 (8916): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-05 12:34:22 (8916): Detected: Web Application Enabled (http://localhost:65424)
2022-01-05 12:34:22 (8916): Detected: Remote Desktop Enabled (localhost:65433)
2022-01-05 12:34:22 (8916): Status Report: Elapsed Time: '491088.716115'
2022-01-05 12:34:22 (8916): Status Report: CPU Time: '3239.296875'
2022-01-05 12:34:22 (8916): Preference change detected
2022-01-05 12:34:22 (8916): Setting CPU throttle for VM. (70%)
2022-01-05 12:34:23 (8916): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-05 12:34:31 (8916): Guest Log: 136:34:10.593424 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 215 450 611 000ns (GuestNow=1 641 411 271 971 723 000 ns GuestLast=1 641 409 056 521 112 000 ns fSetTimeLastLoop=true )
2022-01-05 14:14:29 (8916): Status Report: Elapsed Time: '497088.716115'
2022-01-05 14:14:29 (8916): Status Report: CPU Time: '3300.281250'
2022-01-05 14:55:16 (8916): Stopping VM.
2022-01-05 14:55:36 (8916): Successfully stopped VM.
2022-01-05 15:00:53 (10536): Detected: vboxwrapper 26202
2022-01-05 15:00:53 (10536): Detected: BOINC client v7.14.2
2022-01-05 15:00:57 (10536): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2022-01-05 15:00:58 (10536): Guest Log: 136:34:00.592339 timesync vgsvcTimeSyncWorker: Radical host time change: 2 215 473 000 000ns (HostNow=1 641 411 261 970 000 000 ns HostLast=1 641 409 046 497 000 000 ns)
2022-01-05 15:00:58 (10536): Guest Log: 136:34:10.593424 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 215 450 611 000ns (GuestNow=1 641 411 271 971 723 000 ns GuestLast=1 641 409 056 521 112 000 ns fSetTimeLastLoop=true )
2022-01-05 15:00:58 (10536): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2022-01-05 15:02:00 (10536): Successfully started VM. (PID = '11312')
2022-01-05 15:02:00 (10536): Reporting VM Process ID to BOINC.
2022-01-05 15:02:00 (10536): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-05 15:02:00 (10536): Detected: Web Application Enabled (http://localhost:65424)
2022-01-05 15:02:00 (10536): Detected: Remote Desktop Enabled (localhost:65433)
2022-01-05 15:02:00 (10536): Status Report: Elapsed Time: '499533.716115'
2022-01-05 15:02:00 (10536): Status Report: CPU Time: '3321.234375'
2022-01-05 15:02:00 (10536): Preference change detected
2022-01-05 15:02:00 (10536): Setting CPU throttle for VM. (70%)
2022-01-05 15:02:02 (10536): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-05 16:42:08 (10536): Status Report: Elapsed Time: '505534.242936'
2022-01-05 16:42:08 (10536): Status Report: CPU Time: '3391.906250'
2022-01-05 18:22:15 (10536): Status Report: Elapsed Time: '511534.242936'
2022-01-05 18:22:15 (10536): Status Report: CPU Time: '3430.843750'
2022-01-05 20:02:22 (10536): Status Report: Elapsed Time: '517534.242936'
2022-01-05 20:02:22 (10536): Status Report: CPU Time: '3468.015625'
2022-01-05 21:42:29 (10536): Status Report: Elapsed Time: '523534.242936'
2022-01-05 21:42:29 (10536): Status Report: CPU Time: '3500.312500'
2022-01-07 20:55:52 (6732): Detected: vboxwrapper 26202
2022-01-07 20:55:52 (6732): Detected: BOINC client v7.14.2
2022-01-07 20:55:53 (6732): Detected: VirtualBox VboxManage Interface (Version: 6.0.16)
2022-01-07 20:55:54 (6732): Starting VM using VBoxManage interface. (boinc_f0610f18c1f63976, slot#6)
2022-01-07 20:55:59 (6732): Successfully started VM. (PID = '11236')
2022-01-07 20:55:59 (6732): Reporting VM Process ID to BOINC.
2022-01-07 20:55:59 (6732): Guest Log: BIOS: VirtualBox 6.0.16
2022-01-07 20:55:59 (6732): Guest Log: CPUID EDX: 0x178bfbff
2022-01-07 20:55:59 (6732): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-01-07 20:55:59 (6732): VM state change detected. (old = 'poweredoff', new = 'running')
2022-01-07 20:55:59 (6732): Detected: Web Application Enabled (http://localhost:65424)
2022-01-07 20:55:59 (6732): Detected: Remote Desktop Enabled (localhost:65433)
2022-01-07 20:55:59 (6732): Status Report: Elapsed Time: '524117.242936'
2022-01-07 20:55:59 (6732): Status Report: CPU Time: '3504.640625'
2022-01-07 20:55:59 (6732): Preference change detected
2022-01-07 20:55:59 (6732): Setting CPU throttle for VM. (70%)
2022-01-07 20:55:59 (6732): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2022-01-07 20:56:01 (6732): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-01-07 20:56:01 (6732): Guest Log: BIOS: Booting from Hard Disk...
2022-01-07 20:56:07 (6732): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-01-07 20:56:07 (6732): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2022-01-07 20:56:07 (6732): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2022-01-07 20:56:23 (6732): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-01-07 20:56:23 (6732): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-01-07 20:56:39 (6732): Guest Log: Checking CVMFS...
2022-01-07 20:56:42 (6732): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe:
2022-01-07 20:56:42 (6732): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed!
2022-01-07 20:56:43 (6732): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed!
2022-01-07 20:56:43 (6732): Guest Log: Probing /cvmfs/grid.cern.ch... Failed!
2022-01-07 20:56:45 (6732): Guest Log: Mounting shared directory
2022-01-07 20:56:48 (6732): Guest Log: Copying input files
2022-01-07 20:56:55 (6732): Guest Log: Copied input files into RunAtlas.
2022-01-07 20:57:13 (6732): Guest Log: copied the webapp to /var/www
2022-01-07 20:57:13 (6732): Guest Log: This vm does not need to setup an http proxy
2022-01-07 20:57:13 (6732): Guest Log: core_number=1
2022-01-07 20:57:14 (6732): Guest Log:  *** Starting ATLAS job. (PandaID=5313302938 taskID=NULL&cor) ***
2022-01-07 20:57:24 (6732): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000210 main     Log opened 2022-01-07T20:57:21.871562000Z
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000339 main     OS Product: Linux
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000381 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000415 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000450 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000452 main     Process ID: 2014
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.000453 main     Package type: LINUX_64BITS_GENERIC
2022-01-07 20:57:24 (6732): Guest Log: 00:00:00.002549 main     5.2.32 r132073 started. Verbose level = 0
2022-01-07 20:57:34 (6732): Guest Log: 00:00:10.037389 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 211 425 099 000ns (GuestNow=1 641 614 253 322 902 000 ns GuestLast=1 641 589 041 897 803 000 ns fSetTimeLastLoop=true )
2022-01-07 21:44:26 (6732): Guest Log:  *** Job finished ***
2022-01-07 21:44:26 (6732): Guest Log:  *** The last 20 lines of the pilot log: ***
2022-01-07 21:44:26 (6732): Guest Log:  *** Error codes and diagnostics ***
2022-01-07 21:44:26 (6732): Guest Log:     "exeErrorCode": 0,
2022-01-07 21:44:26 (6732): Guest Log:     "exeErrorDiag": "",
2022-01-07 21:44:26 (6732): Guest Log:     "pilotErrorCode": 0,
2022-01-07 21:44:26 (6732): Guest Log:     "pilotErrorDiag": "",
2022-01-07 21:44:26 (6732): Guest Log:  *** Listing of results directory ***
2022-01-07 21:44:26 (6732): Guest Log: total 7436
2022-01-07 21:44:26 (6732): Guest Log: -rwx------. 1 atlas atlas   26860 Dec 30 19:31 runpilot2-wrapper.sh
2022-01-07 21:44:26 (6732): Guest Log: -rw-r--r--. 1 atlas atlas    4534 Dec 30 19:31 queuedata.json
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas  346481 Dec 30 19:31 pilot2.tar.gz
2022-01-07 21:44:26 (6732): Guest Log: -rwxr-xr-x. 1 atlas atlas   10724 Jan  7 20:56 init_data.xml
2022-01-07 21:44:26 (6732): Guest Log: -rwxr-xr-x. 1 atlas atlas  358334 Jan  7 20:56 input.tar.gz
2022-01-07 21:44:26 (6732): Guest Log: -rwxr-xr-x. 1 atlas atlas   16611 Jan  7 20:56 start_atlas.sh
2022-01-07 21:44:26 (6732): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Jan  7 20:56 EVNT.04972714._000037.pool.root.1 -> /data/./ATLAS.root_0
2022-01-07 21:44:26 (6732): Guest Log: -rw-r--r--. 1 atlas atlas    2595 Jan  7 20:57 pandaJob.out
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas 1102221 Jan  8 03:58 agis_schedconf.cvmfs.json
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas 1925164 Jan  8 03:58 cric_ddmendpoints.json
2022-01-07 21:44:26 (6732): Guest Log: drwx------. 4 atlas atlas     260 Jan  8 03:58 pilot2
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas 1374658 Jan  8 04:43 output.1.fbfb8ffd-43d6-4757-8c8e-2e3a3474ed97_71538.pool.root
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas    1019 Jan  8 04:43 memory_monitor_summary.json
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas  174308 Jan  8 04:43 fbfb8ffd-43d6-4757-8c8e-2e3a3474ed97_71538.1.job.log.tgz
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas    6646 Jan  8 04:43 heartbeat.json
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas    7483 Jan  8 04:44 pilotlog.txt
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas  314250 Jan  8 04:44 fbfb8ffd-43d6-4757-8c8e-2e3a3474ed97_71538.1.job.log
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas     536 Jan  8 04:44 output.list
2022-01-07 21:44:26 (6732): Guest Log: -rw-r--r--. 1 atlas atlas     748 Jan  8 04:44 runtime_log
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas 1884160 Jan  8 04:44 result.tar.gz
2022-01-07 21:44:26 (6732): Guest Log: -rw-r--r--. 1 atlas atlas    9314 Jan  8 04:44 runtime_log.err
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas     562 Jan  8 04:44 514KDm1JGN0n7Olcko1bjSoqABFKDmABFKDm1XmMDmL7FKDmmXloSm.diag
2022-01-07 21:44:26 (6732): Guest Log: Looking for outputfile output.1.fbfb8ffd-43d6-4757-8c8e-2e3a3474ed97_71538.pool.root
2022-01-07 21:44:26 (6732): Guest Log: HITS file was successfully produced
2022-01-07 21:44:26 (6732): Guest Log: -rw-------. 1 atlas atlas 1374658 Jan  8 04:43 /home/atlas/RunAtlas/output.1.fbfb8ffd-43d6-4757-8c8e-2e3a3474ed97_71538.pool.root
2022-01-07 21:44:26 (6732): Guest Log: Successfully finished the ATLAS job!
2022-01-07 21:44:26 (6732): Guest Log: Copying the results back to the shared directory!
2022-01-07 21:44:26 (6732): Guest Log:  *** Contents of shared directory: ***
2022-01-07 21:44:26 (6732): Guest Log: total 40412
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root 37727106 Dec 30 19:35 ATLAS.root_0
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root  1374658 Jan  8 04:43 HITS.pool.root.1
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root    10724 Dec 30 19:35 init_data.xml
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root   358334 Dec 30 19:33 input.tar.gz
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root  1884160 Jan  8 04:44 result.tar.gz
2022-01-07 21:44:26 (6732): Guest Log: -rwxrwxrwx. 1 root root    16611 Dec 30 19:33 start_atlas.sh
2022-01-07 21:44:26 (6732): Guest Log:  *** Success! Shutting down the machine. ***
2022-01-07 21:44:27 (6732): VM Completion File Detected.
2022-01-07 21:44:27 (6732): Powering off VM.
2022-01-07 21:44:28 (6732): Successfully stopped VM.
2022-01-07 21:44:28 (6732): Deregistering VM. (boinc_f0610f18c1f63976, slot#6)
2022-01-07 21:44:28 (6732): Removing network bandwidth throttle group from VM.
2022-01-07 21:44:29 (6732): Removing VM from VirtualBox.
21:44:34 (6732): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN