Name Theory_2279-776344-155_0
Workunit 1949545
Created 6 Nov 2019, 14:45:07 UTC
Sent 7 Nov 2019, 20:14:20 UTC
Report deadline 17 Nov 2019, 20:14:20 UTC
Received 25 Nov 2019, 18:18:13 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3626
Run time 2 days 15 hours 34 min 40 sec
CPU time 2 days 12 hours 39 min 39 sec
Validate state Task was reported too late to validate
Credit 0.00
Device peak FLOPS 3.03 GFLOPS
Application version Theory Simulation v5.18 (vbox64_theory)
windows_x86_64
Peak working set size 75.04 MB
Peak swap size 104.57 MB
Peak disk usage 1.22 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-11-10 12:43:13 (5528): Detected: vboxwrapper 26197
2019-11-10 12:43:13 (5528): Detected: BOINC client v7.7
2019-11-10 12:43:14 (5528): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-11-10 12:43:14 (5528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-10 12:43:14 (5528): Successfully copied 'init_data.xml' to the shared directory.
2019-11-10 12:43:15 (5528): Successfully copied 'input' to the shared directory.
2019-11-10 12:43:16 (5528): Create VM. (boinc_307a7f3efa5bfd67, slot#2)
2019-11-10 12:43:18 (5528): Setting Memory Size for VM. (630MB)
2019-11-10 12:43:19 (5528): Setting CPU Count for VM. (1)
2019-11-10 12:43:20 (5528): Setting Chipset Options for VM.
2019-11-10 12:43:21 (5528): Setting Boot Options for VM.
2019-11-10 12:43:21 (5528): Setting Network Configuration for NAT.
2019-11-10 12:43:22 (5528): Enabling VM Network Access.
2019-11-10 12:43:23 (5528): Disabling USB Support for VM.
2019-11-10 12:43:24 (5528): Disabling COM Port Support for VM.
2019-11-10 12:43:25 (5528): Disabling LPT Port Support for VM.
2019-11-10 12:43:26 (5528): Disabling Audio Support for VM.
2019-11-10 12:43:26 (5528): Disabling Clipboard Support for VM.
2019-11-10 12:43:28 (5528): Disabling Drag and Drop Support for VM.
2019-11-10 12:43:28 (5528): Adding storage controller(s) to VM.
2019-11-10 12:43:29 (5528): Adding virtual disk drive to VM. (vm_image.vdi)
2019-11-10 12:43:30 (5528): Adding VirtualBox Guest Additions to VM.
2019-11-10 12:43:31 (5528): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-10 12:43:31 (5528): forwarding host port 60800 to guest port 80
2019-11-10 12:43:32 (5528): Enabling remote desktop for VM.
2019-11-10 12:43:33 (5528): Enabling shared directory for VM.
2019-11-10 12:43:34 (5528): Starting VM using VBoxManage interface. (boinc_307a7f3efa5bfd67, slot#2)
2019-11-10 12:43:44 (5528): Successfully started VM. (PID = '9900')
2019-11-10 12:43:44 (5528): Reporting VM Process ID to BOINC.
2019-11-10 12:43:44 (5528): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-10 12:43:44 (5528): Guest Log: CPUID EDX: 0x078bfbff

2019-11-10 12:43:44 (5528): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-11-10 12:43:44 (5528): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-10 12:43:44 (5528): Detected: Web Application Enabled (http://localhost:60800)
2019-11-10 12:43:44 (5528): Detected: Remote Desktop Enabled (localhost:60801)
2019-11-10 12:43:44 (5528): Preference change detected
2019-11-10 12:43:44 (5528): Setting CPU throttle for VM. (100%)
2019-11-10 12:43:45 (5528): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-10 12:43:46 (5528): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-10 12:43:46 (5528): Guest Log: BIOS: Booting from Hard Disk...

2019-11-10 12:43:50 (5528): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-11-10 12:43:50 (5528): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-11-10 12:44:20 (5528): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-11-10 12:44:20 (5528): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-11-10 12:44:28 (5528): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000452 main     Log opened 2019-11-10T11:44:29.823404000Z

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000659 main     OS Product: Linux

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000747 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000865 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000947 main     Executable: /usr/sbin/VBoxService

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000950 main     Process ID: 3206

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000952 main     Package type: LINUX_64BITS_GENERIC

2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.009772 main     5.2.6 r120293 started. Verbose level = 0

2019-11-10 12:45:09 (5528): Guest Log: 12:45:11 CET +01:00 2019-11-10: cranky: [INFO] Detected Theory App

2019-11-10 12:45:09 (5528): Guest Log: 12:45:11 CET +01:00 2019-11-10: cranky: [INFO] Checking CVMFS.

2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Checking runc.

2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Creating the filesystem.

2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-11-10 12:45:30 (5528): Guest Log: 12:45:32 CET +01:00 2019-11-10: cranky: [INFO] Updating config.json.

2019-11-10 12:45:30 (5528): Guest Log: 12:45:32 CET +01:00 2019-11-10: cranky: [INFO] Running Container 'runc'.

2019-11-10 12:45:33 (5528): Guest Log: 12:45:34 CET +01:00 2019-11-10: cranky: [INFO] ===> [runRivet] Sun Nov 10 11:45:33 UTC 2019 [boinc pp jets 7000 25,-,480 - pythia8 8.235 tune-A2 100000 155]

2019-11-10 14:53:58 (5528): Status Report: Job Duration: '864000.000000'
2019-11-10 14:53:58 (5528): Status Report: Elapsed Time: '6000.097343'
2019-11-10 14:53:58 (5528): Status Report: CPU Time: '7294.484375'
2019-11-10 16:43:52 (5528): Status Report: Job Duration: '864000.000000'
2019-11-10 16:43:52 (5528): Status Report: Elapsed Time: '12003.486061'
2019-11-10 16:43:52 (5528): Status Report: CPU Time: '13295.703125'
2019-11-10 18:30:52 (5528): Status Report: Job Duration: '864000.000000'
2019-11-10 18:30:52 (5528): Status Report: Elapsed Time: '18003.788134'
2019-11-10 18:30:52 (5528): Status Report: CPU Time: '18269.625000'
2019-11-10 20:18:33 (5528): Status Report: Job Duration: '864000.000000'
2019-11-10 20:18:33 (5528): Status Report: Elapsed Time: '24003.814358'
2019-11-10 20:18:33 (5528): Status Report: CPU Time: '22742.906250'
2019-11-10 22:05:48 (5528): Status Report: Job Duration: '864000.000000'
2019-11-10 22:05:48 (5528): Status Report: Elapsed Time: '30004.060652'
2019-11-10 22:05:48 (5528): Status Report: CPU Time: '27319.109375'
2019-11-10 22:05:50 (5528): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-11 19:32:23 (5528): Error in resume VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume
Output:

2019-11-11 19:32:24 (5528): Guest Log: 09:21:27.418264 timesync vgsvcTimeSyncWorker: Radical host time change: 77 103 357 000 000ns (HostNow=1 573 497 050 450 000 000 ns HostLast=1 573 419 947 093 000 000 ns)

2019-11-11 19:32:24 (5528): Guest Log: 09:21:37.513325 timesync vgsvcTimeSyncWorker: Radical guest time change: 77 103 507 036 000ns (GuestNow=1 573 497 060 598 568 000 ns GuestLast=1 573 419 957 091 532 000 ns fSetTimeLastLoop=true )

2019-11-11 19:32:28 (5528): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-11 21:19:50 (5528): Status Report: Job Duration: '864000.000000'
2019-11-11 21:19:50 (5528): Status Report: Elapsed Time: '36004.679388'
2019-11-11 21:19:50 (5528): Status Report: CPU Time: '32355.515625'
2019-11-11 23:06:49 (5528): Status Report: Job Duration: '864000.000000'
2019-11-11 23:06:49 (5528): Status Report: Elapsed Time: '42005.202383'
2019-11-11 23:06:49 (5528): Status Report: CPU Time: '38548.578125'
2019-11-11 23:36:28 (5528): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-12 19:56:23 (5528): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-12 19:56:24 (5528): Guest Log: 13:27:08.305840 timesync vgsvcTimeSyncWorker: Radical host time change: 73 043 565 000 000ns (HostNow=1 573 584 822 216 000 000 ns HostLast=1 573 511 778 651 000 000 ns)

2019-11-12 19:56:24 (5528): Guest Log: 13:27:18.315277 timesync vgsvcTimeSyncWorker: Radical guest time change: 73 040 834 400 000ns (GuestNow=1 573 584 832 225 451 000 ns GuestLast=1 573 511 791 391 051 000 ns fSetTimeLastLoop=true )

2019-11-12 19:56:24 (5528): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-12 21:15:56 (5528): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-13 01:04:16 (5528): Error in resume VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume
Output:

2019-11-13 01:04:17 (5528): Guest Log: 14:49:30.411670 timesync vgsvcTimeSyncWorker: Radical host time change: 13 547 911 000 000ns (HostNow=1 573 603 302 225 000 000 ns HostLast=1 573 589 754 314 000 000 ns)

2019-11-13 01:04:17 (5528): Guest Log: 14:49:40.426860 timesync vgsvcTimeSyncWorker: Radical guest time change: 13 547 918 499 000ns (GuestNow=1 573 603 312 240 263 000 ns GuestLast=1 573 589 764 321 764 000 ns fSetTimeLastLoop=true )

2019-11-13 01:04:22 (5528): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-13 01:05:26 (5528): Status Report: Job Duration: '864000.000000'
2019-11-13 01:05:26 (5528): Status Report: Elapsed Time: '48005.692606'
2019-11-13 01:05:26 (5528): Status Report: CPU Time: '45026.828125'
2019-11-13 02:55:02 (5528): Status Report: Job Duration: '864000.000000'
2019-11-13 02:55:02 (5528): Status Report: Elapsed Time: '54006.390093'
2019-11-13 02:55:02 (5528): Status Report: CPU Time: '51289.484375'
2019-11-13 04:36:35 (5528): Status Report: Job Duration: '864000.000000'
2019-11-13 04:36:35 (5528): Status Report: Elapsed Time: '60007.072369'
2019-11-13 04:36:35 (5528): Status Report: CPU Time: '57311.437500'
2019-11-13 04:44:44 (5528): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-13 07:38:57 (5528): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-13 07:38:57 (5528): Guest Log: 18:32:37.034048 timesync vgsvcTimeSyncWorker: Radical host time change: 10 440 219 000 000ns (HostNow=1 573 627 119 058 000 000 ns HostLast=1 573 616 678 839 000 000 ns)

2019-11-13 07:38:57 (5528): Guest Log: 18:32:47.044392 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 440 220 961 000ns (GuestNow=1 573 627 129 068 371 000 ns GuestLast=1 573 616 688 847 410 000 ns fSetTimeLastLoop=true )

2019-11-13 07:38:57 (5528): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-13 09:24:55 (5528): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-13 09:31:56 (5528): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-13 09:31:56 (5528): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-13 09:32:17 (5528): Stopping VM.
2019-11-13 09:32:17 (5528): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" savestate
Output:

2019-11-13 09:32:17 (5528): VM did not stop when requested.
2019-11-13 09:32:17 (5528): VM was successfully terminated.
2019-11-16 18:29:57 (5796): Detected: vboxwrapper 26197
2019-11-16 18:29:57 (5796): Detected: BOINC client v7.7
2019-11-16 18:29:59 (5796): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-11-16 18:29:59 (5796): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-16 18:30:00 (5796): Starting VM using VBoxManage interface. (boinc_307a7f3efa5bfd67, slot#2)
2019-11-16 18:30:09 (5796): Successfully started VM. (PID = '9224')
2019-11-16 18:30:09 (5796): Reporting VM Process ID to BOINC.
2019-11-16 18:30:09 (5796): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-16 18:30:09 (5796): Guest Log: CPUID EDX: 0x078bfbff

2019-11-16 18:30:09 (5796): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-11-16 18:30:09 (5796): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-16 18:30:09 (5796): Detected: Web Application Enabled (http://localhost:60800)
2019-11-16 18:30:09 (5796): Detected: Remote Desktop Enabled (localhost:60801)
2019-11-16 18:30:09 (5796): Status Report: Job Duration: '864000.000000'
2019-11-16 18:30:09 (5796): Status Report: Elapsed Time: '65406.970470'
2019-11-16 18:30:09 (5796): Status Report: CPU Time: '63865.937500'
2019-11-16 18:30:09 (5796): Preference change detected
2019-11-16 18:30:09 (5796): Setting CPU throttle for VM. (100%)
2019-11-16 18:30:09 (5796): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-16 18:30:11 (5796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-16 18:30:11 (5796): Guest Log: BIOS: Booting from Hard Disk...

2019-11-16 18:30:14 (5796): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-11-16 18:30:14 (5796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-11-16 18:30:51 (5796): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-11-16 18:30:51 (5796): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-11-16 18:30:58 (5796): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000312 main     Log opened 2019-11-16T17:30:58.774753000Z

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000617 main     OS Product: Linux

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000699 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000806 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000890 main     Executable: /usr/sbin/VBoxService

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000894 main     Process ID: 3210

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000896 main     Package type: LINUX_64BITS_GENERIC

2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.010528 main     5.2.6 r120293 started. Verbose level = 0

2019-11-16 18:31:42 (5796): Guest Log: 18:31:43 CET +01:00 2019-11-16: cranky: [INFO] Detected Theory App

2019-11-16 18:31:42 (5796): Guest Log: 18:31:43 CET +01:00 2019-11-16: cranky: [INFO] Checking CVMFS.

2019-11-16 18:32:08 (5796): Guest Log: 18:32:08 CET +01:00 2019-11-16: cranky: [INFO] Checking runc.

2019-11-16 18:32:08 (5796): Guest Log: 18:32:08 CET +01:00 2019-11-16: cranky: [INFO] Creating the filesystem.

2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Updating config.json.

2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Running Container 'runc'.

2019-11-16 18:32:11 (5796): Guest Log: 18:32:11 CET +01:00 2019-11-16: cranky: [INFO] ===> [runRivet] Sat Nov 16 17:32:11 UTC 2019 [boinc pp jets 7000 25,-,480 - pythia8 8.235 tune-A2 100000 155]

2019-11-16 20:10:53 (5796): Status Report: Job Duration: '864000.000000'
2019-11-16 20:10:53 (5796): Status Report: Elapsed Time: '71406.970470'
2019-11-16 20:10:53 (5796): Status Report: CPU Time: '69864.593750'
2019-11-16 21:55:14 (5796): Status Report: Job Duration: '864000.000000'
2019-11-16 21:55:14 (5796): Status Report: Elapsed Time: '77407.245916'
2019-11-16 21:55:14 (5796): Status Report: CPU Time: '76074.312500'
2019-11-16 23:37:27 (5796): Status Report: Job Duration: '864000.000000'
2019-11-16 23:37:27 (5796): Status Report: Elapsed Time: '83407.945638'
2019-11-16 23:37:27 (5796): Status Report: CPU Time: '82173.062500'
2019-11-16 23:59:51 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-17 13:09:14 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-17 13:09:14 (5796): Guest Log: 05:28:57.919989 timesync vgsvcTimeSyncWorker: Radical host time change: 47 358 160 000 000ns (HostNow=1 573 992 544 788 000 000 ns HostLast=1 573 945 186 628 000 000 ns)

2019-11-17 13:09:14 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-17 13:09:15 (5796): Guest Log: 05:29:07.954268 timesync vgsvcTimeSyncWorker: Radical guest time change: 47 358 204 239 000ns (GuestNow=1 573 992 554 833 184 000 ns GuestLast=1 573 945 196 628 945 000 ns fSetTimeLastLoop=true )

2019-11-17 14:27:51 (5796): Status Report: Job Duration: '864000.000000'
2019-11-17 14:27:51 (5796): Status Report: Elapsed Time: '89407.945638'
2019-11-17 14:27:51 (5796): Status Report: CPU Time: '88221.687500'
2019-11-17 16:08:38 (5796): Status Report: Job Duration: '864000.000000'
2019-11-17 16:08:38 (5796): Status Report: Elapsed Time: '95407.945638'
2019-11-17 16:08:38 (5796): Status Report: CPU Time: '94249.640625'
2019-11-17 17:49:26 (5796): Status Report: Job Duration: '864000.000000'
2019-11-17 17:49:26 (5796): Status Report: Elapsed Time: '101407.945638'
2019-11-17 17:49:26 (5796): Status Report: CPU Time: '100286.281250'
2019-11-17 19:30:39 (5796): Status Report: Job Duration: '864000.000000'
2019-11-17 19:30:39 (5796): Status Report: Elapsed Time: '107407.945638'
2019-11-17 19:30:39 (5796): Status Report: CPU Time: '106333.765625'
2019-11-17 21:14:07 (5796): Status Report: Job Duration: '864000.000000'
2019-11-17 21:14:07 (5796): Status Report: Elapsed Time: '113408.446462'
2019-11-17 21:14:07 (5796): Status Report: CPU Time: '112483.093750'
2019-11-17 22:01:11 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-19 19:39:07 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-19 19:39:08 (5796): Guest Log: 14:21:12.503610 timesync vgsvcTimeSyncWorker: Radical host time change: 164 266 438 000 000ns (HostNow=1 574 188 734 017 000 000 ns HostLast=1 574 024 467 579 000 000 ns)

2019-11-19 19:39:08 (5796): Guest Log: 14:21:22.510574 timesync vgsvcTimeSyncWorker: Radical guest time change: 164 264 696 370 000ns (GuestNow=1 574 188 744 051 333 000 ns GuestLast=1 574 024 479 354 963 000 ns fSetTimeLastLoop=true )

2019-11-19 19:39:08 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-19 20:36:28 (5796): Status Report: Job Duration: '864000.000000'
2019-11-19 20:36:28 (5796): Status Report: Elapsed Time: '119409.147274'
2019-11-19 20:36:28 (5796): Status Report: CPU Time: '118689.375000'
2019-11-19 22:21:09 (5796): Status Report: Job Duration: '864000.000000'
2019-11-19 22:21:09 (5796): Status Report: Elapsed Time: '125409.263151'
2019-11-19 22:21:09 (5796): Status Report: CPU Time: '124861.203125'
2019-11-19 23:14:53 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-20 19:34:01 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-20 19:34:02 (5796): Guest Log: 17:57:19.873912 timesync vgsvcTimeSyncWorker: Radical host time change: 73 139 352 000 000ns (HostNow=1 574 274 828 383 000 000 ns HostLast=1 574 201 689 031 000 000 ns)

2019-11-20 19:34:02 (5796): Guest Log: 17:57:29.876161 timesync vgsvcTimeSyncWorker: Radical guest time change: 73 136 970 432 000ns (GuestNow=1 574 274 838 385 265 000 ns GuestLast=1 574 201 701 414 833 000 ns fSetTimeLastLoop=true )

2019-11-20 19:34:02 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-20 20:25:19 (5796): Status Report: Job Duration: '864000.000000'
2019-11-20 20:25:19 (5796): Status Report: Elapsed Time: '131410.195886'
2019-11-20 20:25:19 (5796): Status Report: CPU Time: '131059.468750'
2019-11-20 21:52:39 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-21 17:54:37 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-21 17:54:38 (5796): Guest Log: 20:16:13.769655 timesync vgsvcTimeSyncWorker: Radical host time change: 72 113 121 000 000ns (HostNow=1 574 355 264 697 000 000 ns HostLast=1 574 283 151 576 000 000 ns)

2019-11-21 17:54:38 (5796): Guest Log: 20:16:23.771044 timesync vgsvcTimeSyncWorker: Radical guest time change: 72 112 419 675 000ns (GuestNow=1 574 355 274 698 406 000 ns GuestLast=1 574 283 162 278 731 000 ns fSetTimeLastLoop=true )

2019-11-21 17:54:38 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-21 18:10:32 (5796): Status Report: Job Duration: '864000.000000'
2019-11-21 18:10:32 (5796): Status Report: Elapsed Time: '137410.766723'
2019-11-21 18:10:32 (5796): Status Report: CPU Time: '137226.125000'
2019-11-21 19:52:08 (5796): Status Report: Job Duration: '864000.000000'
2019-11-21 19:52:08 (5796): Status Report: Elapsed Time: '143410.766723'
2019-11-21 19:52:08 (5796): Status Report: CPU Time: '143289.078125'
2019-11-21 21:32:56 (5796): Status Report: Job Duration: '864000.000000'
2019-11-21 21:32:56 (5796): Status Report: Elapsed Time: '149410.766723'
2019-11-21 21:32:56 (5796): Status Report: CPU Time: '149313.468750'
2019-11-21 23:13:44 (5796): Status Report: Job Duration: '864000.000000'
2019-11-21 23:13:44 (5796): Status Report: Elapsed Time: '155410.766723'
2019-11-21 23:13:44 (5796): Status Report: CPU Time: '155320.296875'
2019-11-21 23:20:36 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-22 18:31:44 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-22 18:31:45 (5796): Guest Log: 25:42:33.559903 timesync vgsvcTimeSyncWorker: Radical host time change: 69 066 431 000 000ns (HostNow=1 574 443 900 914 000 000 ns HostLast=1 574 374 834 483 000 000 ns)

2019-11-22 18:31:45 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-22 18:31:51 (5796): Guest Log: 25:42:43.569707 timesync vgsvcTimeSyncWorker: Radical guest time change: 69 066 436 587 000ns (GuestNow=1 574 443 910 923 822 000 ns GuestLast=1 574 374 844 487 235 000 ns fSetTimeLastLoop=true )

2019-11-22 20:05:56 (5796): Status Report: Job Duration: '864000.000000'
2019-11-22 20:05:56 (5796): Status Report: Elapsed Time: '161410.766723'
2019-11-22 20:05:56 (5796): Status Report: CPU Time: '161343.796875'
2019-11-22 21:46:43 (5796): Status Report: Job Duration: '864000.000000'
2019-11-22 21:46:43 (5796): Status Report: Elapsed Time: '167410.766723'
2019-11-22 21:46:43 (5796): Status Report: CPU Time: '167339.484375'
2019-11-22 22:00:37 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-23 14:28:06 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-23 14:28:07 (5796): Guest Log: 29:11:32.740148 timesync vgsvcTimeSyncWorker: Radical host time change: 59 253 453 000 000ns (HostNow=1 574 515 680 352 000 000 ns HostLast=1 574 456 426 899 000 000 ns)

2019-11-23 14:28:07 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-23 14:28:10 (5796): Guest Log: 29:11:42.746382 timesync vgsvcTimeSyncWorker: Radical guest time change: 59 250 264 024 000ns (GuestNow=1 574 515 690 358 254 000 ns GuestLast=1 574 456 440 094 230 000 ns fSetTimeLastLoop=true )

2019-11-23 15:55:09 (5796): Status Report: Job Duration: '864000.000000'
2019-11-23 15:55:09 (5796): Status Report: Elapsed Time: '173410.766723'
2019-11-23 15:55:09 (5796): Status Report: CPU Time: '173352.656250'
2019-11-23 17:42:59 (5796): Status Report: Job Duration: '864000.000000'
2019-11-23 17:42:59 (5796): Status Report: Elapsed Time: '179411.328773'
2019-11-23 17:42:59 (5796): Status Report: CPU Time: '179645.671875'
2019-11-23 19:42:01 (5796): Status Report: Job Duration: '864000.000000'
2019-11-23 19:42:01 (5796): Status Report: Elapsed Time: '185411.356023'
2019-11-23 19:42:01 (5796): Status Report: CPU Time: '186475.390625'
2019-11-23 21:43:54 (5796): Status Report: Job Duration: '864000.000000'
2019-11-23 21:43:54 (5796): Status Report: Elapsed Time: '191412.670034'
2019-11-23 21:43:54 (5796): Status Report: CPU Time: '193406.281250'
2019-11-23 21:48:01 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-24 16:16:10 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-24 16:16:11 (5796): Guest Log: 36:31:37.613452 timesync vgsvcTimeSyncWorker: Radical host time change: 66 478 696 000 000ns (HostNow=1 574 608 550 724 000 000 ns HostLast=1 574 542 072 028 000 000 ns)

2019-11-24 16:16:11 (5796): Guest Log: 36:31:47.618498 timesync vgsvcTimeSyncWorker: Radical guest time change: 66 475 503 777 000ns (GuestNow=1 574 608 560 729 064 000 ns GuestLast=1 574 542 085 225 287 000 ns fSetTimeLastLoop=true )

2019-11-24 16:16:11 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-24 17:54:45 (5796): Status Report: Job Duration: '864000.000000'
2019-11-24 17:54:45 (5796): Status Report: Elapsed Time: '197413.518005'
2019-11-24 17:54:45 (5796): Status Report: CPU Time: '199529.062500'
2019-11-24 19:36:21 (5796): Status Report: Job Duration: '864000.000000'
2019-11-24 19:36:21 (5796): Status Report: Elapsed Time: '203413.518005'
2019-11-24 19:36:21 (5796): Status Report: CPU Time: '205582.812500'
2019-11-24 21:17:37 (5796): Status Report: Job Duration: '864000.000000'
2019-11-24 21:17:37 (5796): Status Report: Elapsed Time: '209413.518005'
2019-11-24 21:17:37 (5796): Status Report: CPU Time: '211629.531250'
2019-11-24 21:58:38 (5796): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-25 18:00:49 (5796): Error in resume VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" 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 410 of file VBoxManageControlVM.cpp

2019-11-25 18:00:50 (5796): Guest Log: 42:14:27.749640 timesync vgsvcTimeSyncWorker: Radical host time change: 72 129 215 000 000ns (HostNow=1 574 701 238 112 000 000 ns HostLast=1 574 629 108 897 000 000 ns)

2019-11-25 18:00:50 (5796): Guest Log: 42:14:37.750794 timesync vgsvcTimeSyncWorker: Radical guest time change: 72 127 799 832 000ns (GuestNow=1 574 701 248 386 590 000 ns GuestLast=1 574 629 120 586 758 000 ns fSetTimeLastLoop=true )

2019-11-25 18:00:50 (5796): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-25 19:01:15 (5796): Status Report: Job Duration: '864000.000000'
2019-11-25 19:01:15 (5796): Status Report: Elapsed Time: '215413.518005'
2019-11-25 19:01:15 (5796): Status Report: CPU Time: '217701.781250'
2019-11-25 19:12:44 (5796): Guest Log: 19:12:43 CET +01:00 2019-11-25: cranky: [INFO] Container 'runc' finished with status code 0.

2019-11-25 19:12:44 (5796): Guest Log: 19:12:43 CET +01:00 2019-11-25: cranky: [INFO] Preparing output.

2019-11-25 19:12:47 (5796): Guest Log: [INFO] Job Finished

2019-11-25 19:12:47 (5796): Guest Log: [INFO] Shutting Down.

2019-11-25 19:12:47 (5796): VM Completion File Detected.
2019-11-25 19:12:47 (5796): VM Completion Message: Job Finished
.
2019-11-25 19:12:47 (5796): Powering off VM.
2019-11-25 19:17:48 (5796): VM did not power off when requested.
2019-11-25 19:17:48 (5796): VM was successfully terminated.
2019-11-25 19:17:48 (5796): Deregistering VM. (boinc_307a7f3efa5bfd67, slot#2)
2019-11-25 19:17:48 (5796): Removing network bandwidth throttle group from VM.
2019-11-25 19:17:48 (5796): Removing VM from VirtualBox.
19:17:54 (5796): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN