Task 3645205
| Name | 07318292_112_0 |
| Workunit | 2865994 |
| Created | 16 Jul 2019, 19:41:46 UTC |
| Sent | 16 Jul 2019, 22:33:38 UTC |
| Report deadline | 21 Jul 2019, 22:33:38 UTC |
| Received | 17 Jul 2019, 23:05:32 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 | 52 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.49 MB |
| Peak swap size | 86.54 MB |
| Peak disk usage | 499.28 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-17 05:36:16 (5396): vboxwrapper (7.9.26200): starting
2019-07-17 05:36:16 (5396): Feature: Checkpoint interval offset (323 seconds)
2019-07-17 05:36:16 (5396): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-17 05:36:16 (5396): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-17 05:36:16 (5396): Create VM. (boinc_4609fd26adf342d0, slot#5)
2019-07-17 05:36:16 (5396): Updating drive controller type and model for desired configuration.
2019-07-17 05:36:16 (5396): Setting Memory Size for VM. (3072MB)
2019-07-17 05:36:16 (5396): Setting CPU Count for VM. (1)
2019-07-17 05:36:16 (5396): Setting Chipset Options for VM.
2019-07-17 05:36:16 (5396): Setting Boot Options for VM.
2019-07-17 05:36:16 (5396): Enabling VM Network Access.
2019-07-17 05:36:16 (5396): Setting Network Configuration for NAT.
2019-07-17 05:36:16 (5396): Disabling USB Support for VM.
2019-07-17 05:36:16 (5396): Disabling COM Port Support for VM.
2019-07-17 05:36:16 (5396): Disabling LPT Port Support for VM.
2019-07-17 05:36:16 (5396): Disabling Audio Support for VM.
2019-07-17 05:36:16 (5396): Disabling Clipboard Support for VM.
2019-07-17 05:36:16 (5396): Disabling Drag and Drop Support for VM.
2019-07-17 05:36:16 (5396): Adding storage controller(s) to VM.
2019-07-17 05:36:16 (5396): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-07-17 05:36:16 (5396): Adding VirtualBox Guest Additions to VM.
2019-07-17 05:36:16 (5396): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-07-17 05:36:16 (5396): Enabling shared directory for VM.
2019-07-17 05:36:16 (5396): Starting VM. (boinc_4609fd26adf342d0, slot#5)
2019-07-17 05:36:29 (5396): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-17 05:36:29 (5396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 05:36:29 (5396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 05:36:29 (5396): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 05:36:29 (5396): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 05:36:29 (5396): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 05:36:29 (5396): Successfully started VM. (PID = '1436')
2019-07-17 05:36:29 (5396): Reporting VM Process ID to BOINC.
2019-07-17 05:36:34 (5396): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 05:36:44 (5396): Preference change detected
2019-07-17 05:36:44 (5396): Setting CPU throttle for VM. (96%)
2019-07-17 05:36:44 (5396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-17 07:16:45 (5396): Status Report: Elapsed Time: '6001.360075'
2019-07-17 07:16:45 (5396): Status Report: CPU Time: '8.580055'
2019-07-17 08:06:52 (5396): Preference change detected
2019-07-17 08:06:52 (5396): Setting CPU throttle for VM. (96%)
2019-07-17 08:06:52 (5396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-17 08:56:50 (5396): Status Report: Elapsed Time: '12005.865049'
2019-07-17 08:56:50 (5396): Status Report: CPU Time: '9.765663'
2019-07-17 11:02:02 (212): vboxwrapper (7.9.26200): starting
2019-07-17 11:02:07 (212): Feature: Checkpoint interval offset (13 seconds)
2019-07-17 11:02:07 (212): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-17 11:02:07 (212): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-17 11:02:07 (212): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-17 11:02:07 (212): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 11:02:07 (212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 11:02:07 (212): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 11:02:07 (212): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 11:02:07 (212): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 11:02:07 (212): Starting VM. (boinc_4609fd26adf342d0, slot#5)
2019-07-17 11:02:34 (212): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-17 11:02:34 (212): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 11:02:34 (212): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 11:02:34 (212): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 11:02:34 (212): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 11:02:34 (212): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 11:02:34 (212): Successfully started VM. (PID = '4000')
2019-07-17 11:02:34 (212): Reporting VM Process ID to BOINC.
2019-07-17 11:02:40 (212): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 11:02:54 (212): Status Report: Elapsed Time: '17545.212454'
2019-07-17 11:02:54 (212): Status Report: CPU Time: '11.388073'
2019-07-17 11:02:54 (212): Preference change detected
2019-07-17 11:02:54 (212): Setting CPU throttle for VM. (96%)
2019-07-17 11:02:54 (212): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-17 12:42:56 (212): Status Report: Elapsed Time: '23547.300120'
2019-07-17 12:42:56 (212): Status Report: CPU Time: '32.931811'
2019-07-17 14:22:58 (212): Status Report: Elapsed Time: '29549.684328'
2019-07-17 14:22:58 (212): Status Report: CPU Time: '34.304620'
2019-07-17 16:01:32 (4620): vboxwrapper (7.9.26200): starting
2019-07-17 16:01:35 (4620): Feature: Checkpoint interval offset (276 seconds)
2019-07-17 16:01:35 (4620): Detected: VirtualBox COM Interface (Version: 5.1.26)
2019-07-17 16:01:35 (4620): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-07-17 16:01:35 (4620): Guest Log: BIOS: VirtualBox 5.1.26
2019-07-17 16:01:35 (4620): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-07-17 16:01:35 (4620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-07-17 16:01:35 (4620): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-07-17 16:01:35 (4620): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-07-17 16:01:35 (4620): Guest Log: BIOS: Booting from CD-ROM...
2019-07-17 16:01:35 (4620): Starting VM. (boinc_4609fd26adf342d0, slot#5)
2019-07-17 16:01:53 (4620): Successfully started VM. (PID = '1320')
2019-07-17 16:01:53 (4620): Reporting VM Process ID to BOINC.
2019-07-17 16:01:58 (4620): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-17 16:02:08 (4620): Status Report: Elapsed Time: '31473.619639'
2019-07-17 16:02:08 (4620): Status Report: CPU Time: '34.647822'
2019-07-17 16:02:08 (4620): Preference change detected
2019-07-17 16:02:08 (4620): Setting CPU throttle for VM. (96%)
2019-07-17 16:02:08 (4620): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-07-17 16:03:58 (4620): Powering off VM.
2019-07-17 16:03:59 (4620): Successfully stopped VM.
2019-07-17 16:04:04 (4620): Deregistering VM. (boinc_4609fd26adf342d0, slot#5)
2019-07-17 16:04:04 (4620): Removing virtual disk drive(s) from VM.
2019-07-17 16:04:04 (4620): Removing network bandwidth throttle group from VM.
2019-07-17 16:04:04 (4620): Removing storage controller(s) from VM.
2019-07-17 16:04:04 (4620): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.Session.1'(/Default='Session Class') -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.Session' -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.Session'(/Default='Session Class') -> 5
00:00:00.218400 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.218400 main 1201: create key '{3c02f46d-c9d2-4f11-a384-53f0cf917214}' -> 5
00:00:00.218400 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.218400 main 1201: create key '{3c02f46d-c9d2-4f11-a384-53f0cf917214}'(/Default='Session Class') -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.VirtualBoxClient.1' -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.VirtualBoxClient.1'(/Default='VirtualBoxClient Class') -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.VirtualBoxClient' -> 5
00:00:00.218400 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.218400 main 1115: create key 'VirtualBox.VirtualBoxClient'(/Default='VirtualBoxClient Class') -> 5
00:00:00.218400 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.218400 main 1201: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}' -> 5
00:00:00.218400 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.218400 main 1201: create key '{dd3fc71d-26c0-4fe1-bf6f-67f633265bba}'(/Default='VirtualBoxClient Class') -> 5
00:00:00.234000 VirtualBox: object creation starts
00:00:00.234000 Home directory: 'C:\Users\SAB\.VirtualBox'
00:00:00.234000 Installed Drivers:
00:00:00.249600 C:\Windows\system32\DRIVERS\VBoxNetLwf.sys (Version: 5.1.26.17224)
00:00:00.265200 C:\Windows\system32\DRIVERS\VBoxUSBMon.sys (Version: 5.1.26.17224)
00:00:00.265200 C:\Windows\system32\DRIVERS\VBoxDrv.sys (Version: 5.1.26.17224)
00:00:00.296400 C:\Windows\system32\DRIVERS\VBoxNetAdp6.sys (Version: 5.1.26.17224)
00:00:00.312000 Loading settings file "C:\Users\SAB\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:00.514800 usbLibDevCfgDrGet: DeviceIoControl 1 fail dwErr (31)
00:00:00.514800 USB: Unknown USB device detected (idVendor: 0x5986, idProduct: 0x02ac)
00:00:00.764401 HostDnsMonitor: old information
00:00:00.764401 no server entries
00:00:00.780001 no domain set
00:00:00.780001 no search string entries
00:00:00.780001 HostDnsMonitor: new information
00:00:00.780001 server 1: 192.168.1.1
00:00:00.780001 no domain set
00:00:00.780001 no search string entries
00:00:00.780001 HostDnsMonitorProxy::notify
00:00:01.014001 SUPR0QueryVTCaps -> VERR_SVM_DISABLED
00:00:01.029601 VD: VDInit finished
00:00:01.045201 Loading settings file "C:\ProgramData\BOINC\slots\1\boinc_d8d831b7a591c23e\boinc_d8d831b7a591c23e.vbox" with version "1.16-windows"
00:00:01.060801 Loading settings file "C:\ProgramData\BOINC\slots\0\boinc_35efcbb64751a4b7\boinc_35efcbb64751a4b7.vbox" with version "1.16-windows"
00:00:01.076401 Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_4609fd26adf342d0\boinc_4609fd26adf342d0.vbox" with version "1.16-windows"
00:00:01.123202 Loading settings file "C:\ProgramData\BOINC\slots\3\boinc_60183543010315f4\boinc_60183543010315f4.vbox" with version "1.16-windows"
00:00:01.138802 Loading settings file "C:\ProgramData\BOINC\slots\2\boinc_662aea6f12037a1e\boinc_662aea6f12037a1e.vbox" with version "1.16-windows"
00:00:01.154402 VirtualBox: object created
00:00:13.954344 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:13.956845 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:13.966346 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:02:30.384669 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
00:02:30.420673 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
00:02:30.439676 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:02:30.440176 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:
16:04:14 (4620): called boinc_finish(194)
</stderr_txt>
]]>
©2024 COPYRIGHT 2017-2018 NCN