Task 8215448

Name	07609392_07_2
Workunit	6580865
Created	13 Dec 2019, 16:43:41 UTC
Sent	13 Dec 2019, 16:51:43 UTC
Report deadline	18 Dec 2019, 16:51:43 UTC
Received	21 Dec 2019, 13:07:57 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED
Computer ID	4000
Run time	3 hours 33 min 2 sec
CPU time	5 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	2.87 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	91.13 MB
Peak swap size	97.38 MB
Peak disk usage	600.79 MB
Stderr output

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

2019-12-18 15:42:07 (16508): Guest Log: CPUID EDX: 0x078bf3ff

2019-12-18 15:42:07 (16508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-12-18 15:42:07 (16508): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-12-18 15:42:07 (16508): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-12-18 15:42:07 (16508): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-12-18 15:42:07 (16508): Guest Log: BIOS: Booting from CD-ROM...

2019-12-18 15:42:07 (16508): Successfully started VM. (PID = '17312')
2019-12-18 15:42:07 (16508): Reporting VM Process ID to BOINC.
2019-12-18 15:42:12 (16508): VM state change detected. (old = 'poweroff', new = 'running')
2019-12-18 15:42:22 (16508): Preference change detected
2019-12-18 15:42:22 (16508): Setting CPU throttle for VM. (60%)
2019-12-18 15:42:22 (16508): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-12-18 16:37:11 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:37:21 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:39:02 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:39:22 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:42:52 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:43:23 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:43:33 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:43:43 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:43:53 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:44:13 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:44:33 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:44:53 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:45:03 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:45:13 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 16:45:23 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 16:45:43 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 17:13:03 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 17:13:13 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 17:25:40 (16508): Status Report: Elapsed Time: '6002.661579'
2019-12-18 17:25:40 (16508): Status Report: CPU Time: '5.140625'
2019-12-18 17:39:08 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 17:39:18 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 17:48:09 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 17:48:19 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 18:39:05 (16508): VM state change detected. (old = 'running', new = 'paused')
2019-12-18 18:39:15 (16508): VM state change detected. (old = 'paused', new = 'running')
2019-12-18 19:06:31 (16508): Status Report: Elapsed Time: '12007.594461'
2019-12-18 19:06:31 (16508): Status Report: CPU Time: '5.281250'
2019-12-18 19:17:38 (16508): Powering off VM.
2019-12-18 19:17:39 (16508): Successfully stopped VM.
2019-12-18 19:17:44 (16508): Deregistering VM. (boinc_3e23e6e33b602d4d, slot#0)
2019-12-18 19:17:44 (16508): Removing virtual disk drive(s) from VM.
2019-12-18 19:17:44 (16508): Removing network bandwidth throttle group from VM.
2019-12-18 19:17:44 (16508): Removing storage controller(s) from VM.
2019-12-18 19:17:44 (16508): Removing VM from VirtualBox.

    Hypervisor System Log:

08:02:34.900981          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_b8453749be566910\boinc_b8453749be566910.vbox" with version "1.16-windows"
08:02:34.912975          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
08:02:34.925967          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
08:02:34.925967          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
08:02:50.267745          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_d4a11caf9be09293'}, preserve=false aResultDetail=0
08:02:50.304724          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
08:02:50.311721          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
08:02:50.408664          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
08:02:57.250347          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
08:03:17.345532          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
11:37:42.435086          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
11:37:48.514690          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
11:37:48.533663          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
11:37:48.545658          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
11:37:48.557651          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_d4a11caf9be09293\boinc_d4a11caf9be09293.vbox" with version "1.16-windows"
11:37:48.573645          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
11:37:48.589630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
11:37:48.589630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
11:38:04.390283          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_157e3d3896af77ae'}, preserve=false aResultDetail=0
11:38:04.429258          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
11:38:04.440263          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
11:38:04.559172          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
11:38:11.784178          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
11:38:31.949188          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
15:11:38.073472          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
15:11:44.174710          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
15:11:44.212943          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
15:11:44.233991          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
15:11:44.251182          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_157e3d3896af77ae\boinc_157e3d3896af77ae.vbox" with version "1.16-windows"
15:11:44.266465          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
15:11:44.281194          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
15:11:44.281194          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
15:12:04.140658          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_3e23e6e33b602d4d'}, preserve=false aResultDetail=0
15:12:04.178153          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
15:12:04.189125          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
15:12:04.291758          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
15:12:11.762043          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
15:12:31.915198          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
17:54:27.149877 USBPROXY Getting USB descriptor failed with error 31
18:47:48.545652          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
18:47:54.619222          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
18:47:54.638210          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
18:47:54.652203          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
18:47:54.665196          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_3e23e6e33b602d4d\boinc_3e23e6e33b602d4d.vbox" with version "1.16-windows"
18:47:54.681185          Saving settings file "C:\Users\senklu2\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
18:47:54.698176          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
18:47:54.699175          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:

19:17:55 (16508): called boinc_finish(194)

</stderr_txt>
]]>