Task 7749648

Name 07577379_43_1
Workunit 6234590
Created 21 Nov 2019, 15:23:59 UTC
Sent 21 Nov 2019, 15:47:17 UTC
Report deadline 26 Nov 2019, 15:47:17 UTC
Received 27 Nov 2019, 6:28:18 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED
Computer ID 2668
Run time 2 hours 16 min 45 sec
CPU time 28 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 3.49 GFLOPS
Application version boinc2docker v1.12 (vbox64_mt)
windows_x86_64
Peak working set size 90.32 MB
Peak swap size 96.59 MB
Peak disk usage 499.53 MB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<message>
exceeded elapsed time limit 8197.44 (86400.00G/10.54G)</message>
<stderr_txt>
2019-11-25 17:48:15 (1196): vboxwrapper (7.9.26200): starting
2019-11-25 17:48:15 (1196): Feature: Checkpoint interval offset (72 seconds)
2019-11-25 17:48:15 (1196): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-25 17:48:15 (1196): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-25 17:48:15 (1196): Create VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-25 17:48:15 (1196): Updating drive controller type and model for desired configuration.
2019-11-25 17:48:16 (1196): Setting Memory Size for VM. (3072MB)
2019-11-25 17:48:16 (1196): Setting CPU Count for VM. (1)
2019-11-25 17:48:16 (1196): Setting Chipset Options for VM.
2019-11-25 17:48:16 (1196): Setting Boot Options for VM.
2019-11-25 17:48:16 (1196): Enabling VM Network Access.
2019-11-25 17:48:16 (1196): Setting Network Configuration for NAT.
2019-11-25 17:48:16 (1196): Disabling USB Support for VM.
2019-11-25 17:48:16 (1196): Disabling COM Port Support for VM.
2019-11-25 17:48:16 (1196): Disabling LPT Port Support for VM.
2019-11-25 17:48:16 (1196): Disabling Audio Support for VM.
2019-11-25 17:48:16 (1196): Disabling Clipboard Support for VM.
2019-11-25 17:48:16 (1196): Disabling Drag and Drop Support for VM.
2019-11-25 17:48:16 (1196): Adding storage controller(s) to VM.
2019-11-25 17:48:16 (1196): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-11-25 17:48:16 (1196): Adding VirtualBox Guest Additions to VM.
2019-11-25 17:48:16 (1196): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-25 17:48:16 (1196): Enabling shared directory for VM.
2019-11-25 17:48:16 (1196): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-25 17:48:25 (1196): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-25 17:48:25 (1196): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-25 17:48:25 (1196): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-25 17:48:25 (1196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-25 17:48:25 (1196): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-25 17:48:25 (1196): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-25 17:48:25 (1196): Guest Log: BIOS: Booting from CD-ROM...

2019-11-25 17:48:25 (1196): Successfully started VM. (PID = '30508')
2019-11-25 17:48:25 (1196): Reporting VM Process ID to BOINC.
2019-11-25 17:48:30 (1196): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-25 17:48:40 (1196): Preference change detected
2019-11-25 17:48:40 (1196): Setting CPU throttle for VM. (10%)
2019-11-25 17:48:40 (1196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-25 17:51:15 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 18:36:57 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 18:37:07 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 18:44:27 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 18:44:38 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 18:44:58 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 18:45:08 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:11:15 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:11:26 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:12:56 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:13:06 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:16:26 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:16:36 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:16:56 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:17:06 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:18:27 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:18:37 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:18:57 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:19:07 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:19:27 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:19:37 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:21:17 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:21:27 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:21:57 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:22:02 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:22:12 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:22:22 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:24:32 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:25:00 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:25:35 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:25:45 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:27:55 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:28:05 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:32:56 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:33:06 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:34:06 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:34:16 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:35:16 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:35:26 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:35:46 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:35:56 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:36:46 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:36:56 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:44:53 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:44:58 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:46:18 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:46:28 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:47:18 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:47:28 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:50:48 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:50:59 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:51:59 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:52:09 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:52:59 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:53:09 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:53:49 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:53:59 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:56:29 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:56:39 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 20:59:49 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 20:59:59 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:00:09 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:00:20 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:01:50 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:02:00 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:07:20 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:07:30 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:08:00 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:08:10 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:09:38 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:09:48 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:14:39 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:14:49 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:17:09 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:17:29 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:32:30 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:32:41 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:33:11 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:33:21 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:34:11 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:34:31 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:39:31 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:39:41 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:41:31 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:41:41 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:41:51 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:42:02 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-25 21:44:32 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-25 21:44:42 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:03:00 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:03:10 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:06:00 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:06:10 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:24:52 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:25:02 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:45:23 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:45:33 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:50:43 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:51:04 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:51:14 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:51:24 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:55:44 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:55:54 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:56:34 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:56:54 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:57:14 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:57:24 (1196): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 00:57:34 (1196): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 00:57:51 (1196): Powering off VM.
2019-11-26 00:57:51 (1196): Error 0x8000ffff in vbox52::VBOX_VM::poweroff (c:\users\david\documents\boinc_git\boinc\samples\vboxwrapper\vbox_mscom_impl.cpp:1506)
2019-11-26 00:57:51 (1196): Error Source     : SessionWrap
2019-11-26 00:57:51 (1196): Error Description: The session is not locked (session state: Unlocked)
2019-11-26 11:12:43 (18524): vboxwrapper (7.9.26200): starting
2019-11-26 11:12:45 (18524): Feature: Checkpoint interval offset (508 seconds)
2019-11-26 11:12:45 (18524): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-26 11:12:45 (18524): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-26 11:12:45 (18524): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-26 11:12:45 (18524): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-26 11:12:45 (18524): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 11:12:45 (18524): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 11:12:45 (18524): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 11:12:45 (18524): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 11:12:45 (18524): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 11:12:45 (18524): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 11:12:55 (18524): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 11:12:55 (18524): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 11:12:55 (18524): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 11:12:55 (18524): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 11:12:55 (18524): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 11:12:55 (18524): Successfully started VM. (PID = '9136')
2019-11-26 11:12:55 (18524): Reporting VM Process ID to BOINC.
2019-11-26 11:13:00 (18524): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-26 11:13:10 (18524): Preference change detected
2019-11-26 11:13:10 (18524): Setting CPU throttle for VM. (10%)
2019-11-26 11:13:10 (18524): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-26 11:13:15 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:16:05 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:16:15 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:19:55 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:20:05 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:20:45 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:20:56 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:22:56 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:23:06 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:23:16 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:23:26 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:33:07 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:33:17 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:39:17 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:39:27 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:40:07 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:40:27 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 11:54:19 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 11:54:29 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:05:50 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:06:00 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:10:00 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:10:10 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:21:51 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:22:01 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:26:32 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:26:42 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:29:02 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:29:12 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:31:12 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:31:22 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:34:23 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:34:33 (18524): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 12:39:03 (18524): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 12:39:05 (18524): VM state change detected. (old = 'running', new = 'aborted')
2019-11-26 12:39:05 (18524): Powering off VM.
2019-11-26 12:39:05 (18524): Deregistering VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 12:39:05 (18524): Removing virtual disk drive(s) from VM.
2019-11-26 12:39:05 (18524): Removing network bandwidth throttle group from VM.
2019-11-26 12:39:05 (18524): Removing storage controller(s) from VM.
2019-11-26 12:39:05 (18524): Removing VM from VirtualBox.
2019-11-26 14:33:47 (4548): vboxwrapper (7.9.26200): starting
2019-11-26 14:33:54 (4548): Feature: Checkpoint interval offset (272 seconds)
2019-11-26 14:33:54 (4548): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-26 14:33:54 (4548): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-26 14:33:54 (4548): Create VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 14:33:54 (4548): Updating drive controller type and model for desired configuration.
2019-11-26 14:33:55 (4548): Setting Memory Size for VM. (3072MB)
2019-11-26 14:33:55 (4548): Setting CPU Count for VM. (1)
2019-11-26 14:33:55 (4548): Setting Chipset Options for VM.
2019-11-26 14:33:55 (4548): Setting Boot Options for VM.
2019-11-26 14:33:55 (4548): Enabling VM Network Access.
2019-11-26 14:33:55 (4548): Setting Network Configuration for NAT.
2019-11-26 14:33:55 (4548): Disabling USB Support for VM.
2019-11-26 14:33:55 (4548): Disabling COM Port Support for VM.
2019-11-26 14:33:55 (4548): Disabling LPT Port Support for VM.
2019-11-26 14:33:55 (4548): Disabling Audio Support for VM.
2019-11-26 14:33:55 (4548): Disabling Clipboard Support for VM.
2019-11-26 14:33:55 (4548): Disabling Drag and Drop Support for VM.
2019-11-26 14:33:55 (4548): Adding storage controller(s) to VM.
2019-11-26 14:33:55 (4548): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-11-26 14:33:55 (4548): Adding VirtualBox Guest Additions to VM.
2019-11-26 14:33:55 (4548): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-26 14:33:55 (4548): Enabling shared directory for VM.
2019-11-26 14:33:55 (4548): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 14:34:08 (4548): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-26 14:34:08 (4548): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-26 14:34:08 (4548): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 14:34:08 (4548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 14:34:08 (4548): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 14:34:08 (4548): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 14:34:08 (4548): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 14:34:08 (4548): Successfully started VM. (PID = '11420')
2019-11-26 14:34:08 (4548): Reporting VM Process ID to BOINC.
2019-11-26 14:34:13 (4548): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-26 14:34:23 (4548): Preference change detected
2019-11-26 14:34:23 (4548): Setting CPU throttle for VM. (10%)
2019-11-26 14:34:23 (4548): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-26 14:34:48 (4548): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 14:35:39 (4548): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 14:35:49 (4548): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 14:36:19 (4548): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 14:47:00 (4548): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 14:47:10 (4548): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 14:54:42 (4548): Powering off VM.
2019-11-26 18:00:39 (6932): vboxwrapper (7.9.26200): starting
2019-11-26 18:00:39 (6932): Feature: Checkpoint interval offset (415 seconds)
2019-11-26 18:00:39 (6932): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-26 18:00:39 (6932): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-26 18:00:39 (6932): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-26 18:00:39 (6932): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-26 18:00:39 (6932): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 18:00:39 (6932): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 18:00:39 (6932): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 18:00:39 (6932): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 18:00:39 (6932): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 18:00:39 (6932): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 18:00:48 (6932): Successfully started VM. (PID = '4960')
2019-11-26 18:00:48 (6932): Reporting VM Process ID to BOINC.
2019-11-26 18:00:53 (6932): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-26 18:01:03 (6932): Preference change detected
2019-11-26 18:01:03 (6932): Setting CPU throttle for VM. (10%)
2019-11-26 18:01:03 (6932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-26 18:01:09 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:01:19 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:01:39 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:02:21 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:02:32 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:02:52 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:03:02 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:03:12 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:03:32 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:04:02 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:04:13 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:04:33 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:04:48 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:04:58 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:06:38 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:07:08 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:07:29 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:08:09 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:08:59 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:09:09 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:09:59 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:10:19 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:11:09 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:11:19 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:12:09 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:12:20 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:13:10 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:13:20 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:13:30 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:13:40 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:14:10 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:14:20 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:15:10 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:15:30 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:15:40 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:15:51 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:16:22 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:16:32 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:16:42 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:16:52 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:17:32 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:17:42 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:18:03 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:18:13 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:18:53 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:19:03 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:19:23 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:19:43 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:20:03 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:20:13 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:20:33 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:21:13 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:21:33 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:21:53 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:22:14 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:22:44 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 18:23:05 (6932): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 18:23:25 (6932): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:17:40 (13936): vboxwrapper (7.9.26200): starting
2019-11-26 19:17:44 (13936): Feature: Checkpoint interval offset (233 seconds)
2019-11-26 19:17:44 (13936): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-26 19:17:44 (13936): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-26 19:17:44 (13936): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-26 19:17:44 (13936): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-26 19:17:44 (13936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 19:17:44 (13936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 19:17:44 (13936): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 19:17:44 (13936): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 19:17:44 (13936): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 19:17:44 (13936): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-26 19:17:56 (13936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-26 19:17:56 (13936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-26 19:17:56 (13936): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-26 19:17:56 (13936): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-26 19:17:56 (13936): Guest Log: BIOS: Booting from CD-ROM...

2019-11-26 19:17:56 (13936): Successfully started VM. (PID = '9208')
2019-11-26 19:17:56 (13936): Reporting VM Process ID to BOINC.
2019-11-26 19:18:01 (13936): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-26 19:18:11 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:19:42 (13936): Preference change detected
2019-11-26 19:19:42 (13936): Setting CPU throttle for VM. (10%)
2019-11-26 19:19:42 (13936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-26 19:19:42 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:19:59 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:20:14 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:20:25 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:20:45 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:20:55 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:21:05 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:21:15 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:21:40 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:22:00 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:22:10 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:22:50 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:23:11 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:23:31 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:24:11 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:25:22 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:25:52 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:26:23 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:26:33 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:26:53 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:27:13 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:29:34 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:29:44 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:30:44 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:30:54 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:32:41 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:32:51 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:35:12 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:35:23 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:35:43 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:35:53 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:37:23 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:37:34 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:38:03 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:38:28 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:40:04 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:40:46 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:40:56 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:41:19 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:41:31 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:43:30 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:43:40 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:44:25 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:45:15 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:45:35 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:45:45 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:47:26 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:48:07 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:48:17 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:48:45 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:48:55 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:49:18 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:49:34 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:49:50 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:50:15 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:50:25 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:50:45 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:51:05 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:51:26 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:52:06 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:52:16 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:52:36 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:53:16 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:55:26 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:55:46 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:55:57 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:56:37 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:57:07 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:57:47 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 19:59:47 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 19:59:57 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:00:07 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:00:17 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:01:17 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:01:27 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:03:38 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:03:48 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:04:28 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:04:48 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:05:38 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:05:48 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:07:48 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:08:05 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:09:35 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:09:45 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:10:05 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:10:15 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:11:16 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:11:36 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:12:16 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:12:26 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:12:36 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:12:56 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:13:26 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:13:36 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:13:46 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:14:06 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:14:36 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:15:06 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:15:18 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:15:28 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:15:38 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:15:48 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:17:38 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:17:48 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:22:29 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:22:39 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:23:29 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:23:39 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:24:29 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:24:39 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:31:30 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:31:40 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:34:11 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:34:21 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:35:41 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:36:01 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:37:11 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:37:21 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:39:22 (13936): VM state change detected. (old = 'running', new = 'paused')
2019-11-26 20:39:32 (13936): VM state change detected. (old = 'paused', new = 'running')
2019-11-26 20:39:37 (13936): Powering off VM.
2019-11-26 20:39:38 (13936): Successfully stopped VM.
2019-11-27 00:06:03 (12772): vboxwrapper (7.9.26200): starting
2019-11-27 00:06:03 (12772): Feature: Checkpoint interval offset (164 seconds)
2019-11-27 00:06:03 (12772): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-11-27 00:06:03 (12772): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-27 00:06:03 (12772): Guest Log: BIOS: VirtualBox 5.2.8

2019-11-27 00:06:03 (12772): Guest Log: CPUID EDX: 0x078bf3ff

2019-11-27 00:06:03 (12772): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-27 00:06:03 (12772): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-11-27 00:06:03 (12772): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-11-27 00:06:03 (12772): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-11-27 00:06:03 (12772): Guest Log: BIOS: Booting from CD-ROM...

2019-11-27 00:06:03 (12772): Starting VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-27 00:06:12 (12772): Successfully started VM. (PID = '704')
2019-11-27 00:06:12 (12772): Reporting VM Process ID to BOINC.
2019-11-27 00:06:17 (12772): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-27 00:06:27 (12772): Preference change detected
2019-11-27 00:06:27 (12772): Setting CPU throttle for VM. (10%)
2019-11-27 00:06:27 (12772): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-27 00:14:23 (12772): Status Report: Elapsed Time: '6000.430566'
2019-11-27 00:14:23 (12772): Status Report: CPU Time: '28.390625'
2019-11-27 00:19:25 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:19:35 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:20:15 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:20:25 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:24:45 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:25:07 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:26:18 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:26:28 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:27:59 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:28:09 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:29:59 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:30:09 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:31:50 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:32:00 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:35:20 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:35:30 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:35:50 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:36:20 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:37:50 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:38:19 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:38:29 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:38:47 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:46:03 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:46:13 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:46:43 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:47:03 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:47:13 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:47:23 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:48:34 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:48:44 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:51:24 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:51:34 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:55:55 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:56:15 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:56:45 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:57:52 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:59:12 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 00:59:23 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 00:59:43 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:00:03 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:01:23 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:02:24 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:02:44 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:03:24 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:03:44 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:04:51 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:05:02 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:07:19 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:07:30 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:08:13 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:08:33 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:12:35 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:12:40 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:13:52 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:13:57 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:15:30 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:15:40 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:17:25 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:17:30 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:18:26 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:18:47 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:19:22 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:19:43 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:20:45 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:20:53 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:21:27 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:21:47 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:22:23 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:22:33 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:23:52 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:23:58 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:24:23 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:24:53 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:25:03 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:25:28 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:25:53 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:26:23 (12772): VM state change detected. (old = 'running', new = 'paused')
2019-11-27 01:26:33 (12772): VM state change detected. (old = 'paused', new = 'running')
2019-11-27 01:26:49 (12772): Powering off VM.
2019-11-27 01:26:50 (12772): Successfully stopped VM.
2019-11-27 01:26:55 (12772): Deregistering VM. (boinc_1cc5c89d7f458113, slot#1)
2019-11-27 01:26:55 (12772): Removing virtual disk drive(s) from VM.
2019-11-27 01:26:55 (12772): Removing network bandwidth throttle group from VM.
2019-11-27 01:26:55 (12772): Removing storage controller(s) from VM.
2019-11-27 01:26:55 (12772): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:00.671852 main     AssertLogRel F:\tinderbox\win-5.2\src\VBox\Main\src-all\win\VBoxProxyStub.c(937) long __cdecl vbpsCreateRegKeyWithDefaultValueAAEx(struct VBPSREGSTATE *,struct HKEY__ *,const char *,const char *,struct HKEY__ **,unsigned int): VBPS_LOGREL_NO_ASSERT(rc == ERROR_ACCESS_DENIED)
00:00:00.671852 main     1148: create key 'VirtualBox.VirtualBoxClient'(/Default='VirtualBoxClient Class') -> 5
00:00:00.671852 main     AssertLogRel F:\tinderbox\win-5.2\src\VBox\Main\src-all\win\VBoxProxyStub.c(842) long __cdecl vbpsCreateRegKeyA(struct VBPSREGSTATE *,struct HKEY__ *,const char *,struct HKEY__ **,unsigned int): VBPS_LOGREL_NO_ASSERT(rc == ERROR_ACCESS_DENIED)
00:00:00.671852 main     1234: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}' -> 5
00:00:00.671852 main     AssertLogRel F:\tinderbox\win-5.2\src\VBox\Main\src-all\win\VBoxProxyStub.c(937) long __cdecl vbpsCreateRegKeyWithDefaultValueAAEx(struct VBPSREGSTATE *,struct HKEY__ *,const char *,const char *,struct HKEY__ **,unsigned int): VBPS_LOGREL_NO_ASSERT(rc == ERROR_ACCESS_DENIED)
00:00:00.671852 main     1234: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}'(/Default='VirtualBoxClient Class') -> 5
00:00:00.671852          VirtualBox: object creation starts
00:00:00.671852          Home directory: 'C:\Users\Bingo\.VirtualBox'
00:00:00.671852          Installed Drivers:
00:00:00.687475            C:\WINDOWS\system32\DRIVERS\VBoxNetLwf.sys (Version: 5.2.8.21009)
00:00:00.687475            C:\WINDOWS\system32\DRIVERS\VBoxUSBMon.sys (Version: 5.2.8.21009)
00:00:00.687475            C:\WINDOWS\system32\DRIVERS\VBoxDrv.sys (Version: 5.2.8.21009)
00:00:00.687475          Loading settings file "C:\Users\Bingo\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:00.804560          Getting USB descriptor failed with error 31
00:00:00.903048          Getting USB descriptor failed with error 31
00:00:00.903048          USB: Unknown USB device detected (idVendor: 0x0461, idProduct: 0x4dfe)
00:00:01.624564          netIfIsWireless: CreateFile on '\\.\{8A34E997-D2AF-47A3-BF5D-CC44A7BE7359}' failed with rcWin=2 (0x2) - ignoring
00:00:01.640189          HostDnsMonitor: old information
00:00:01.812061            no server entries
00:00:01.812061            no domain set
00:00:01.812061            no search string entries
00:00:01.812061          HostDnsMonitor: new information
00:00:01.812061            server 1: 192.168.0.1
00:00:01.812061            no domain set
00:00:01.812061            no search string entries
00:00:01.812061          HostDnsMonitorProxy::notify
00:00:01.905804          SUPR0QueryVTCaps -> VERR_VMX_MSR_ALL_VMX_DISABLED
00:00:02.062051          VD: VDInit finished with VINF_SUCCESS
00:00:02.062051          VirtualBox: object created
00:00:02.187043          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={9570b9d5-f1a1-448a-10c5-e12f5285adad} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_1cc5c89d7f458113'}, preserve=false aResultDetail=0
00:00:02.546423          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
00:00:02.702654          Saving settings file "C:\Users\Bingo\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:02.983894          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
00:00:11.429336          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
00:00:31.562855          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
00:01:26.237127 USBPROXY Getting USB descriptor failed with error 31
00:01:26.334757 USBPROXY Getting USB descriptor failed with error 31
00:20:45.432313 MainPower Host suspending: Paused 1 VMs
00:20:50.289383          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
03:26:25.971771 MainPower Host resumed: Resumed 0 VMs
03:26:34.809770 USBPROXY Getting USB descriptor failed with error 31
03:26:34.878615 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
03:26:51.505796          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
03:27:11.563637          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
03:50:08.496570 MainPower Host suspending: Paused 1 VMs
04:42:47.641119 Watcher  Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
04:42:52.023360 MainPower Host resumed: Resumed 0 VMs
04:42:56.542569 Watcher  Reaper: Pid 8200 (2008) exited normally: 194 (0xc2)
04:43:59.113692          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
04:45:50.579240          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
06:05:44.073943 MainPower Host suspending: Paused 1 VMs
06:05:45.186915          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
09:31:47.873188 MainPower Host resumed: Resumed 0 VMs
09:32:15.155734          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
09:32:35.190567          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
10:29:29.003202 USBPROXY Getting USB descriptor failed with error 31
10:29:29.074983 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
10:29:30.132160 USBPROXY Getting USB descriptor failed with error 31
10:29:30.245411 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
10:29:54.429230 USBPROXY Getting USB descriptor failed with error 31
10:29:54.553278 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
10:31:14.880249 USBPROXY Getting USB descriptor failed with error 31
10:31:15.004238 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
10:52:57.114468          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
10:53:03.372647          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
10:53:03.466998          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
10:53:03.496102          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
10:53:03.578253          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_1cc5c89d7f458113\boinc_1cc5c89d7f458113.vbox" with version "1.16-windows"
10:53:03.680766          Saving settings file "C:\Users\Bingo\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
10:53:03.746726          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
10:53:03.746726          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

01:27:06 (12772): called boinc_finish(194)

</stderr_txt>
]]>


©2024 COPYRIGHT 2017-2018 NCN