Task 8287510

Name	07618088_17_1
Workunit	6700506
Created	20 Dec 2019, 17:19:56 UTC
Sent	23 Dec 2019, 12:06:36 UTC
Report deadline	28 Dec 2019, 12:06:36 UTC
Received	25 Dec 2019, 20:41:36 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED
Computer ID	4578
Run time	2 hours 14 min 14 sec
CPU time	5 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	5.17 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	96.12 MB
Peak swap size	98.43 MB
Peak disk usage	227.43 MB
Stderr output

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

2019-12-25 19:03:09 (10052): Guest Log: CPUID EDX: 0x078bf3ff

2019-12-25 19:03:09 (10052): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-12-25 19:03:09 (10052): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-12-25 19:03:09 (10052): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-12-25 19:03:09 (10052): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-12-25 19:03:09 (10052): Guest Log: BIOS: Booting from CD-ROM...

2019-12-25 19:03:09 (10052): Successfully started VM. (PID = '17524')
2019-12-25 19:03:09 (10052): Reporting VM Process ID to BOINC.
2019-12-25 19:03:14 (10052): VM state change detected. (old = 'poweroff', new = 'running')
2019-12-25 19:03:24 (10052): Preference change detected
2019-12-25 19:03:24 (10052): Setting CPU throttle for VM. (100%)
2019-12-25 19:03:24 (10052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-12-25 19:56:24 (10052): Powering off VM.
2019-12-25 19:56:25 (10052): Successfully stopped VM.
2019-12-25 20:04:31 (3788): vboxwrapper (7.9.26200): starting
2019-12-25 20:04:31 (3788): Feature: Checkpoint interval offset (227 seconds)
2019-12-25 20:04:31 (3788): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-12-25 20:04:31 (3788): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-12-25 20:04:31 (3788): Guest Log: BIOS: VirtualBox 5.2.8

2019-12-25 20:04:31 (3788): Guest Log: CPUID EDX: 0x078bf3ff

2019-12-25 20:04:31 (3788): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-12-25 20:04:31 (3788): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-12-25 20:04:31 (3788): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-12-25 20:04:31 (3788): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-12-25 20:04:31 (3788): Guest Log: BIOS: Booting from CD-ROM...

2019-12-25 20:04:31 (3788): Starting VM. (boinc_f5709e76acc40124, slot#5)
2019-12-25 20:04:38 (3788): Successfully started VM. (PID = '10396')
2019-12-25 20:04:38 (3788): Reporting VM Process ID to BOINC.
2019-12-25 20:04:43 (3788): VM state change detected. (old = 'poweroff', new = 'running')
2019-12-25 20:04:53 (3788): Preference change detected
2019-12-25 20:04:53 (3788): Setting CPU throttle for VM. (100%)
2019-12-25 20:04:53 (3788): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-12-25 20:05:13 (3788): Powering off VM.
2019-12-25 20:05:14 (3788): Successfully stopped VM.
2019-12-25 20:05:20 (1704): vboxwrapper (7.9.26200): starting
2019-12-25 20:05:20 (1704): Feature: Checkpoint interval offset (102 seconds)
2019-12-25 20:05:20 (1704): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-12-25 20:05:20 (1704): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-12-25 20:05:20 (1704): Guest Log: BIOS: VirtualBox 5.2.8

2019-12-25 20:05:20 (1704): Guest Log: CPUID EDX: 0x078bf3ff

2019-12-25 20:05:20 (1704): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-12-25 20:05:20 (1704): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-12-25 20:05:20 (1704): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-12-25 20:05:20 (1704): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-12-25 20:05:20 (1704): Guest Log: BIOS: Booting from CD-ROM...

2019-12-25 20:05:20 (1704): Starting VM. (boinc_f5709e76acc40124, slot#5)
2019-12-25 20:05:28 (1704): Successfully started VM. (PID = '12120')
2019-12-25 20:05:28 (1704): Reporting VM Process ID to BOINC.
2019-12-25 20:05:33 (1704): VM state change detected. (old = 'poweroff', new = 'running')
2019-12-25 20:05:43 (1704): Preference change detected
2019-12-25 20:05:43 (1704): Setting CPU throttle for VM. (100%)
2019-12-25 20:05:43 (1704): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-12-25 20:53:42 (1704): Status Report: Elapsed Time: '6004.111203'
2019-12-25 20:53:42 (1704): Status Report: CPU Time: '5.625000'
2019-12-25 21:26:40 (1704): Powering off VM.
2019-12-25 21:26:41 (1704): Successfully stopped VM.
2019-12-25 21:26:46 (1704): Deregistering VM. (boinc_f5709e76acc40124, slot#5)
2019-12-25 21:26:46 (1704): Removing virtual disk drive(s) from VM.
2019-12-25 21:26:46 (1704): Removing network bandwidth throttle group from VM.
2019-12-25 21:26:46 (1704): Removing storage controller(s) from VM.
2019-12-25 21:26:46 (1704): Removing VM from VirtualBox.

    Hypervisor System Log:

32:38:14.694000          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
32:38:34.750730          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
32:38:54.821471          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
32:39:04.185430          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
32:39:24.215209          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
32:51:18.804631 USBPROXY Getting USB descriptor failed with error 31
32:51:18.804631 USBPROXY Getting USB descriptor failed with error 31
32:51:18.823692 USBPROXY USB: Unknown USB device detected (idVendor: 0x0b05, idProduct: 0x1872)
32:54:22.188165          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
32:54:31.569667          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_f80e86fed659ef7e'}, preserve=false aResultDetail=0
32:54:31.574549          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f80e86fed659ef7e\boinc_f80e86fed659ef7e.vbox" with version "1.16-windows"
32:54:31.748983          Saving settings file "C:\Users\Mathias\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
32:54:31.847386          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f80e86fed659ef7e\boinc_f80e86fed659ef7e.vbox" with version "1.16-windows"
32:54:34.441198          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
32:54:42.228652          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_f75db42027ff3563\boinc_f75db42027ff3563.vbox" with version "1.16-windows"
32:54:54.491862          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f80e86fed659ef7e\boinc_f80e86fed659ef7e.vbox" with version "1.16-windows"
33:02:45.412590          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f80e86fed659ef7e\boinc_f80e86fed659ef7e.vbox" with version "1.16-windows"
33:02:55.063447          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
33:03:15.097731          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f80e86fed659ef7e\boinc_f80e86fed659ef7e.vbox" with version "1.16-windows"
33:15:06.461544          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_ec662cf960d2028d\boinc_ec662cf960d2028d.vbox" with version "1.16-windows"
33:15:12.500290          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
33:15:12.502244          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_ec662cf960d2028d\boinc_ec662cf960d2028d.vbox" with version "1.16-windows"
33:15:12.519984          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_ec662cf960d2028d\boinc_ec662cf960d2028d.vbox" with version "1.16-windows"
33:15:12.526820          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
33:15:12.527789          Saving settings file "C:\Users\Mathias\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
33:15:12.537180          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
33:15:12.537180          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
33:15:32.850099          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_0150b0905250c807'}, preserve=false aResultDetail=0
33:15:32.853029          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0150b0905250c807\boinc_0150b0905250c807.vbox" with version "1.16-windows"
33:15:33.063547          Saving settings file "C:\Users\Mathias\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
33:15:33.128060          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0150b0905250c807\boinc_0150b0905250c807.vbox" with version "1.16-windows"
33:15:35.961996          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
33:15:56.005814          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0150b0905250c807\boinc_0150b0905250c807.vbox" with version "1.16-windows"
33:33:08.815132          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0150b0905250c807\boinc_0150b0905250c807.vbox" with version "1.16-windows"
33:33:18.055332          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
33:33:38.090200          Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_0150b0905250c807\boinc_0150b0905250c807.vbox" with version "1.16-windows"
34:00:21.556844          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
34:00:27.602335          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
34:00:27.604289          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
34:00:27.614578          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_f5709e76acc40124\boinc_f5709e76acc40124.vbox" with version "1.16-windows"
34:00:27.623760          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
34:00:27.624731          Saving settings file "C:\Users\Mathias\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
34:00:27.641354          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
34:00:27.641354          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:

21:26:56 (1704): called boinc_finish(194)

</stderr_txt>
]]>