Task 3645173
| Name | 07318292_080_0 |
| Workunit | 2865962 |
| Created | 16 Jul 2019, 19:41:45 UTC |
| Sent | 16 Jul 2019, 22:33:38 UTC |
| Report deadline | 21 Jul 2019, 22:33:38 UTC |
| Received | 17 Jul 2019, 13:14:31 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED |
| Computer ID | 2562 |
| Run time | 8 hours 48 min 53 sec |
| CPU time | 33 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 0.75 GFLOPS |
| Application version | boinc2docker v1.12 (vbox64_mt) windows_x86_64 |
| Peak working set size | 80.24 MB |
| Peak swap size | 86.59 MB |
| Peak disk usage | 499.37 MB |
Stderr output
<core_client_version>7.14.2</core_client_version>
<![CDATA[
<message>
exceeded elapsed time limit 31710.87 (86400.00G/2.72G)</message>
<stderr_txt>
2019-07-16 15:36:16 (3384): vboxwrapper (7.9.26200): starting
2019-07-16 15:36:16 (3384): Feature: Checkpoint interval offset (203 seconds)
2019-07-16 15:36:16 (3384): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-16 15:36:16 (3384): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-16 15:36:16 (3384): Create VM. (boinc_0442c405749829b2, slot#2)
2019-07-16 15:36:16 (3384): Updating drive controller type and model for desired configuration.
2019-07-16 15:36:17 (3384): Setting Memory Size for VM. (3072MB)
2019-07-16 15:36:17 (3384): Setting CPU Count for VM. (1)
2019-07-16 15:36:17 (3384): Setting Chipset Options for VM.
2019-07-16 15:36:17 (3384): Setting Boot Options for VM.
2019-07-16 15:36:17 (3384): Enabling VM Network Access.
2019-07-16 15:36:17 (3384): Setting Network Configuration for NAT.
2019-07-16 15:36:17 (3384): Disabling USB Support for VM.
2019-07-16 15:36:17 (3384): Disabling COM Port Support for VM.
2019-07-16 15:36:17 (3384): Disabling LPT Port Support for VM.
2019-07-16 15:36:17 (3384): Disabling Audio Support for VM.
2019-07-16 15:36:17 (3384): Disabling Clipboard Support for VM.
2019-07-16 15:36:17 (3384): Disabling Drag and Drop Support for VM.
2019-07-16 15:36:17 (3384): Adding storage controller(s) to VM.
2019-07-16 15:36:17 (3384): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-07-16 15:36:20 (3384): Adding VirtualBox Guest Additions to VM.
2019-07-16 15:36:20 (3384): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-07-16 15:36:20 (3384): Enabling shared directory for VM.
2019-07-16 15:36:20 (3384): Starting VM. (boinc_0442c405749829b2, slot#2)
2019-07-16 15:36:33 (3384): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-16 15:36:33 (3384): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-16 15:36:33 (3384): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-16 15:36:33 (3384): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-16 15:36:33 (3384): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-16 15:36:33 (3384): Guest Log: BIOS: Booting from CD-ROM...
2019-07-16 15:36:33 (3384): Successfully started VM. (PID = '5744')
2019-07-16 15:36:33 (3384): Reporting VM Process ID to BOINC.
2019-07-16 15:36:38 (3384): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-16 15:36:48 (3384): Preference change detected
2019-07-16 15:36:48 (3384): Setting CPU throttle for VM. (96%)
2019-07-16 15:36:48 (3384): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-16 16:41:41 (3384): Preference change detected
2019-07-16 16:41:41 (3384): Setting CPU throttle for VM. (96%)
2019-07-16 16:41:41 (3384): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-16 17:16:51 (3384): Status Report: Elapsed Time: '6003.058792'
2019-07-16 17:16:51 (3384): Status Report: CPU Time: '35.147025'
2019-07-16 17:39:17 (4692): vboxwrapper (7.9.26200): starting
2019-07-16 17:39:20 (4692): Feature: Checkpoint interval offset (281 seconds)
2019-07-16 17:39:20 (4692): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-16 17:39:20 (4692): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-16 17:39:21 (4692): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-16 17:39:21 (4692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-16 17:39:21 (4692): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-16 17:39:21 (4692): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-16 17:39:21 (4692): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-16 17:39:21 (4692): Guest Log: BIOS: Booting from CD-ROM...
2019-07-16 17:39:21 (4692): Starting VM. (boinc_0442c405749829b2, slot#2)
2019-07-16 17:39:35 (4692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-16 17:39:35 (4692): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-16 17:39:35 (4692): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-16 17:39:35 (4692): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-16 17:39:35 (4692): Guest Log: BIOS: Booting from CD-ROM...
2019-07-16 17:39:35 (4692): Successfully started VM. (PID = '3988')
2019-07-16 17:39:35 (4692): Reporting VM Process ID to BOINC.
2019-07-16 17:39:40 (4692): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-16 17:39:50 (4692): Preference change detected
2019-07-16 17:39:50 (4692): Setting CPU throttle for VM. (96%)
2019-07-16 17:39:50 (4692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-16 19:19:53 (4692): Status Report: Elapsed Time: '6002.901270'
2019-07-16 19:19:53 (4692): Status Report: CPU Time: '17.409712'
2019-07-17 00:35:43 (4492): vboxwrapper (7.9.26200): starting
2019-07-17 00:41:21 (4820): vboxwrapper (7.9.26200): starting
2019-07-17 00:41:26 (4820): Feature: Checkpoint interval offset (288 seconds)
2019-07-17 00:41:26 (4820): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-17 00:41:26 (4820): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-17 00:41:26 (4820): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-17 00:41:26 (4820): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 00:41:26 (4820): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 00:41:26 (4820): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 00:41:26 (4820): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 00:41:26 (4820): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 00:41:26 (4820): Starting VM. (boinc_0442c405749829b2, slot#2)
2019-07-17 00:41:45 (4820): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 00:41:45 (4820): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 00:41:45 (4820): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 00:41:45 (4820): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 00:41:45 (4820): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 00:41:45 (4820): Successfully started VM. (PID = '4528')
2019-07-17 00:41:45 (4820): Reporting VM Process ID to BOINC.
2019-07-17 00:41:50 (4820): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 00:42:00 (4820): Status Report: Elapsed Time: '7932.764832'
2019-07-17 00:42:00 (4820): Status Report: CPU Time: '17.690513'
2019-07-17 00:42:00 (4820): Preference change detected
2019-07-17 00:42:00 (4820): Setting CPU throttle for VM. (96%)
2019-07-17 00:42:08 (4820): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-17 02:22:05 (4820): Status Report: Elapsed Time: '13937.443825'
2019-07-17 02:22:05 (4820): Status Report: CPU Time: '32.775810'
2019-07-17 04:02:06 (4820): Status Report: Elapsed Time: '19939.088437'
2019-07-17 04:02:06 (4820): Status Report: CPU Time: '33.103412'
2019-07-17 05:42:08 (4820): Status Report: Elapsed Time: '25940.350998'
2019-07-17 05:42:08 (4820): Status Report: CPU Time: '33.540215'
2019-07-17 06:12:46 (4820): Powering off VM.
2019-07-17 06:12:47 (4820): Successfully stopped VM.
2019-07-17 06:12:52 (4820): Deregistering VM. (boinc_0442c405749829b2, slot#2)
2019-07-17 06:12:52 (4820): Removing virtual disk drive(s) from VM.
2019-07-17 06:12:52 (4820): Removing network bandwidth throttle group from VM.
2019-07-17 06:12:52 (4820): Removing storage controller(s) from VM.
2019-07-17 06:12:52 (4820): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:00.265200 main AssertLogRel F:\tinderbox\win-5.1\src\VBox\Main\src-all\win\VBoxProxyStub.c(837) long __cdecl vbpsCreateRegKeyA(struct VBPSREGSTATE *,struct HKEY__ *,const char *,struct HKEY__ **,unsigned int): VBPS_LOGREL_NO_ASSERT(rc == ERROR_ACCESS_DENIED)
00:00:00.265200 main 1201: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}' -> 5
00:00:00.265200 main AssertLogRel F:\tinderbox\win-5.1\src\VBox\Main\src-all\win\VBoxProxyStub.c(932) 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.265200 main 1201: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}'(/Default='VirtualBoxClient Class') -> 5
00:00:00.280800 VirtualBox: object creation starts
00:00:00.280800 Home directory: 'C:\Users\SAB\.VirtualBox'
00:00:00.280800 Installed Drivers:
00:00:00.296400 C:\Windows\system32\DRIVERS\VBoxNetLwf.sys (Version: 5.1.26.17224)
00:00:00.312000 C:\Windows\system32\DRIVERS\VBoxUSBMon.sys (Version: 5.1.26.17224)
00:00:00.327600 C:\Windows\system32\DRIVERS\VBoxDrv.sys (Version: 5.1.26.17224)
00:00:00.358800 C:\Windows\system32\DRIVERS\VBoxNetAdp6.sys (Version: 5.1.26.17224)
00:00:00.374400 Loading settings file "C:\Users\SAB\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:00.546000 usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
00:00:00.546000 USB: Unknown USB device detected (idVendor: 0x5986, idProduct: 0x02ac)
00:00:00.967201 HostDnsMonitor: old information
00:00:00.967201 no server entries
00:00:00.967201 no domain set
00:00:00.967201 no search string entries
00:00:00.967201 HostDnsMonitor: new information
00:00:00.967201 server 1: 192.168.1.1
00:00:00.967201 no domain set
00:00:00.967201 no search string entries
00:00:00.967201 HostDnsMonitorProxy::notify
00:00:02.449204 SUPR0QueryVTCaps -> VERR_SVM_DISABLED
00:00:02.464804 VD: VDInit finished
00:00:02.480404 Loading settings file "C:\ProgramData\BOINC\slots\1\boinc_d8d831b7a591c23e\boinc_d8d831b7a591c23e.vbox" with version "1.16-windows"
00:00:02.496004 Loading settings file "C:\ProgramData\BOINC\slots\0\boinc_35efcbb64751a4b7\boinc_35efcbb64751a4b7.vbox" with version "1.16-windows"
00:00:02.511604 Loading settings file "C:\ProgramData\BOINC\slots\2\boinc_0442c405749829b2\boinc_0442c405749829b2.vbox" with version "1.16-windows"
00:00:02.527204 Loading settings file "C:\ProgramData\BOINC\slots\3\boinc_2de5a5a09b70bd48\boinc_2de5a5a09b70bd48.vbox" with version "1.16-windows"
00:00:02.542804 Loading settings file "C:\ProgramData\BOINC\slots\4\boinc_2e1102eaf7d27520\boinc_2e1102eaf7d27520.vbox" with version "1.16-windows"
00:00:02.542804 VirtualBox: object created
00:00:14.860803 ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
00:00:15.089332 ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
00:00:15.096833 ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
00:00:22.282745 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
00:00:50.048771 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
00:00:50.050271 USBPROXY USB: Unknown USB device detected (idVendor: 0x5986, idProduct: 0x02ac)
00:01:05.105683 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
00:25:04.369946 USBPROXY usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
04:54:28.961589 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
04:54:28.992093 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
04:54:29.002594 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
04:54:29.003094 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
04:54:53.120657 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={0169423f-46b4-cde9-91af-1e9d5b6cd945} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_4609fd26adf342d0'}, preserve=false aResultDetail=0
04:55:00.438086 ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
05:07:00.196483 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
05:07:00.225987 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
05:07:00.236489 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
05:07:00.236989 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
05:07:16.347034 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={0169423f-46b4-cde9-91af-1e9d5b6cd945} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_60183543010315f4'}, preserve=false aResultDetail=0
05:07:25.238163 ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
05:31:28.901985 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
05:31:28.972994 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
05:31:28.984996 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
05:31:28.985496 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:
06:13:02 (4820): called boinc_finish(194)
</stderr_txt>
]]>
©2024 COPYRIGHT 2017-2018 NCN