Page 1 of 1

VM hang at 0% or 20% on starting virtual machine

Posted: 30. Dec 2015, 12:13
by cybergatto
Hello I've a fresh installation of vbox. About 50% of my tries to start a VM goes to a window saying "Starting virtual machine 0%".
The only chance to sart the VM is to reboot the host (windows 10 system) and retry.

On the logs I can see:

Vboxsvc.log:

Code: Select all

00:01:57.260252          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Unknown exception
00:01:57.260252          F:\tinderbox\win-5.0\out\win.amd64\release\obj\VBoxAPIWrap\MediumWrap.cpp[2245] (long __cdecl MediumWrap::GetEncryptionSettings(unsigned short **,unsigned short **))}, preserve=false aResultDetail=0
00:01:57.360521          Load [C:\Program Files\Oracle\VirtualBox/ExtensionPacks/Oracle_VM_VirtualBox_Extension_Pack/win.amd64/VBoxHostWebcam.DLL] rc VINF_SUCCESS
00:01:57.437652          ERROR [COM]: aRC=VBOX_E_IPRT_ERROR (0x80bb0005) aIID={f30138d4-e5ea-4b3a-8858-a059de4c93fd} aComponent={SessionMachine} aText={Saved screenshot data is not available (VERR_NOT_SUPPORTED)}, preserve=false aResultDetail=0
on the vbox.log:

Code: Select all

00:00:02.063449 VM: fHMEnabled=true  (configured) fRecompileUser=false fRecompileSupervisor=false
00:00:02.063450 VM: fRawRing1Enabled=false CSAM=true  PATM=true 
00:00:02.063711 HM: HMR3Init: VT-x w/ nested paging and unrestricted guest execution hw support
00:00:02.063794 MM: cbHyperHeap=0x140000 (1310720)
00:00:02.064597 CPUM: fXStateHostMask=0x7; initial: 0x7; host XCR0=0x1f
00:00:02.065843 CPUM: Matched host CPU INTEL 0x6/0x4e/0x3 Intel_Core7_Skylake with CPU DB entry 'Intel Core i7-5600U' (INTEL 0x6/0x3d/0x4 Intel_Core7_Broadwell)
00:00:02.066726 PGM: HCPhysInterPD=0000000036319000 HCPhysInterPaePDPT=0000000036316000 HCPhysInterPaePML4=0000000036314000
00:00:02.066733 PGM: apInterPTs={0000000036318000,0000000036317000} apInterPaePTs={0000000180702000,000000016d183000} apInterPaePDs={000000013fac4000,000000014cd85000,00000001b9206000,0000000136007000} pInterPaePDPT64=0000000036315000
00:00:02.066739 PGM: Host paging mode: AMD64+PGE+NX
00:00:02.066743 PGM: PGMPool: cMaxPages=1072 (u64MaxPages=1058)
00:00:02.066746 PGM: pgmR3PoolInit: cMaxPages=0x430 cMaxUsers=0x860 cMaxPhysExts=0x860 fCacheEnable=true 
00:00:02.079555 TM: GIP - u32Mode=3 (Invariant) u32UpdateHz=92 u32UpdateIntervalNS=10794300 enmUseTscDelta=2 (Pratically Zero) fGetGipCpu=0x3 cCpus=4
00:00:02.079574 TM: GIP - u64CpuHz=2 592 000 999 (0x9a7ecbe7)  SUPGetCpuHzFromGip => 2 592 000 999
00:00:02.079579 TM: GIP - CPU: iCpuSet=0x0 idCpu=0x0 idApic=0x0 iGipCpu=0x1 i64TSCDelta=0 enmState=3 u64CpuHz=2591975789(*) cErrors=0
00:00:02.079582 TM: GIP - CPU: iCpuSet=0x1 idCpu=0x1 idApic=0x1 iGipCpu=0x3 i64TSCDelta=0 enmState=3 u64CpuHz=2592000806(*) cErrors=0
00:00:02.079585 TM: GIP - CPU: iCpuSet=0x2 idCpu=0x2 idApic=0x2 iGipCpu=0x0 i64TSCDelta=0 enmState=3 u64CpuHz=2592000999(*) cErrors=0
00:00:02.079588 TM: GIP - CPU: iCpuSet=0x3 idCpu=0x3 idApic=0x3 iGipCpu=0x2 i64TSCDelta=0 enmState=3 u64CpuHz=2592001015(*) cErrors=0
00:00:02.079636 TM: cTSCTicksPerSecond=2 592 000 999 (0x9a7ecbe7) enmTSCMode=1 (VirtTscEmulated)
00:00:02.079637 TM: TSCTiedToExecution=false TSCNotTiedToHalt=false
00:00:02.080115 VMM: CoreCode: R3=0000000006890000 R0=ffffd00024dc4000 RC=a09b0000 Phys=00000000362f8000 cb=0x1000
00:00:02.080376 GIM: Using provider 'HyperV' (Implementation version: 0)
00:00:02.080383 CPUM: SetGuestCpuIdFeature: Enabled Hypervisor Present bit
00:00:02.080469 AIOMgr: Default manager type is 'Async'
00:00:02.080472 AIOMgr: Default file backend is 'NonBuffered'
00:00:02.080705 BlkCache: Cache successfully initialized. Cache size is 5242880 bytes
00:00:02.080712 BlkCache: Cache commit interval is 10000 ms
00:00:02.080715 BlkCache: Cache commit threshold is 2621440 bytes
00:00:02.329880 PcBios: [SMP] BIOS with 2 CPUs
00:00:02.330001 PcBios: MPS table at 000e1300
00:00:02.330723 PcBios: Using LAN ROM 'C:\Program Files\Oracle\VirtualBox/ExtensionPacks/Oracle_VM_VirtualBox_Extension_Pack/PXE-Intel.rom' with a size of 0xc000 bytes
00:00:02.339160 SUP: Loaded VBoxDDR0.r0 (C:\Program Files\Oracle\VirtualBox\VBoxDDR0.r0) at 0xfffff8001a440000 - ModuleInit at 0000000000000000 and ModuleTerm at 0000000000000000 using the native ring-0 loader
00:00:02.339173 SUP: windbg> .reload /f C:\Program Files\Oracle\VirtualBox\VBoxDDR0.r0=0xfffff8001a440000
00:00:02.345730 SUP: Loaded VBoxDD2R0.r0 (C:\Program Files\Oracle\VirtualBox\VBoxDD2R0.r0) at 0xfffff8001a470000 - ModuleInit at 0000000000000000 and ModuleTerm at 0000000000000000 using the native ring-0 loader
00:00:02.345740 SUP: windbg> .reload /f C:\Program Files\Oracle\VirtualBox\VBoxDD2R0.r0=0xfffff8001a470000
00:00:02.345811 APIC: Activating Local APIC
00:00:02.345815 CPUM: SetGuestCpuIdFeature: Enabled APIC
00:00:02.346334 PIT: mode=3 count=0x10000 (65536) - 18.20 Hz (ch=0)
00:00:02.353443 Shared Folders service loaded
00:00:02.369995 DrvBlock: Flushes will be ignored
00:00:02.370012 DrvBlock: Async flushes will be passed to the disk
00:00:02.370164 VD: VDInit finished
00:00:02.393634 AIOMgr: Endpoint for file 'C:\Users\loren\VirtualBox VMs\Win7\Win7.vdi' (flags 000c0723) created successfully
00:00:02.395494 VD: Opening the disk took 3779849 ns
00:00:02.395552 AHCI: LUN#0: disk, PCHS=16383/16/63, total number of sectors 104857600
00:00:02.395561 AHCI: LUN#0: using async I/O
00:00:02.395767 DrvBlock: Flushes will be ignored
00:00:02.395772 DrvBlock: Async flushes will be passed to the disk
00:00:02.395911 AIOMgr: Endpoint for file 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' (flags 000c0781) created successfully
00:00:02.395918 VD: Opening the disk took 130874 ns
00:00:02.395926 AHCI LUN#1: CD/DVD, total number of sectors 28804, passthrough disabled
00:00:02.395931 AHCI: LUN#1: using async I/O
00:00:02.396050 AHCI#0: Reset the HBA
00:00:02.414833 NAT: DNS#0: 192.168.1.1
00:00:02.415626 Audio: Initializing DirectSound audio driver
00:00:02.495380 DSound: Output: GUID: {0E480161-FA80-4456-AC74-7C9D4E0BE286} [Altoparlanti / cuffie (Realtek High Definition Audio)] (Module: {0.0.0.00000000}.{0e480161-fa80-4456-ac74-7c9d4e0be286})
00:00:02.495394 DSound: Found 1 host playback devices
00:00:02.583043 DSound: Input: GUID: {2216DA56-2231-432B-8620-0016BDAF0D99} [Microfono (Realtek High Definition Audio)] (Module: {0.0.1.00000000}.{2216da56-2231-432b-8620-0016bdaf0d99})
00:00:02.583056 DSound: Found 1 host capturing devices
00:00:02.583060 DSound: Adjusting the number of host capturing devices from 1 to 2
00:00:02.583393 Audio: Initializing VRDE driver
00:00:02.583589 DSound: Guest "Line In" is using host device with GUID: {Default device}
Do you have any idea of how I can resolve this issue?
Thanks
Lorenzo

Re: VM hang at 0% or 20% on starting virtual machine

Posted: 30. Dec 2015, 13:06
by mpack
Please post a VM log file. With the VM fully shut down, right click it in GUI. Select "Show Log" and save "VBox.log" (ONLY) to a zip file. Attach the zip here.