Task 8734153

Name	07830545_14_4
Workunit	6919423
Created	9 Jul 2020, 6:48:30 UTC
Sent	9 Jul 2020, 8:45:53 UTC
Report deadline	14 Jul 2020, 8:45:53 UTC
Received	9 Jul 2020, 13:37:07 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED
Computer ID	6750
Run time	1 hours 43 min 34 sec
CPU time	2 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	4.15 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	84.92 MB
Peak swap size	94.93 MB
Peak disk usage	499.07 MB
Stderr output

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

2020-07-09 17:50:13 (7196): Guest Log: CPUID EDX: 0x078bf3ff

2020-07-09 17:50:13 (7196): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-07-09 17:50:13 (7196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2020-07-09 17:50:13 (7196): Guest Log: BIOS: Boot from Hard Disk 0 failed

2020-07-09 17:50:13 (7196): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2020-07-09 17:50:13 (7196): Guest Log: BIOS: Booting from CD-ROM...

2020-07-09 17:50:13 (7196): Successfully started VM. (PID = '1500')
2020-07-09 17:50:13 (7196): Reporting VM Process ID to BOINC.
2020-07-09 17:50:18 (7196): VM state change detected. (old = 'poweroff', new = 'running')
2020-07-09 17:50:28 (7196): Preference change detected
2020-07-09 17:50:28 (7196): Setting CPU throttle for VM. (100%)
2020-07-09 17:50:28 (7196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2020-07-09 17:58:39 (7196): Preference change detected
2020-07-09 17:58:39 (7196): Setting CPU throttle for VM. (100%)
2020-07-09 17:58:39 (7196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2020-07-09 18:19:25 (7196): Preference change detected
2020-07-09 18:19:25 (7196): Setting CPU throttle for VM. (100%)
2020-07-09 18:19:25 (7196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2020-07-09 18:25:36 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:25:46 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:26:06 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:26:16 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:27:36 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:27:46 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:33:32 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:33:52 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:34:52 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:36:22 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:36:32 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:36:52 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:37:03 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:37:13 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:45:23 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:45:33 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:49:54 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:50:04 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 18:57:54 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 18:58:04 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 19:00:25 (7196): Preference change detected
2020-07-09 19:00:25 (7196): Setting CPU throttle for VM. (100%)
2020-07-09 19:00:25 (7196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2020-07-09 19:00:55 (7196): VM state change detected. (old = 'running', new = 'paused')
2020-07-09 19:01:05 (7196): VM state change detected. (old = 'paused', new = 'running')
2020-07-09 19:34:58 (7196): Status Report: Elapsed Time: '6004.700470'
2020-07-09 19:34:58 (7196): Status Report: CPU Time: '2.875000'
2020-07-09 19:36:49 (7196): Powering off VM.
2020-07-09 19:36:50 (7196): Successfully stopped VM.
2020-07-09 19:36:55 (7196): Deregistering VM. (boinc_165f3bad27174d0e, slot#0)
2020-07-09 19:36:55 (7196): Removing virtual disk drive(s) from VM.
2020-07-09 19:36:55 (7196): Removing network bandwidth throttle group from VM.
2020-07-09 19:36:55 (7196): Removing storage controller(s) from VM.
2020-07-09 19:36:55 (7196): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:00.080056          Loading settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:00.086060          Getting USB descriptor failed with error 31
00:00:00.104073          HostDnsMonitor: old information
00:00:00.104073            no server entries
00:00:00.104073            no domain set
00:00:00.104073            no search string entries
00:00:00.104073          HostDnsMonitor: new information
00:00:00.104073            server 1: 1.1.1.1
00:00:00.104073            server 2: 1.0.0.1
00:00:00.104073            no domain set
00:00:00.104073            no search string entries
00:00:00.104073          HostDnsMonitorProxy::notify
00:00:00.155109          SUPR0QueryVTCaps -> VERR_VMX_MSR_ALL_VMX_DISABLED
00:00:00.155109          VD: VDInit finished with VINF_SUCCESS
00:00:00.156110          VirtualBox: object created
00:00:00.169119          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_0f0d44db9db4d0de'}, preserve=false aResultDetail=0
00:00:00.173122          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
00:00:00.704497          Saving settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:00.784554          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
00:00:06.890861          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:26.929993          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
00:44:14.198489          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_03bd38850ce3d162'}, preserve=false aResultDetail=0
00:44:14.206294          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_03bd38850ce3d162\boinc_03bd38850ce3d162.vbox" with version "1.16-windows"
00:44:14.415446          Saving settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:44:14.487382          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_03bd38850ce3d162\boinc_03bd38850ce3d162.vbox" with version "1.16-windows"
00:44:18.068982          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:44:38.155513          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_03bd38850ce3d162\boinc_03bd38850ce3d162.vbox" with version "1.16-windows"
02:03:07.576162          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
02:03:13.624914          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
02:03:13.634680          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
02:03:13.851395          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0f0d44db9db4d0de\boinc_0f0d44db9db4d0de.vbox" with version "1.16-windows"
02:03:13.942795          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
02:03:13.947682          Saving settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
02:03:13.972731          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
02:03:13.972731          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
02:03:26.239147          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_165f3bad27174d0e'}, preserve=false aResultDetail=0
02:03:26.249900          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
02:03:26.692374          Saving settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
02:03:26.812139          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
02:03:30.507430          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
02:03:50.592951          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
02:12:00.669764          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_03bd38850ce3d162\boinc_03bd38850ce3d162.vbox" with version "1.16-windows"
02:12:01.650252          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
02:31:40.662706 USBPROXY Getting USB descriptor failed with error 31
02:32:48.401568          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
03:13:47.565453          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
03:30:37.281236          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_03bd38850ce3d162\boinc_03bd38850ce3d162.vbox" with version "1.16-windows"
03:50:11.724494          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
03:50:17.784247          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
03:50:17.795014          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
03:50:17.829924          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_165f3bad27174d0e\boinc_165f3bad27174d0e.vbox" with version "1.16-windows"
03:50:17.850654          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
03:50:17.855561          Saving settings file "C:\Users\ADMIN\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
03:50:17.886141          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
03:50:17.887123          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

19:37:05 (7196): called boinc_finish(194)

</stderr_txt>
]]>