Windows 7 x86-64 gets aborted on Debian.

Discussions related to using VirtualBox on Linux hosts.
Post Reply
ygrishin
Posts: 5
Joined: 3. Jan 2015, 21:23
Primary OS: Debian Wheezy
VBox Version: OSE Debian
Guest OSses: Windows 7

Windows 7 x86-64 gets aborted on Debian.

Post by ygrishin »

Hello,

I have my Windows 7 aborted during innocent operations like opening Firefox browser of running different programs. The Windows' event log compalins only about power being cut off.

Host machine

Code: Select all

Linux volki 3.2.0-4-amd64 #1 SMP Debian 3.2.63-2+deb7u2 x86_64 GNU/Linux
Host machine is 12Gb Ram with 8 cores Xeon X5472 @ 3.2GHz on Intel 5400 chipset,
with 4Gb Ram and 4 cores for the VM (tried with only 1 processor and disabling PAE -- same)

The log right after the VM got aborted, looks like nothing criminal

Code: Select all

VirtualBox VM 4.3.20 r96996 linux.amd64 (Nov 21 2014 15:55:22) release log
00:00:00.282581 Log opened 2015-01-03T16:50:29.909715000Z
00:00:00.282583 Build Type: release
00:00:00.282586 OS Product: Linux
00:00:00.282587 OS Release: 3.2.0-4-amd64
00:00:00.282588 OS Version: #1 SMP Debian 3.2.63-2+deb7u2
00:00:00.282613 DMI Product Name: Precision WorkStation T7400  
00:00:00.282622 DMI Product Version: 
00:00:00.282702 Host RAM: 12043MB total, 10777MB available
00:00:00.282706 Executable: /usr/lib/virtualbox/VirtualBox
00:00:00.282707 Process ID: 5524
00:00:00.282708 Package type: LINUX_64BITS_DEBIAN_7_0
00:00:00.347622 Installed Extension Packs:
00:00:00.347636   None installed!
00:00:00.430305 UIMediumEnumerator: Medium-enumeration finished!
00:00:00.430564 Using XKB for keycode to scan code conversion
00:00:00.431258 SUP: Loaded VMMR0.r0 (/usr/lib/virtualbox/VMMR0.r0) at 0xffffffffa0668020 - ModuleInit at ffffffffa06864f0 and ModuleTerm at ffffffffa0686780
00:00:00.431307 SUP: VMMR0EntryEx located at ffffffffa0687b30, VMMR0EntryFast at ffffffffa0687770 and VMMR0EntryInt at ffffffffa0687760
00:00:00.434127 Guest OS type: 'Windows7_64'
00:00:00.439046 fHMForced=true - Lots of RAM
00:00:00.439064 fHMForced=true - 64-bit guest
00:00:00.449487 File system of '/home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots' (snapshots) is ext4
00:00:00.449501 File system of '/home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots/{3b6a7ae0-8ed3-4d1e-ad28-554099773af4}.vdi' is ext4
00:00:00.462508 Shared clipboard mode: Bidirectional
00:00:00.463303 Drag'n'drop mode: Off
00:00:00.469737 ************************* CFGM dump *************************
00:00:00.469746 [/] (level 0)
00:00:00.469767   CSAMEnabled     <integer> = 0x0000000000000001 (1)
00:00:00.469776   CpuExecutionCap <integer> = 0x0000000000000064 (100)
00:00:00.469778   EnablePAE       <integer> = 0x0000000000000000 (0)
00:00:00.469779   HMEnabled       <integer> = 0x0000000000000001 (1)
00:00:00.469780   MemBalloonSize  <integer> = 0x0000000000000000 (0)
00:00:00.469781   Name            <string>  = "win7-pro-x86-64" (cb=16)
00:00:00.469783   NumCPUs         <integer> = 0x0000000000000001 (1)
00:00:00.469784   PATMEnabled     <integer> = 0x0000000000000001 (1)
00:00:00.469785   PageFusion      <integer> = 0x0000000000000000 (0)
00:00:00.469786   RamHoleSize     <integer> = 0x0000000020000000 (536 870 912, 512 MB)
00:00:00.469789   RamSize         <integer> = 0x0000000100000000 (4 294 967 296, 4 GB)
00:00:00.469791   RawR0Enabled    <integer> = 0x0000000000000001 (1)
00:00:00.469792   RawR3Enabled    <integer> = 0x0000000000000001 (1)
00:00:00.469793   TimerMillies    <integer> = 0x000000000000000a (10)
00:00:00.469794   UUID            <bytes>   = "87 6f fa 73 c6 a3 24 40 82 60 ce cf 62 e2 98 8f" (cb=16)
00:00:00.469801 
00:00:00.469805 [/CPUM/] (level 1)
00:00:00.469806   SyntheticCpu <integer> = 0x0000000000000000 (0)
00:00:00.469808 
00:00:00.469812 [/DBGF/] (level 1)
00:00:00.469813   Path <string>  = "/home/grishin/VirtualBox VMs/win7-pro-x86-64/debug/;/home/grishin/VirtualBox VMs/win7-pro-x86-64/;/home/grishin/" (cb=113)
00:00:00.469815 
00:00:00.469816 [/Devices/] (level 1)
00:00:00.469817 
00:00:00.469818 [/Devices/8237A/] (level 2)
00:00:00.469819 
00:00:00.469820 [/Devices/8237A/0/] (level 3)
00:00:00.469821   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.469822 
00:00:00.469823 [/Devices/AudioSniffer/] (level 2)
00:00:00.469825 
00:00:00.469825 [/Devices/AudioSniffer/0/] (level 3)
00:00:00.469827 
00:00:00.469827 [/Devices/AudioSniffer/0/Config/] (level 4)
00:00:00.469829 
00:00:00.469830 [/Devices/AudioSniffer/0/LUN#0/] (level 4)
00:00:00.469832   Driver <string>  = "MainAudioSniffer" (cb=17)
00:00:00.469833 
00:00:00.469833 [/Devices/AudioSniffer/0/LUN#0/Config/] (level 5)
00:00:00.469836   Object <integer> = 0x00007fdff002b860 (140 599 781 144 672)
00:00:00.469837 
00:00:00.469838 [/Devices/VMMDev/] (level 2)
00:00:00.469840 
00:00:00.469840 [/Devices/VMMDev/0/] (level 3)
00:00:00.469843   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.469844   PCIDeviceNo   <integer> = 0x0000000000000004 (4)
00:00:00.469845   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.469846   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.469847 
00:00:00.469848 [/Devices/VMMDev/0/Config/] (level 4)
00:00:00.469850   GuestCoreDumpDir <string>  = "/home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots" (cb=55)
00:00:00.469851   RamSize          <integer> = 0x0000000100000000 (4 294 967 296, 4 GB)
00:00:00.469853 
00:00:00.469853 [/Devices/VMMDev/0/LUN#0/] (level 4)
00:00:00.469855   Driver <string>  = "HGCM" (cb=5)
00:00:00.469856 
00:00:00.469857 [/Devices/VMMDev/0/LUN#0/Config/] (level 5)
00:00:00.469859   Object <integer> = 0x00000000013b7d90 (20 675 984)
00:00:00.469860 
00:00:00.469861 [/Devices/VMMDev/0/LUN#999/] (level 4)
00:00:00.469863   Driver <string>  = "MainStatus" (cb=11)
00:00:00.469864 
00:00:00.469864 [/Devices/VMMDev/0/LUN#999/Config/] (level 5)
00:00:00.469867   First   <integer> = 0x0000000000000000 (0)
00:00:00.469868   Last    <integer> = 0x0000000000000000 (0)
00:00:00.469869   papLeds <integer> = 0x00007fdff0027580 (140 599 781 127 552)
00:00:00.469871 
00:00:00.469872 [/Devices/acpi/] (level 2)
00:00:00.469873 
00:00:00.469874 [/Devices/acpi/0/] (level 3)
00:00:00.469875   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.469877   PCIDeviceNo   <integer> = 0x0000000000000007 (7)
00:00:00.469878   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.469879   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.469880 
00:00:00.469881 [/Devices/acpi/0/Config/] (level 4)
00:00:00.469883   CpuHotPlug        <integer> = 0x0000000000000000 (0)
00:00:00.469885   FdcEnabled        <integer> = 0x0000000000000000 (0)
00:00:00.469886   HostBusPciAddress <integer> = 0x0000000000000000 (0)
00:00:00.469887   HpetEnabled       <integer> = 0x0000000000000000 (0)
00:00:00.469888   IOAPIC            <integer> = 0x0000000000000001 (1)
00:00:00.469890   IocPciAddress     <integer> = 0x0000000000010000 (65 536)
00:00:00.469891   NumCPUs           <integer> = 0x0000000000000001 (1)
00:00:00.469892   RamHoleSize       <integer> = 0x0000000020000000 (536 870 912, 512 MB)
00:00:00.469894   RamSize           <integer> = 0x0000000100000000 (4 294 967 296, 4 GB)
00:00:00.469897   Serial0IoPortBase <integer> = 0x0000000000000000 (0)
00:00:00.469898   Serial0Irq        <integer> = 0x0000000000000000 (0)
00:00:00.469899   Serial1IoPortBase <integer> = 0x0000000000000000 (0)
00:00:00.469900   Serial1Irq        <integer> = 0x0000000000000000 (0)
00:00:00.469901   ShowCpu           <integer> = 0x0000000000000001 (1)
00:00:00.469902   ShowRtc           <integer> = 0x0000000000000000 (0)
00:00:00.469904   SmcEnabled        <integer> = 0x0000000000000000 (0)
00:00:00.469905 
00:00:00.469905 [/Devices/acpi/0/LUN#0/] (level 4)
00:00:00.469907   Driver <string>  = "ACPIHost" (cb=9)
00:00:00.469908 
00:00:00.469909 [/Devices/acpi/0/LUN#0/Config/] (level 5)
00:00:00.469911 
00:00:00.469912 [/Devices/ahci/] (level 2)
00:00:00.469913 
00:00:00.469914 [/Devices/ahci/0/] (level 3)
00:00:00.469916   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.469917   PCIDeviceNo   <integer> = 0x000000000000000d (13)
00:00:00.469918   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.469919   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.469920 
00:00:00.469921 [/Devices/ahci/0/Config/] (level 4)
00:00:00.469923   Bootable  <integer> = 0x0000000000000001 (1)
00:00:00.469924   PortCount <integer> = 0x0000000000000001 (1)
00:00:00.469925 
00:00:00.469925 [/Devices/ahci/0/Config/Port0/] (level 5)
00:00:00.469928   Hotpluggable        <integer> = 0x0000000000000000 (0)
00:00:00.469929   NonRotationalMedium <integer> = 0x0000000000000000 (0)
00:00:00.469930 
00:00:00.469931 [/Devices/ahci/0/LUN#0/] (level 4)
00:00:00.469933   Driver <string>  = "Block" (cb=6)
00:00:00.469934 
00:00:00.469934 [/Devices/ahci/0/LUN#0/AttachedDriver/] (level 5)
00:00:00.469936   Driver <string>  = "VD" (cb=3)
00:00:00.469937 
00:00:00.469938 [/Devices/ahci/0/LUN#0/AttachedDriver/Config/] (level 6)
00:00:00.469940   BlockCache <integer> = 0x0000000000000001 (1)
00:00:00.469941   Format     <string>  = "VDI" (cb=4)
00:00:00.469942   Path       <string>  = "/home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots/{3b6a7ae0-8ed3-4d1e-ad28-554099773af4}.vdi" (cb=98)
00:00:00.469944   Type       <string>  = "HardDisk" (cb=9)
00:00:00.469945   UseNewIo   <integer> = 0x0000000000000001 (1)
00:00:00.469946 
00:00:00.469946 [/Devices/ahci/0/LUN#0/AttachedDriver/Config/Parent/] (level 7)
00:00:00.469949   Format <string>  = "VDI" (cb=4)
00:00:00.469950   Path   <string>  = "/home/grishin/VirtualBox VMs/win7-pro-x86-64/win7-pro-x86-64.vdi" (cb=65)
00:00:00.469951 
00:00:00.469952 [/Devices/ahci/0/LUN#0/Config/] (level 5)
00:00:00.469954   Mountable <integer> = 0x0000000000000000 (0)
00:00:00.469955   Type      <string>  = "HardDisk" (cb=9)
00:00:00.469956 
00:00:00.469956 [/Devices/ahci/0/LUN#999/] (level 4)
00:00:00.469958   Driver <string>  = "MainStatus" (cb=11)
00:00:00.469959 
00:00:00.469960 [/Devices/ahci/0/LUN#999/Config/] (level 5)
00:00:00.469962   DeviceInstance        <string>  = "ahci/0" (cb=7)
00:00:00.469963   First                 <integer> = 0x0000000000000000 (0)
00:00:00.469964   Last                  <integer> = 0x0000000000000000 (0)
00:00:00.469966   pConsole              <integer> = 0x00007fdff0026f90 (140 599 781 126 032)
00:00:00.469968   papLeds               <integer> = 0x00007fdff00272b0 (140 599 781 126 832)
00:00:00.469970   pmapMediumAttachments <integer> = 0x00007fdff0027598 (140 599 781 127 576)
00:00:00.469972 
00:00:00.469972 [/Devices/apic/] (level 2)
00:00:00.469974 
00:00:00.469975 [/Devices/apic/0/] (level 3)
00:00:00.469976   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.469977 
00:00:00.469978 [/Devices/apic/0/Config/] (level 4)
00:00:00.469980   IOAPIC  <integer> = 0x0000000000000001 (1)
00:00:00.469981   NumCPUs <integer> = 0x0000000000000001 (1)
00:00:00.469982 
00:00:00.469983 [/Devices/e1000/] (level 2)
00:00:00.469984 
00:00:00.469985 [/Devices/e1000/0/] (level 3)
00:00:00.469987   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.469988   PCIDeviceNo   <integer> = 0x0000000000000003 (3)
00:00:00.469989   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.469990   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.469991 
00:00:00.469992 [/Devices/e1000/0/Config/] (level 4)
00:00:00.469994   AdapterType    <integer> = 0x0000000000000000 (0)
00:00:00.469995   CableConnected <integer> = 0x0000000000000001 (1)
00:00:00.469996   LineSpeed      <integer> = 0x0000000000000000 (0)
00:00:00.469997   MAC            <bytes>   = "08 00 27 d7 55 bd" (cb=6)
00:00:00.470000 
00:00:00.470000 [/Devices/e1000/0/LUN#0/] (level 4)
00:00:00.470002   Driver <string>  = "NAT" (cb=4)
00:00:00.470003 
00:00:00.470004 [/Devices/e1000/0/LUN#0/Config/] (level 5)
00:00:00.470006   AliasMode       <integer> = 0x0000000000000000 (0)
00:00:00.470008   BootFile        <string>  = "win7-pro-x86-64.pxe" (cb=20)
00:00:00.470009   DNSProxy        <integer> = 0x0000000000000000 (0)
00:00:00.470010   Network         <string>  = "10.0.2.0/24" (cb=12)
00:00:00.470011   PassDomain      <integer> = 0x0000000000000001 (1)
00:00:00.470012   TFTPPrefix      <string>  = "/home/grishin/.config/VirtualBox/TFTP" (cb=38)
00:00:00.470013   UseHostResolver <integer> = 0x0000000000000000 (0)
00:00:00.470014 
00:00:00.470015 [/Devices/e1000/0/LUN#999/] (level 4)
00:00:00.470017   Driver <string>  = "MainStatus" (cb=11)
00:00:00.470018 
00:00:00.470018 [/Devices/e1000/0/LUN#999/Config/] (level 5)
00:00:00.470021   First   <integer> = 0x0000000000000000 (0)
00:00:00.470022   Last    <integer> = 0x0000000000000000 (0)
00:00:00.470023   papLeds <integer> = 0x00007fdff0027460 (140 599 781 127 264)
00:00:00.470025 
00:00:00.470025 [/Devices/i8254/] (level 2)
00:00:00.470027 
00:00:00.470028 [/Devices/i8254/0/] (level 3)
00:00:00.470029 
00:00:00.470030 [/Devices/i8254/0/Config/] (level 4)
00:00:00.470032 
00:00:00.470032 [/Devices/i8259/] (level 2)
00:00:00.470034 
00:00:00.470034 [/Devices/i8259/0/] (level 3)
00:00:00.470036   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470037 
00:00:00.470038 [/Devices/i8259/0/Config/] (level 4)
00:00:00.470039 
00:00:00.470040 [/Devices/ioapic/] (level 2)
00:00:00.470042 
00:00:00.470042 [/Devices/ioapic/0/] (level 3)
00:00:00.470044   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470045 
00:00:00.470045 [/Devices/ioapic/0/Config/] (level 4)
00:00:00.470047   NumCPUs <integer> = 0x0000000000000001 (1)
00:00:00.470048 
00:00:00.470049 [/Devices/mc146818/] (level 2)
00:00:00.470050 
00:00:00.470051 [/Devices/mc146818/0/] (level 3)
00:00:00.470053 
00:00:00.470053 [/Devices/mc146818/0/Config/] (level 4)
00:00:00.470055   UseUTC <integer> = 0x0000000000000000 (0)
00:00:00.470056 
00:00:00.470057 [/Devices/parallel/] (level 2)
00:00:00.470058 
00:00:00.470059 [/Devices/pcarch/] (level 2)
00:00:00.470060 
00:00:00.470061 [/Devices/pcarch/0/] (level 3)
00:00:00.470063   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470064 
00:00:00.470064 [/Devices/pcarch/0/Config/] (level 4)
00:00:00.470066 
00:00:00.470067 [/Devices/pcbios/] (level 2)
00:00:00.470068 
00:00:00.470069 [/Devices/pcbios/0/] (level 3)
00:00:00.470070   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470072 
00:00:00.470072 [/Devices/pcbios/0/Config/] (level 4)
00:00:00.470075   BootDevice0        <string>  = "IDE" (cb=4)
00:00:00.470076   BootDevice1        <string>  = "NONE" (cb=5)
00:00:00.470077   BootDevice2        <string>  = "NONE" (cb=5)
00:00:00.470078   BootDevice3        <string>  = "NONE" (cb=5)
00:00:00.470080   FloppyDevice       <string>  = "i82078" (cb=7)
00:00:00.470080   HardDiskDevice     <string>  = "piix3ide" (cb=9)
00:00:00.470081   IOAPIC             <integer> = 0x0000000000000001 (1)
00:00:00.470083   McfgBase           <integer> = 0x0000000000000000 (0)
00:00:00.470084   McfgLength         <integer> = 0x0000000000000000 (0)
00:00:00.470085   NumCPUs            <integer> = 0x0000000000000001 (1)
00:00:00.470086   PXEDebug           <integer> = 0x0000000000000000 (0)
00:00:00.470088   RamHoleSize        <integer> = 0x0000000020000000 (536 870 912, 512 MB)
00:00:00.470090   RamSize            <integer> = 0x0000000100000000 (4 294 967 296, 4 GB)
00:00:00.470092   SataHardDiskDevice <string>  = "ahci" (cb=5)
00:00:00.470093   SataLUN1           <integer> = 0x0000000000000000 (0)
00:00:00.470094   UUID               <bytes>   = "87 6f fa 73 c6 a3 24 40 82 60 ce cf 62 e2 98 8f" (cb=16)
00:00:00.470098 
00:00:00.470098 [/Devices/pcbios/0/Config/NetBoot/] (level 5)
00:00:00.470101 
00:00:00.470101 [/Devices/pcbios/0/Config/NetBoot/0/] (level 6)
00:00:00.470104   NIC           <integer> = 0x0000000000000000 (0)
00:00:00.470105   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.470106   PCIDeviceNo   <integer> = 0x0000000000000003 (3)
00:00:00.470107   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.470108 
00:00:00.470109 [/Devices/pci/] (level 2)
00:00:00.470111 
00:00:00.470111 [/Devices/pci/0/] (level 3)
00:00:00.470113   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470114 
00:00:00.470114 [/Devices/pci/0/Config/] (level 4)
00:00:00.470116   IOAPIC <integer> = 0x0000000000000001 (1)
00:00:00.470117 
00:00:00.470118 [/Devices/pckbd/] (level 2)
00:00:00.470120 
00:00:00.470120 [/Devices/pckbd/0/] (level 3)
00:00:00.470122   Trusted <integer> = 0x0000000000000001 (1)
00:00:00.470123 
00:00:00.470123 [/Devices/pckbd/0/Config/] (level 4)
00:00:00.470125 
00:00:00.470126 [/Devices/pckbd/0/LUN#0/] (level 4)
00:00:00.470128   Driver <string>  = "KeyboardQueue" (cb=14)
00:00:00.470129 
00:00:00.470130 [/Devices/pckbd/0/LUN#0/AttachedDriver/] (level 5)
00:00:00.470132   Driver <string>  = "MainKeyboard" (cb=13)
00:00:00.470133 
00:00:00.470133 [/Devices/pckbd/0/LUN#0/AttachedDriver/Config/] (level 6)
00:00:00.470136   Object <integer> = 0x00007fdff00290b0 (140 599 781 134 512)
00:00:00.470137 
00:00:00.470138 [/Devices/pckbd/0/LUN#0/Config/] (level 5)
00:00:00.470140   QueueSize <integer> = 0x0000000000000040 (64)
00:00:00.470141 
00:00:00.470142 [/Devices/pckbd/0/LUN#1/] (level 4)
00:00:00.470144   Driver <string>  = "MouseQueue" (cb=11)
00:00:00.470145 
00:00:00.470145 [/Devices/pckbd/0/LUN#1/AttachedDriver/] (level 5)
00:00:00.470148   Driver <string>  = "MainMouse" (cb=10)
00:00:00.470149 
00:00:00.470149 [/Devices/pckbd/0/LUN#1/AttachedDriver/Config/] (level 6)
00:00:00.470152   Object <integer> = 0x00007fdff0029780 (140 599 781 136 256)
00:00:00.470154 
00:00:00.470154 [/Devices/pckbd/0/LUN#1/Config/] (level 5)
00:00:00.470156   QueueSize <integer> = 0x0000000000000080 (128)
00:00:00.470158 
00:00:00.470158 [/Devices/pcnet/] (level 2)
00:00:00.470160 
00:00:00.470160 [/Devices/piix3ide/] (level 2)
00:00:00.470162 
00:00:00.470162 [/Devices/piix3ide/0/] (level 3)
00:00:00.470164   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.470165   PCIDeviceNo   <integer> = 0x0000000000000001 (1)
00:00:00.470167   PCIFunctionNo <integer> = 0x0000000000000001 (1)
00:00:00.470168   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.470169 
00:00:00.470169 [/Devices/piix3ide/0/Config/] (level 4)
00:00:00.470171   Type <string>  = "PIIX4" (cb=6)
00:00:00.470172 
00:00:00.470173 [/Devices/piix3ide/0/Config/SecondaryMaster/] (level 5)
00:00:00.470175   NonRotationalMedium <integer> = 0x0000000000000000 (0)
00:00:00.470176 
00:00:00.470177 [/Devices/piix3ide/0/LUN#2/] (level 4)
00:00:00.470179   Driver <string>  = "Block" (cb=6)
00:00:00.470179 
00:00:00.470180 [/Devices/piix3ide/0/LUN#2/Config/] (level 5)
00:00:00.470182   Mountable <integer> = 0x0000000000000001 (1)
00:00:00.470183   Type      <string>  = "DVD" (cb=4)
00:00:00.470184 
00:00:00.470185 [/Devices/piix3ide/0/LUN#999/] (level 4)
00:00:00.470187   Driver <string>  = "MainStatus" (cb=11)
00:00:00.470188 
00:00:00.470188 [/Devices/piix3ide/0/LUN#999/Config/] (level 5)
00:00:00.470190   DeviceInstance        <string>  = "piix3ide/0" (cb=11)
00:00:00.470191   First                 <integer> = 0x0000000000000000 (0)
00:00:00.470193   Last                  <integer> = 0x0000000000000003 (3)
00:00:00.470194   pConsole              <integer> = 0x00007fdff0026f90 (140 599 781 126 032)
00:00:00.470196   papLeds               <integer> = 0x00007fdff0027290 (140 599 781 126 800)
00:00:00.470198   pmapMediumAttachments <integer> = 0x00007fdff0027598 (140 599 781 127 576)
00:00:00.470200 
00:00:00.470201 [/Devices/serial/] (level 2)
00:00:00.470202 
00:00:00.470203 [/Devices/usb-ohci/] (level 2)
00:00:00.470204 
00:00:00.470205 [/Devices/usb-ohci/0/] (level 3)
00:00:00.470207   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.470208   PCIDeviceNo   <integer> = 0x0000000000000006 (6)
00:00:00.470209   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.470210   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.470211 
00:00:00.470212 [/Devices/usb-ohci/0/Config/] (level 4)
00:00:00.470214 
00:00:00.470214 [/Devices/usb-ohci/0/LUN#0/] (level 4)
00:00:00.470216   Driver <string>  = "VUSBRootHub" (cb=12)
00:00:00.470217 
00:00:00.470218 [/Devices/usb-ohci/0/LUN#0/Config/] (level 5)
00:00:00.470220 
00:00:00.470220 [/Devices/usb-ohci/0/LUN#999/] (level 4)
00:00:00.470222   Driver <string>  = "MainStatus" (cb=11)
00:00:00.470223 
00:00:00.470224 [/Devices/usb-ohci/0/LUN#999/Config/] (level 5)
00:00:00.470226   First   <integer> = 0x0000000000000000 (0)
00:00:00.470227   Last    <integer> = 0x0000000000000000 (0)
00:00:00.470228   papLeds <integer> = 0x00007fdff0027588 (140 599 781 127 560)
00:00:00.470230 
00:00:00.470231 [/Devices/vga/] (level 2)
00:00:00.470232 
00:00:00.470233 [/Devices/vga/0/] (level 3)
00:00:00.470235   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:00.470236   PCIDeviceNo   <integer> = 0x0000000000000002 (2)
00:00:00.470237   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:00.470238   Trusted       <integer> = 0x0000000000000001 (1)
00:00:00.470240 
00:00:00.470240 [/Devices/vga/0/Config/] (level 4)
00:00:00.470242   CustomVideoModes <integer> = 0x0000000000000000 (0)
00:00:00.470243   FadeIn           <integer> = 0x0000000000000001 (1)
00:00:00.470245   FadeOut          <integer> = 0x0000000000000001 (1)
00:00:00.470246   HeightReduction  <integer> = 0x0000000000000000 (0)
00:00:00.470247   LogoFile         <string>  = "" (cb=1)
00:00:00.470248   LogoTime         <integer> = 0x0000000000000000 (0)
00:00:00.470249   MonitorCount     <integer> = 0x0000000000000001 (1)
00:00:00.470250   ShowBootMenu     <integer> = 0x0000000000000002 (2)
00:00:00.470251   VRamSize         <integer> = 0x0000000002000000 (33 554 432, 32 MB)
00:00:00.470253 
00:00:00.470254 [/Devices/vga/0/LUN#0/] (level 4)
00:00:00.470256   Driver <string>  = "MainDisplay" (cb=12)
00:00:00.470257 
00:00:00.470258 [/Devices/vga/0/LUN#0/Config/] (level 5)
00:00:00.470260   Object <integer> = 0x00007fdff0037b60 (140 599 781 194 592)
00:00:00.470262 
00:00:00.470262 [/Devices/virtio-net/] (level 2)
00:00:00.470264 
00:00:00.470264 [/EM/] (level 1)
00:00:00.470266   TripleFaultReset <integer> = 0x0000000000000000 (0)
00:00:00.470267 
00:00:00.470267 [/HM/] (level 1)
00:00:00.470269   64bitEnabled       <integer> = 0x0000000000000001 (1)
00:00:00.470271   EnableLargePages   <integer> = 0x0000000000000000 (0)
00:00:00.470272   EnableNestedPaging <integer> = 0x0000000000000000 (0)
00:00:00.470273   EnableUX           <integer> = 0x0000000000000001 (1)
00:00:00.470274   EnableVPID         <integer> = 0x0000000000000001 (1)
00:00:00.470276   Exclusive          <integer> = 0x0000000000000001 (1)
00:00:00.470277   HMForced           <integer> = 0x0000000000000001 (1)
00:00:00.470278 
00:00:00.470279 [/MM/] (level 1)
00:00:00.470280   CanUseLargerHeap <integer> = 0x0000000000000000 (0)
00:00:00.470281 
00:00:00.470282 [/PDM/] (level 1)
00:00:00.470283 
00:00:00.470284 [/PDM/AsyncCompletion/] (level 2)
00:00:00.470285 
00:00:00.470286 [/PDM/AsyncCompletion/File/] (level 3)
00:00:00.470288 
00:00:00.470288 [/PDM/AsyncCompletion/File/BwGroups/] (level 4)
00:00:00.470290 
00:00:00.470291 [/PDM/BlkCache/] (level 2)
00:00:00.470292   CacheSize <integer> = 0x0000000000500000 (5 242 880, 5 MB)
00:00:00.470294 
00:00:00.470295 [/PDM/Devices/] (level 2)
00:00:00.470296 
00:00:00.470297 [/PDM/Drivers/] (level 2)
00:00:00.470299 
00:00:00.470299 [/PDM/Drivers/VBoxC/] (level 3)
00:00:00.470301   Path <string>  = "/usr/lib/virtualbox/components/VBoxC" (cb=37)
00:00:00.470302 
00:00:00.470302 [/PDM/NetworkShaper/] (level 2)
00:00:00.470304 
00:00:00.470304 [/PDM/NetworkShaper/BwGroups/] (level 3)
00:00:00.470306 
00:00:00.470307 [/TM/] (level 1)
00:00:00.470308   UTCOffset <integer> = 0x0000000000000000 (0)
00:00:00.470309 
00:00:00.470310 [/USB/] (level 1)
00:00:00.470311 
00:00:00.470312 [/USB/HidMouse/] (level 2)
00:00:00.470313 
00:00:00.470314 [/USB/HidMouse/0/] (level 3)
00:00:00.470315 
00:00:00.470316 [/USB/HidMouse/0/Config/] (level 4)
00:00:00.470318   Mode <string>  = "absolute" (cb=9)
00:00:00.470319 
00:00:00.470319 [/USB/HidMouse/0/LUN#0/] (level 4)
00:00:00.470321   Driver <string>  = "MouseQueue" (cb=11)
00:00:00.470322 
00:00:00.470323 [/USB/HidMouse/0/LUN#0/AttachedDriver/] (level 5)
00:00:00.470325   Driver <string>  = "MainMouse" (cb=10)
00:00:00.470326 
00:00:00.470327 [/USB/HidMouse/0/LUN#0/AttachedDriver/Config/] (level 6)
00:00:00.470329   Object <integer> = 0x00007fdff0029780 (140 599 781 136 256)
00:00:00.470331 
00:00:00.470332 [/USB/HidMouse/0/LUN#0/Config/] (level 5)
00:00:00.470334   QueueSize <integer> = 0x0000000000000080 (128)
00:00:00.470335 
00:00:00.470336 [/USB/USBProxy/] (level 2)
00:00:00.470337 
00:00:00.470338 [/USB/USBProxy/GlobalConfig/] (level 3)
00:00:00.470340 
00:00:00.470340 ********************* End of CFGM dump **********************
00:00:00.470357 VM: fHMEnabled=true  (configured) fRecompileUser=false fRecompileSupervisor=false
00:00:00.470361 VM: fRawRing1Enabled=false CSAM=true  PATM=true 
00:00:00.470515 HMR3Init: VT-x
00:00:00.470576 MM: cbHyperHeap=0x100000 (1048576)
00:00:00.472409 CPUM: Matched host CPU INTEL 0x6/0x17/0x6 Intel_Core2_Penryn with CPU DB entry 'Intel Xeon X5482 3.20GHz' (INTEL 0x6/0x17/0x6 Intel_Core2_Penryn).
00:00:00.472827 Debug: HCPhysInterPD=00000000cb874000 HCPhysInterPaePDPT=00000000cb877000 HCPhysInterPaePML4=00000000cb879000
00:00:00.472846 Debug: apInterPTs={00000000cb875000,00000000cb876000} apInterPaePTs={000000019a344000,000000019974d000} apInterPaePDs={000000031f653000,00000003211f9000,00000002f54d2000,00000002ba8ed000} pInterPaePDPT64=00000000cb878000
00:00:00.472856 Host paging mode: AMD64+PGE+NX
00:00:00.472871 PGMPool: cMaxPages=2096 (u64MaxPages=2084)
00:00:00.472877 pgmR3PoolInit: cMaxPages=0x830 cMaxUsers=0x1060 cMaxPhysExts=0x1060 fCacheEnable=true 
00:00:00.512557 TM: GIP - u32Mode=1 (SyncTSC) u32UpdateHz=83
00:00:00.544650 TM: cTSCTicksPerSecond=0xb18f4665 (2 978 956 901) fTSCVirtualized=true  fTSCUseRealTSC=false
00:00:00.544658 TM: fMaybeUseOffsettedHostTSC=true  TSCTiedToExecution=false TSCNotTiedToHalt=false
00:00:00.545047 CoreCode: R3=00007fe017106000 R0=ffffc90012744000 RC=a0f99000 Phys=0000000036e29000 cb=0x1000
00:00:00.545553 AIOMgr: Default manager type is "Async"
00:00:00.545562 AIOMgr: Default file backend is "NonBuffered"
00:00:00.545705 BlkCache: Cache successfully initialised. Cache size is 5242880 bytes
00:00:00.545712 BlkCache: Cache commit interval is 10000 ms
00:00:00.545716 BlkCache: Cache commit threshold is 2621440 bytes
00:00:00.547981 [SMP] BIOS with 1 CPUs
00:00:00.552970 SUP: Loaded VBoxDDR0.r0 (/usr/lib/virtualbox/VBoxDDR0.r0) at 0xffffffffa0747020 - ModuleInit at 0000000000000000 and ModuleTerm at 0000000000000000
00:00:00.554329 SUP: Loaded VBoxDD2R0.r0 (/usr/lib/virtualbox/VBoxDD2R0.r0) at 0xffffffffa008a020 - ModuleInit at 0000000000000000 and ModuleTerm at 0000000000000000
00:00:00.554350 Activating Local APIC
00:00:00.554359 CPUM: SetGuestCpuIdFeature: Enabled APIC
00:00:00.554705 PIT: mode=3 count=0x10000 (65536) - 18.20 Hz (ch=0)
00:00:00.557451 Shared Folders service loaded.
00:00:00.568563 DrvBlock: Flushes will be ignored
00:00:00.568579 DrvBlock: Async flushes will be passed to the disk
00:00:00.568719 VDInit finished
00:00:00.568892 AIOMgr: Endpoint for file '/home/grishin/VirtualBox VMs/win7-pro-x86-64/win7-pro-x86-64.vdi' (flags 000c0781) created successfully
00:00:00.587084 AIOMgr: Endpoint for file '/home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots/{3b6a7ae0-8ed3-4d1e-ad28-554099773af4}.vdi' (flags 000c0723) created successfully
00:00:00.608527 VD: Opening the disk took 39923655 ns
00:00:00.608577 AHCI: LUN#0: disk, PCHS=16383/16/63, total number of sectors 104857600
00:00:00.608588 AHCI: LUN#0: using async I/O
00:00:00.608701 AHCI#0: Reset the HBA
00:00:00.608850 PIIX3 ATA: LUN#0: no unit
00:00:00.608857 PIIX3 ATA: LUN#1: no unit
00:00:00.608895 DrvBlock: Flushes will be ignored
00:00:00.608900 DrvBlock: Async flushes will be passed to the disk
00:00:00.608997 PIIX3 ATA: LUN#2: CD/DVD, total number of sectors 0, passthrough disabled
00:00:00.609009 PIIX3 ATA: LUN#3: no unit
00:00:00.609040 PIIX3 ATA: Ctl#1: finished processing RESET
00:00:00.609080 PIIX3 ATA: Ctl#0: finished processing RESET
00:00:00.618836 NAT: DNS#0: 192.168.0.1
00:00:00.618879 NAT: DNS#1: 208.67.222.222
00:00:00.619993 VUSB: attached 'HidMouse' to port 1
00:00:00.621421 DevPcBios: SATA LUN#0 LCHS=1024/255/63
00:00:00.621654 PGM: The CPU physical address width is 38 bits
00:00:00.621661 PGMR3InitFinalize: 4 MB PSE mask 0000003fffffffff
00:00:00.626535 VMM: Thread-context hooks enabled!
00:00:00.626568 HM: Using VT-x implementation 2.0!
00:00:00.626569 HM: Host CR4                        = 0x6e0
00:00:00.626571 HM: Host EFER                       = 0xd01
00:00:00.626572 HM: MSR_IA32_FEATURE_CONTROL        = 0xd
00:00:00.626573 HM: MSR_IA32_VMX_BASIC_INFO         = 0x5a08000000000d
00:00:00.626574 HM:   VMCS id                             = 0xd
00:00:00.626575 HM:   VMCS size                           = 2048 bytes
00:00:00.626575 HM:   VMCS physical address limit         = None
00:00:00.626576 HM:   VMCS memory type                    = 0x6
00:00:00.626577 HM:   Dual-monitor treatment support      = true 
00:00:00.626578 HM:   OUTS & INS instruction-info         = true 
00:00:00.626579 HM: Max resume loops                = 8192
00:00:00.626580 HM: MSR_IA32_VMX_PINBASED_CTLS      = 0x3f00000016
00:00:00.626581 HM:   VMX_VMCS_CTRL_PIN_EXEC_EXT_INT_EXIT
00:00:00.626581 HM:   VMX_VMCS_CTRL_PIN_EXEC_NMI_EXIT
00:00:00.626582 HM:   VMX_VMCS_CTRL_PIN_EXEC_VIRTUAL_NMI
00:00:00.626582 HM:   VMX_VMCS_CTRL_PIN_EXEC_PREEMPT_TIMER (must be cleared)
00:00:00.626584 HM: MSR_IA32_VMX_PROCBASED_CTLS     = 0xf7f9fffe0401e172
00:00:00.626585 HM:   VMX_VMCS_CTRL_PROC_EXEC_INT_WINDOW_EXIT
00:00:00.626586 HM:   VMX_VMCS_CTRL_PROC_EXEC_USE_TSC_OFFSETTING
00:00:00.626586 HM:   VMX_VMCS_CTRL_PROC_EXEC_HLT_EXIT
00:00:00.626587 HM:   VMX_VMCS_CTRL_PROC_EXEC_INVLPG_EXIT
00:00:00.626587 HM:   VMX_VMCS_CTRL_PROC_EXEC_MWAIT_EXIT
00:00:00.626588 HM:   VMX_VMCS_CTRL_PROC_EXEC_RDPMC_EXIT
00:00:00.626589 HM:   VMX_VMCS_CTRL_PROC_EXEC_RDTSC_EXIT
00:00:00.626590 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR3_LOAD_EXIT
00:00:00.626591 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR3_LOAD_EXIT (must be set)
00:00:00.626592 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR3_STORE_EXIT
00:00:00.626592 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR3_STORE_EXIT (must be set)
00:00:00.626593 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR8_LOAD_EXIT
00:00:00.626593 HM:   VMX_VMCS_CTRL_PROC_EXEC_CR8_STORE_EXIT
00:00:00.626594 HM:   VMX_VMCS_CTRL_PROC_EXEC_USE_TPR_SHADOW
00:00:00.626594 HM:   VMX_VMCS_CTRL_PROC_EXEC_NMI_WINDOW_EXIT
00:00:00.626596 HM:   VMX_VMCS_CTRL_PROC_EXEC_MOV_DR_EXIT
00:00:00.626596 HM:   VMX_VMCS_CTRL_PROC_EXEC_UNCOND_IO_EXIT
00:00:00.626597 HM:   VMX_VMCS_CTRL_PROC_EXEC_USE_IO_BITMAPS
00:00:00.626597 HM:   VMX_VMCS_CTRL_PROC_EXEC_MONITOR_TRAP_FLAG (must be cleared)
00:00:00.626598 HM:   VMX_VMCS_CTRL_PROC_EXEC_USE_MSR_BITMAPS
00:00:00.626598 HM:   VMX_VMCS_CTRL_PROC_EXEC_MONITOR_EXIT
00:00:00.626599 HM:   VMX_VMCS_CTRL_PROC_EXEC_PAUSE_EXIT
00:00:00.626599 HM:   VMX_VMCS_CTRL_PROC_EXEC_USE_SECONDARY_EXEC_CTRL
00:00:00.626601 HM: MSR_IA32_VMX_PROCBASED_CTLS2    = 0x4100000000
00:00:00.626602 HM:   VMX_VMCS_CTRL_PROC_EXEC2_VIRT_APIC
00:00:00.626602 HM:   VMX_VMCS_CTRL_PROC_EXEC2_EPT (must be cleared)
00:00:00.626603 HM:   VMX_VMCS_CTRL_PROC_EXEC2_DESCRIPTOR_TABLE_EXIT (must be cleared)
00:00:00.626604 HM:   VMX_VMCS_CTRL_PROC_EXEC2_RDTSCP (must be cleared)
00:00:00.626604 HM:   VMX_VMCS_CTRL_PROC_EXEC2_VIRT_X2APIC (must be cleared)
00:00:00.626605 HM:   VMX_VMCS_CTRL_PROC_EXEC2_VPID (must be cleared)
00:00:00.626605 HM:   VMX_VMCS_CTRL_PROC_EXEC2_WBINVD_EXIT
00:00:00.626606 HM:   VMX_VMCS_CTRL_PROC_EXEC2_UNRESTRICTED_GUEST (must be cleared)
00:00:00.626607 HM:   VMX_VMCS_CTRL_PROC_EXEC2_PAUSE_LOOP_EXIT (must be cleared)
00:00:00.626607 HM:   VMX_VMCS_CTRL_PROC_EXEC2_RDRAND_EXIT (must be cleared)
00:00:00.626608 HM:   VMX_VMCS_CTRL_PROC_EXEC2_INVPCID (must be cleared)
00:00:00.626608 HM:   VMX_VMCS_CTRL_PROC_EXEC2_VMFUNC (must be cleared)
00:00:00.626609 HM: MSR_IA32_VMX_ENTRY_CTLS         = 0x3fff000011ff
00:00:00.626609 HM:   VMX_VMCS_CTRL_ENTRY_LOAD_DEBUG
00:00:00.626610 HM:   VMX_VMCS_CTRL_ENTRY_LOAD_DEBUG (must be set)
00:00:00.626611 HM:   VMX_VMCS_CTRL_ENTRY_IA32E_MODE_GUEST
00:00:00.626611 HM:   VMX_VMCS_CTRL_ENTRY_ENTRY_SMM
00:00:00.626613 HM:   VMX_VMCS_CTRL_ENTRY_DEACTIVATE_DUALMON
00:00:00.626613 HM:   VMX_VMCS_CTRL_ENTRY_LOAD_GUEST_PERF_MSR
00:00:00.626614 HM:   VMX_VMCS_CTRL_ENTRY_LOAD_GUEST_PAT_MSR (must be cleared)
00:00:00.626614 HM:   VMX_VMCS_CTRL_ENTRY_LOAD_GUEST_EFER_MSR (must be cleared)
00:00:00.626615 HM: MSR_IA32_VMX_EXIT_CTLS          = 0x3ffff00036dff
00:00:00.626616 HM:   VMX_VMCS_CTRL_EXIT_SAVE_DEBUG
00:00:00.626617 HM:   VMX_VMCS_CTRL_EXIT_SAVE_DEBUG (must be set)
00:00:00.626617 HM:   VMX_VMCS_CTRL_EXIT_HOST_ADDR_SPACE_SIZE
00:00:00.626618 HM:   VMX_VMCS_CTRL_EXIT_LOAD_PERF_MSR
00:00:00.626618 HM:   VMX_VMCS_CTRL_EXIT_ACK_EXT_INT
00:00:00.626619 HM:   VMX_VMCS_CTRL_EXIT_SAVE_GUEST_PAT_MSR (must be cleared)
00:00:00.626620 HM:   VMX_VMCS_CTRL_EXIT_LOAD_HOST_PAT_MSR (must be cleared)
00:00:00.626620 HM:   VMX_VMCS_CTRL_EXIT_SAVE_GUEST_EFER_MSR (must be cleared)
00:00:00.626621 HM:   VMX_VMCS_CTRL_EXIT_LOAD_HOST_EFER_MSR (must be cleared)
00:00:00.626621 HM:   VMX_VMCS_CTRL_EXIT_SAVE_VMX_PREEMPT_TIMER (must be cleared)
00:00:00.626622 HM: MSR_IA32_VMX_MISC               = 0x403c0
00:00:00.626623 HM:   MSR_IA32_VMX_MISC_PREEMPT_TSC_BIT      = 0x0
00:00:00.626624 HM:   MSR_IA32_VMX_MISC_STORE_EFERLMA_VMEXIT = false
00:00:00.626624 HM:   MSR_IA32_VMX_MISC_ACTIVITY_STATES      = 0x7
00:00:00.626625 HM:   MSR_IA32_VMX_MISC_CR3_TARGET           = 0x4
00:00:00.626627 HM:   MSR_IA32_VMX_MISC_MAX_MSR              = 512
00:00:00.626627 HM:   MSR_IA32_VMX_MISC_RDMSR_SMBASE_MSR_SMM = false
00:00:00.626628 HM:   MSR_IA32_VMX_MISC_SMM_MONITOR_CTL_B2   = false
00:00:00.626629 HM:   MSR_IA32_VMX_MISC_VMWRITE_VMEXIT_INFO  = false
00:00:00.626629 HM:   MSR_IA32_VMX_MISC_MSEG_ID              = 0x0
00:00:00.626630 HM: MSR_IA32_VMX_CR0_FIXED0         = 0x80000021
00:00:00.626631 HM: MSR_IA32_VMX_CR0_FIXED1         = 0xffffffff
00:00:00.626632 HM: MSR_IA32_VMX_CR4_FIXED0         = 0x2000
00:00:00.626632 HM: MSR_IA32_VMX_CR4_FIXED1         = 0x27ff
00:00:00.626633 HM: MSR_IA32_VMX_VMCS_ENUM          = 0x2c
00:00:00.626634 HM:   MSR_IA32_VMX_VMCS_ENUM_HIGHEST_INDEX   = 0x16
00:00:00.626634 HM: APIC-access page physaddr       = 0x0000000036e2a000
00:00:00.626635 HM: VCPU  0: MSR bitmap physaddr    = 0x000000003699d000
00:00:00.626636 HM: VCPU  0: VMCS physaddr          = 0x0000000036e2b000
00:00:00.626642 HM: Real Mode TSS guest physaddr    = 0x00000000f0800000
00:00:00.626642 HM: Non-Paging Mode EPT CR3         = 0x00000000f0803000
00:00:00.626643 HM: Guest support: 32-bit and 64-bit.
00:00:00.626647 HM: Supports VMCS EFER fields       = false
00:00:00.626648 HM: VMX enabled!
00:00:00.626657 CPUM: SetGuestCpuIdFeature: Enabled SYSENTER/EXIT
00:00:00.626659 CPUM: SetGuestCpuIdFeature: Enabled PAE
00:00:00.626660 CPUM: SetGuestCpuIdFeature: Enabled LONG MODE
00:00:00.626660 CPUM: SetGuestCpuIdFeature: Enabled SYSCALL/RET
00:00:00.626661 CPUM: SetGuestCpuIdFeature: Enabled LAHF/SAHF
00:00:00.626662 CPUM: SetGuestCpuIdFeature: Enabled NX
00:00:00.626662 HM: VMX-preemption timer disabled.
00:00:00.626663 HM: VT-x/AMD-V init method: GLOBAL
00:00:00.626664 VMM: fUsePeriodicPreemptionTimers=true 
00:00:00.627304 Logical host processors: 8 present, 8 max, 8 online, online mask: 00000000000000ff
00:00:00.627421 Physical host cores: 8
00:00:00.627422 ************************* CPUID dump ************************
00:00:00.627433          RAW Standard CPUIDs
00:00:00.627434      Function  eax      ebx      ecx      edx
00:00:00.627434 Gst: 00000000  00000005 756e6547 6c65746e 49656e69
00:00:00.627436 Hst:           0000000a 756e6547 6c65746e 49656e69
00:00:00.627437 Gst: 00000001  00010676 00000800 00000209 078bfbff
00:00:00.627439 Hst:           00010676 04040800 000ce3bd bfebfbff
00:00:00.627440 Gst: 00000002  05b0b101 005657f0 00000000 2cb4304e
00:00:00.627442 Hst:           05b0b101 005657f0 00000000 2cb4304e
00:00:00.627443 Gst: 00000003  00000000 00000000 00000000 00000000
00:00:00.627444 Hst:           00000000 00000000 00000000 00000000
00:00:00.627445 Gst: 00000004  00000000 00000000 00000000 00000000
00:00:00.627446 Hst:           0c000121 01c0003f 0000003f 00000001
00:00:00.627447 Gst: 00000005  00000040 00000040 00000000 00000000
00:00:00.627448 Hst:           00000040 00000040 00000003 00002220
00:00:00.627449 Hst: 00000006  00000001 00000002 00000001 00000000
00:00:00.627450 Hst: 00000007  00000000 00000000 00000000 00000000
00:00:00.627451 Hst: 00000008  00000400 00000000 00000000 00000000
00:00:00.627452 Hst: 00000009  00000000 00000000 00000000 00000000
00:00:00.627453 Hst: 0000000a  07280202 00000000 00000000 00000503
00:00:00.627455 Name:                            GenuineIntel
00:00:00.627455 Supports:                        0-5
00:00:00.627457 Family:                          6  	Extended: 0 	Effective: 6
00:00:00.627458 Model:                           7  	Extended: 1 	Effective: 23
00:00:00.627459 Stepping:                        6
00:00:00.627460 Type:                            0 (primary)
00:00:00.627460 APIC ID:                         0x00
00:00:00.627461 Logical CPUs:                    0
00:00:00.627461 CLFLUSH Size:                    8
00:00:00.627462 Brand ID:                        0x00
00:00:00.627464 Mnemonic - Description                 = guest (host)
00:00:00.627464 FPU - x87 FPU on Chip                  = 1 (1)
00:00:00.627465 VME - Virtual 8086 Mode Enhancements   = 1 (1)
00:00:00.627466 DE - Debugging extensions              = 1 (1)
00:00:00.627466 PSE - Page Size Extension              = 1 (1)
00:00:00.627467 TSC - Time Stamp Counter               = 1 (1)
00:00:00.627468 MSR - Model Specific Registers         = 1 (1)
00:00:00.627468 PAE - Physical Address Extension       = 1 (1)
00:00:00.627469 MCE - Machine Check Exception          = 1 (1)
00:00:00.627470 CX8 - CMPXCHG8B instruction            = 1 (1)
00:00:00.627470 APIC - APIC On-Chip                    = 1 (1)
00:00:00.627471 10 - Reserved                          = 0 (0)
00:00:00.627472 SEP - SYSENTER and SYSEXIT             = 1 (1)
00:00:00.627472 MTRR - Memory Type Range Registers     = 1 (1)
00:00:00.627473 PGE - PTE Global Bit                   = 1 (1)
00:00:00.627473 MCA - Machine Check Architecture       = 1 (1)
00:00:00.627474 CMOV - Conditional Move Instructions   = 1 (1)
00:00:00.627475 PAT - Page Attribute Table             = 1 (1)
00:00:00.627475 PSE-36 - 36-bit Page Size Extention    = 1 (1)
00:00:00.627476 PSN - Processor Serial Number          = 0 (0)
00:00:00.627477 CLFSH - CLFLUSH Instruction.           = 1 (1)
00:00:00.627477 20 - Reserved                          = 0 (0)
00:00:00.627478 DS - Debug Store                       = 0 (1)
00:00:00.627479 ACPI - Thermal Mon. & Soft. Clock Ctrl.= 0 (1)
00:00:00.627479 MMX - Intel MMX Technology             = 1 (1)
00:00:00.627480 FXSR - FXSAVE and FXRSTOR Instructions = 1 (1)
00:00:00.627482 SSE - SSE Support                      = 1 (1)
00:00:00.627482 SSE2 - SSE2 Support                    = 1 (1)
00:00:00.627483 SS - Self Snoop                        = 0 (1)
00:00:00.627483 HTT - Hyper-Threading Technology       = 0 (1)
00:00:00.627484 TM - Thermal Monitor                   = 0 (1)
00:00:00.627485 30 - Reserved                          = 0 (0)
00:00:00.627485 PBE - Pending Break Enable             = 0 (1)
00:00:00.627486 Supports SSE3                          = 1 (1)
00:00:00.627487 PCLMULQDQ                              = 0 (0)
00:00:00.627487 DS Area 64-bit layout                  = 0 (1)
00:00:00.627488 Supports MONITOR/MWAIT                 = 1 (1)
00:00:00.627489 CPL-DS - CPL Qualified Debug Store     = 0 (1)
00:00:00.627489 VMX - Virtual Machine Technology       = 0 (1)
00:00:00.627490 SMX - Safer Mode Extensions            = 0 (0)
00:00:00.627490 Enhanced SpeedStep Technology          = 0 (1)
00:00:00.627491 Terminal Monitor 2                     = 0 (1)
00:00:00.627492 Supplemental SSE3 instructions         = 1 (1)
00:00:00.627492 L1 Context ID                          = 0 (0)
00:00:00.627493 11 - Reserved                          = 0 (0)
00:00:00.627494 FMA extensions using YMM state         = 0 (0)
00:00:00.627494 CMPXCHG16B instruction                 = 0 (1)
00:00:00.627495 xTPR Update Control                    = 0 (1)
00:00:00.627495 Perf/Debug Capability MSR              = 0 (1)
00:00:00.627496 16 - Reserved                          = 0 (0)
00:00:00.627497 PCID - Process-context identifiers     = 0 (0)
00:00:00.627497 DCA - Direct Cache Access              = 0 (1)
00:00:00.627498 SSE4.1 instruction extensions          = 0 (1)
00:00:00.627499 SSE4.2 instruction extensions          = 0 (0)
00:00:00.627499 Supports the x2APIC extensions         = 0 (0)
00:00:00.627500 MOVBE instruction                      = 0 (0)
00:00:00.627500 POPCNT instruction                     = 0 (0)
00:00:00.627501 TSC-Deadline LAPIC timer mode          = 0 (0)
00:00:00.627502 AESNI instruction extensions           = 0 (0)
00:00:00.627502 XSAVE/XRSTOR extended state feature    = 0 (0)
00:00:00.627503 Supports OSXSAVE                       = 0 (0)
00:00:00.627504 AVX instruction extensions             = 0 (0)
00:00:00.627504 29/30 - Reserved                       = 0x0 (0x0)
00:00:00.627505 Hypervisor Present (we're a guest)     = 0 (0)
00:00:00.627506 
00:00:00.627506          RAW Extended CPUIDs
00:00:00.627506      Function  eax      ebx      ecx      edx
00:00:00.627507 Gst: 80000000  80000008 00000000 00000000 00000000
00:00:00.627508 Hst:           80000008 00000000 00000000 00000000
00:00:00.627510 Gst: 80000001  00000000 00000000 00000001 20100800
00:00:00.627511 Hst:           00000000 00000000 00000001 20100800
00:00:00.627512 Gst: 80000002  65746e49 2952286c 6f655820 2952286e
00:00:00.627514 Hst:           65746e49 2952286c 6f655820 2952286e
00:00:00.627515 Gst: 80000003  55504320 20202020 20202020 58202020
00:00:00.627517 Hst:           55504320 20202020 20202020 58202020
00:00:00.627518 Gst: 80000004  32373435 20402020 30302e33 007a4847
00:00:00.627520 Hst:           32373435 20402020 30302e33 007a4847
00:00:00.627521 Gst: 80000005  00000000 00000000 00000000 00000000
00:00:00.627522 Hst:           00000000 00000000 00000000 00000000
00:00:00.627523 Gst: 80000006  00000000 00000000 18008040 00000000
00:00:00.627524 Hst:           00000000 00000000 18008040 00000000
00:00:00.627525 Gst: 80000007  00000000 00000000 00000000 00000000
00:00:00.627526 Hst:           00000000 00000000 00000000 00000000
00:00:00.627527 Gst: 80000008  00003026 00000000 00000000 00000000
00:00:00.627528 Hst:           00003026 00000000 00000000 00000000
00:00:00.627529 Gst: 80000009  07280202 00000000 00000000 00000503*
00:00:00.627531 Hst:           07280202 00000000 00000000 00000503
00:00:00.627532 Ext Name:                        
00:00:00.627532 Ext Supports:                    0x80000000-0x80000008
00:00:00.627533 Family:                          0  	Extended: 0 	Effective: 0
00:00:00.627534 Model:                           0  	Extended: 0 	Effective: 0
00:00:00.627535 Stepping:                        0
00:00:00.627535 Brand ID:                        0x000
00:00:00.627536 Mnemonic - Description                 = guest (host)
00:00:00.627537 FPU - x87 FPU on Chip                  = 0 (0)
00:00:00.627537 VME - Virtual 8086 Mode Enhancements   = 0 (0)
00:00:00.627538 DE - Debugging extensions              = 0 (0)
00:00:00.627539 PSE - Page Size Extension              = 0 (0)
00:00:00.627539 TSC - Time Stamp Counter               = 0 (0)
00:00:00.627540 MSR - K86 Model Specific Registers     = 0 (0)
00:00:00.627541 PAE - Physical Address Extension       = 0 (0)
00:00:00.627541 MCE - Machine Check Exception          = 0 (0)
00:00:00.627542 CX8 - CMPXCHG8B instruction            = 0 (0)
00:00:00.627542 APIC - APIC On-Chip                    = 0 (0)
00:00:00.627543 10 - Reserved                          = 0 (0)
00:00:00.627544 SEP - SYSCALL and SYSRET               = 1 (1)
00:00:00.627545 MTRR - Memory Type Range Registers     = 0 (0)
00:00:00.627546 PGE - PTE Global Bit                   = 0 (0)
00:00:00.627547 MCA - Machine Check Architecture       = 0 (0)
00:00:00.627547 CMOV - Conditional Move Instructions   = 0 (0)
00:00:00.627548 PAT - Page Attribute Table             = 0 (0)
00:00:00.627548 PSE-36 - 36-bit Page Size Extention    = 0 (0)
00:00:00.627549 18 - Reserved                          = 0 (0)
00:00:00.627550 19 - Reserved                          = 0 (0)
00:00:00.627550 NX - No-Execute Page Protection        = 1 (1)
00:00:00.627551 DS - Debug Store                       = 0 (0)
00:00:00.627552 AXMMX - AMD Extensions to MMX Instr.   = 0 (0)
00:00:00.627552 MMX - Intel MMX Technology             = 0 (0)
00:00:00.627553 FXSR - FXSAVE and FXRSTOR Instructions = 0 (0)
00:00:00.627553 25 - AMD fast FXSAVE and FXRSTOR Instr.= 0 (0)
00:00:00.627554 26 - 1 GB large page support           = 0 (0)
00:00:00.627555 27 - RDTSCP instruction                = 0 (0)
00:00:00.627555 28 - Reserved                          = 0 (0)
00:00:00.627556 29 - AMD Long Mode                     = 1 (1)
00:00:00.627557 30 - AMD Extensions to 3DNow!          = 0 (0)
00:00:00.627557 31 - AMD 3DNow!                        = 0 (0)
00:00:00.627558 LahfSahf - LAHF/SAHF in 64-bit mode    = 1 (1)
00:00:00.627559 CmpLegacy - Core MP legacy mode (depr) = 0 (0)
00:00:00.627559 SVM - AMD VM Extensions                = 0 (0)
00:00:00.627560 APIC registers starting at 0x400       = 0 (0)
00:00:00.627561 AltMovCR8 - LOCK MOV CR0 means MOV CR8 = 0 (0)
00:00:00.627561 5  - Advanced bit manipulation         = 0 (0)
00:00:00.627562 6  - SSE4A instruction support         = 0 (0)
00:00:00.627562 7  - Misaligned SSE mode               = 0 (0)
00:00:00.627563 8  - PREFETCH and PREFETCHW instruction= 0 (0)
00:00:00.627564 9  - OS visible workaround             = 0 (0)
00:00:00.627564 10 - Instruction based sampling        = 0 (0)
00:00:00.627565 11 - SSE5 support                      = 0 (0)
00:00:00.627566 12 - SKINIT, STGI, and DEV support     = 0 (0)
00:00:00.627566 13 - Watchdog timer support.           = 0 (0)
00:00:00.627567 31:14 - Reserved                       = 0x0 (0x0)
00:00:00.627568 Full Name:                       Intel(R) Xeon(R) CPU           X5472  @ 3.00GHz
00:00:00.627569 TLB 2/4M Instr/Uni:              res0     0 entries
00:00:00.627570 TLB 2/4M Data:                   res0     0 entries
00:00:00.627570 TLB 4K Instr/Uni:                res0     0 entries
00:00:00.627571 TLB 4K Data:                     res0     0 entries
00:00:00.627572 L1 Instr Cache Line Size:        0 bytes
00:00:00.627572 L1 Instr Cache Lines Per Tag:    0
00:00:00.627573 L1 Instr Cache Associativity:    res0  
00:00:00.627573 L1 Instr Cache Size:             0 KB
00:00:00.627574 L1 Data Cache Line Size:         0 bytes
00:00:00.627574 L1 Data Cache Lines Per Tag:     0
00:00:00.627575 L1 Data Cache Associativity:     res0  
00:00:00.627575 L1 Data Cache Size:              0 KB
00:00:00.627576 L2 TLB 2/4M Instr/Uni:           off       0 entries
00:00:00.627577 L2 TLB 2/4M Data:                off       0 entries
00:00:00.627577 L2 TLB 4K Instr/Uni:             off       0 entries
00:00:00.627578 L2 TLB 4K Data:                  off       0 entries
00:00:00.627579 L2 Cache Line Size:              0 bytes
00:00:00.627579 L2 Cache Lines Per Tag:          0
00:00:00.627580 L2 Cache Associativity:          off   
00:00:00.627580 L2 Cache Size:                   0 KB
00:00:00.627581 Host Invariant-TSC support:      false
00:00:00.627582 APM Features:                   
00:00:00.627582 Physical Address Width:          38 bits
00:00:00.627583 Virtual Address Width:           48 bits
00:00:00.627583 Guest Physical Address Width:    0 bits
00:00:00.627584 Physical Core Count:             0
00:00:00.627584 
00:00:00.627585          RAW Centaur CPUIDs
00:00:00.627585      Function  eax      ebx      ecx      edx
00:00:00.627586 Gst: c0000000  07280202 00000000 00000000 00000503
00:00:00.627587 Hst:           07280202 00000000 00000000 00000503
00:00:00.627588 Gst: c0000001  07280202 00000000 00000000 00000503
00:00:00.627590 Hst:           07280202 00000000 00000000 00000503
00:00:00.627591 Gst: c0000002  07280202 00000000 00000000 00000503
00:00:00.627592 Hst:           07280202 00000000 00000000 00000503
00:00:00.627593 Gst: c0000003  07280202 00000000 00000000 00000503
00:00:00.627594 Hst:           07280202 00000000 00000000 00000503
00:00:00.627595 Centaur Supports:                0xc0000000-0x07280202
00:00:00.627596 Mnemonic - Description                 = guest (host)
00:00:00.627597 AIS - Alternate Instruction Set        = 1 (1)
00:00:00.627598 AIS-E - AIS enabled                    = 1 (1)
00:00:00.627598 RNG - Random Number Generator          = 0 (0)
00:00:00.627599 RNG-E - RNG enabled                    = 0 (0)
00:00:00.627600 LH - LongHaul MSR 0000_110Ah           = 0 (0)
00:00:00.627600 FEMMS - FEMMS                          = 0 (0)
00:00:00.627601 ACE - Advanced Cryptography Engine     = 0 (0)
00:00:00.627601 ACE-E - ACE enabled                    = 0 (0)
00:00:00.627602 ACE2 - Advanced Cryptography Engine 2  = 1 (1)
00:00:00.627603 ACE2-E - ACE enabled                   = 0 (0)
00:00:00.627603 PHE - Padlock Hash Engine              = 1 (1)
00:00:00.627604 PHE-E - PHE enabled                    = 0 (0)
00:00:00.627605 PMM - Montgomery Multiplier            = 0 (0)
00:00:00.627605 PMM-E - PMM enabled                    = 0 (0)
00:00:00.627606 14 - Reserved                          = 0 (0)
00:00:00.627606 15 - Reserved                          = 0 (0)
00:00:00.627607 Parallax                               = 0 (0)
00:00:00.627608 Parallax enabled                       = 0 (0)
00:00:00.627608 Overstress                             = 0 (0)
00:00:00.627609 Overstress enabled                     = 0 (0)
00:00:00.627610 TM3 - Temperature Monitoring 3         = 0 (0)
00:00:00.627610 TM3-E - TM3 enabled                    = 0 (0)
00:00:00.627611 RNG2 - Random Number Generator 2       = 0 (0)
00:00:00.627611 RNG2-E - RNG2 enabled                  = 0 (0)
00:00:00.627612 24 - Reserved                          = 0 (0)
00:00:00.627613 PHE2 - Padlock Hash Engine 2           = 0 (0)
00:00:00.627613 PHE2-E - PHE2 enabled                  = 0 (0)
00:00:00.627614 
00:00:00.627614 
00:00:00.627615 ******************** End of CPUID dump **********************
00:00:00.631727 VM: Halt method global1 (5)
00:00:00.631742 HaltedGlobal1 config: cNsSpinBlockThresholdCfg=2000
00:00:00.631751 Changing the VM state from 'CREATING' to 'CREATED'.
00:00:00.632191 Changing the VM state from 'CREATED' to 'POWERING_ON'.
00:00:00.632209 AIOMgr: Endpoints without assigned bandwidth groups:
00:00:00.632214 AIOMgr:     /home/grishin/VirtualBox VMs/win7-pro-x86-64/Snapshots/{3b6a7ae0-8ed3-4d1e-ad28-554099773af4}.vdi
00:00:00.632218 AIOMgr:     /home/grishin/VirtualBox VMs/win7-pro-x86-64/win7-pro-x86-64.vdi
00:00:00.632389 Changing the VM state from 'POWERING_ON' to 'RUNNING'.
00:00:00.640599 Guest Log: BIOS: VirtualBox 4.3.20
00:00:00.640825 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
00:00:00.650687 ERROR [COM]: aRC=VBOX_E_IPRT_ERROR (0x80bb0005) aIID={480b372c-c0b5-4c23-9bd7-dcbb85b1594c} aComponent={Display} aText={Could not take a screenshot (VERR_NOT_SUPPORTED)}, preserve=false
00:00:00.655015 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=0000000000000000 w=720 h=400 bpp=0 cbLine=0x0, flags=0x1
00:00:00.655029 UIFrameBuffer::RequestResize: Screen=0, Format=0, BitsPerPixel=0, BytesPerLine=0, Size=720x400, Sending to async-handler..
00:00:00.655065 UIFrameBufferQImage::resizeEvent: Format=0, BitsPerPixel=0, BytesPerLine=0, Size=720x400
00:00:00.655078 UIFrameBufferQImage::resizeEvent: Resizing to FALLBACK buffer due to format is invalid..
00:00:00.655866 PIIX3 ATA: Ctl#1: RESET, DevSel=0 AIOIf=0 CmdIf0=0x00 (-1 usec ago) CmdIf1=0x00 (-1 usec ago)
00:00:00.655906 PIIX3 ATA: Ctl#1: finished processing RESET
00:00:00.669298 AHCI#0: Reset the HBA
00:00:00.669385 AHCI#0: Port 0 reset
00:00:00.670107 Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 104857600 sectors
00:00:00.670161 PIT: mode=2 count=0x48d3 (18643) - 64.00 Hz (ch=0)
00:00:00.674938 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007fdfee000000 w=640 h=480 bpp=32 cbLine=0xA00, flags=0x1
00:00:00.674958 UIFrameBuffer::RequestResize: Screen=0, Format=843204434, BitsPerPixel=32, BytesPerLine=2560, Size=640x480, Sending to async-handler..
00:00:00.676623 UIFrameBufferQImage::resizeEvent: Format=843204434, BitsPerPixel=32, BytesPerLine=2560, Size=640x480
00:00:00.676665 UIFrameBufferQImage::resizeEvent: Resizing to directly use VGA device content..
00:00:00.778560 2D video acceleration is disabled.
00:00:00.778594 HID LEDs sync is not supported on this platform.
00:00:03.144940 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=0000000000000000 w=720 h=400 bpp=0 cbLine=0x0, flags=0x1
00:00:03.144982 UIFrameBuffer::RequestResize: Screen=0, Format=0, BitsPerPixel=0, BytesPerLine=0, Size=720x400, Sending to async-handler..
00:00:03.145039 UIFrameBufferQImage::resizeEvent: Format=0, BitsPerPixel=0, BytesPerLine=0, Size=720x400
00:00:03.145078 UIFrameBufferQImage::resizeEvent: Resizing to FALLBACK buffer due to format is invalid..
00:00:03.150350 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
00:00:03.150706 Guest Log: BIOS: Boot : bseqnr=1, bootseq=0002
00:00:03.155676 Guest Log: BIOS: Booting from Hard Disk...
00:00:03.574958 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007fdfee000000 w=1024 h=768 bpp=24 cbLine=0xC00, flags=0x1
00:00:03.575027 UIFrameBuffer::RequestResize: Screen=0, Format=843204434, BitsPerPixel=24, BytesPerLine=3072, Size=1024x768, Sending to async-handler..
00:00:03.575085 UIFrameBufferQImage::resizeEvent: Format=843204434, BitsPerPixel=24, BytesPerLine=3072, Size=1024x768
00:00:03.575123 UIFrameBufferQImage::resizeEvent: Resizing to FALLBACK buffer due to format is invalid..
00:00:10.917234 RTC: period=0x200 (512) 64 Hz
00:00:14.017352 AHCI#0: Reset the HBA
00:00:14.110722 Guest Additions information report: Version 4.3.20 r96996 '4.3.20'
00:00:14.110803 Guest Additions information report: Interface = 0x00010004 osType = 0x00037100 (64-bit)
00:00:14.110887 Guest Additions capability report: (0x0 -> 0x0) seamless: no, hostWindowMapping: no, graphics: no
00:00:14.111167 Guest reported fixed hypervisor window at 00008000000 (size = 0x2400000, rc = VINF_SUCCESS)
00:00:16.317592 AIOMgr: Flush failed with VERR_INVALID_PARAMETER, disabling async flushes
00:00:17.407691 Guest Log: VBoxMP::VBoxDrvFindAdapter: using HGSMI
00:00:17.524491 OHCI: Software reset
00:00:17.525573 OHCI: USB Reset
00:00:17.603308 OHCI: USB Operational
00:00:17.653597 IEM: rdmsr(0x40000081) -> GP(0)
00:00:22.505985 NAT: link up
00:00:23.055126 NAT: IPv6 not supported
00:00:27.718781 Guest Log: VBoxDisp[0]: VBVA enabled
00:00:27.718825 VBVA_INFO_SCREEN: [0] @0,0 1280x936, line 0x1400, BPP 32, flags 0x1
00:00:27.719050 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007fdfee000000 w=1280 h=936 bpp=32 cbLine=0x1400, flags=0x1
00:00:27.719058 UIFrameBuffer::RequestResize: Screen=0, Format=843204434, BitsPerPixel=32, BytesPerLine=5120, Size=1280x936, Sending to async-handler..
00:00:27.719112 UIFrameBufferQImage::resizeEvent: Format=843204434, BitsPerPixel=32, BytesPerLine=5120, Size=1280x936
00:00:27.719148 UIFrameBufferQImage::resizeEvent: Resizing to directly use VGA device content..
00:00:27.725081 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007fdfee000000 w=1280 h=936 bpp=32 cbLine=0x1400, flags=0x1
00:00:27.725099 UIFrameBuffer::RequestResize: Screen=0, Format=843204434, BitsPerPixel=32, BytesPerLine=5120, Size=1280x936, Sending to async-handler..
00:00:27.725335 UIFrameBufferQImage::resizeEvent: Format=843204434, BitsPerPixel=32, BytesPerLine=5120, Size=1280x936
00:00:27.725398 UIFrameBufferQImage::resizeEvent: Resizing to directly use VGA device content..
00:00:32.941409 NAT: DNS#0: 192.168.0.1
00:00:32.941446 NAT: DNS#1: 208.67.222.222
00:00:32.941454 NAT: DHCP offered IP address 10.0.2.15
00:00:46.779523 Starting host clipboard service
00:00:46.779565 Initializing X11 clipboard backend
00:00:46.782044 Shared clipboard: starting shared clipboard thread
00:00:47.244545 Guest Additions capability report: (0x0 -> 0x1) seamless: yes, hostWindowMapping: no, graphics: no
00:00:47.244642 Guest Additions capability report: (0x1 -> 0x5) seamless: yes, hostWindowMapping: no, graphics: yes
00:00:56.206363 NAT: DHCP offered IP address 10.0.2.15
00:06:33.905310 RTC: period=0x20 (32) 1024 Hz
00:06:33.913980 RTC: period=0x200 (512) 64 Hz
00:08:35.282319 NAT: DNS#0: 192.168.0.1
00:08:35.282363 NAT: DNS#1: 208.67.222.222
00:08:35.282370 NAT: DHCP offered IP address 10.0.2.15
00:08:49.352593 Guest Additions capability report: (0x5 -> 0x0) seamless: no, hostWindowMapping: no, graphics: no
00:08:50.513979 Guest Additions capability report: (0x0 -> 0x1) seamless: yes, hostWindowMapping: no, graphics: no
00:08:50.514102 Guest Additions capability report: (0x1 -> 0x5) seamless: yes, hostWindowMapping: no, graphics: yes
00:09:19.277317 RTC: period=0x20 (32) 1024 Hz
00:09:19.288987 RTC: period=0x200 (512) 64 Hz
01:38:21.887966 RTC: period=0x20 (32) 1024 Hz
01:38:21.904881 RTC: period=0x200 (512) 64 Hz
VirtualBox version is
4.3.20 r96996

Any ideas how to debug this?
Last edited by ygrishin on 8. Jan 2015, 16:15, edited 1 time in total.
ygrishin
Posts: 5
Joined: 3. Jan 2015, 21:23
Primary OS: Debian Wheezy
VBox Version: OSE Debian
Guest OSses: Windows 7

Re: Windows 7 x86-64 gets aborted on Debian.

Post by ygrishin »

Ok, so. I was able to toggle debug logging

Code: Select all

export VBOX_RELEASE_LOG="rem*.e.l.f.s.b main gui"
export VBOX_RELEASE_LOG_FLAGS="buffered thread msprog"
export VBOX_RELEASE_LOG_DEST="file=/home/username/temp/vbox-release.log"

export VBOXSVC_RELEASE_LOG="rem*.e.l.f.s.b main gui"
export VBOXSVC_RELEASE_LOG_FLAGS="buffered thread msprog"
export VBOXSVC_RELEASE_LOG_DEST="file=/home/username/temp/vboxsvc-release.log"
and now have last 32 lines of vbox-release.log

Code: Select all

001638619 00:27:18.619739 EMT-0    /TM/CPU/03/cNsOther              94954653506 ns
001638619 00:27:18.619741 EMT-0    /TM/CPU/03/cNsTotal              1637908831784 ns
001638619 00:27:18.619743 EMT-0    /TM/CPU/03/cPeriodsExecuting      4082295 count
001638619 00:27:18.619745 EMT-0    /TM/CPU/03/cPeriodsHalted          169994 count
001638619 00:27:18.619746 EMT-0    /TM/CPU/03/pctExecuting                 1 %
001638619 00:27:18.619748 EMT-0    /TM/CPU/03/pctHalted                   92 %
001638619 00:27:18.619749 EMT-0    /TM/CPU/03/pctOther                     6 %
001638619 00:27:18.619751 EMT-0    /TM/CPU/pctExecuting                    1 %
001638619 00:27:18.619753 EMT-0    /TM/CPU/pctHalted                      91 %
001638619 00:27:18.619754 EMT-0    /TM/CPU/pctOther                        6 %
001638619 00:27:18.619756 EMT-0    /TM/MaxHzHint                          64 Hz
001638619 00:27:18.619758 EMT-0    /TM/R0/1nsSteps                      3664 times
001638619 00:27:18.619760 EMT-0    /TM/R3/1nsSteps                      3872 times
001638619 00:27:18.619762 EMT-0    /TM/TSC/offCPU0                  116532417802 ticks
001638619 00:27:18.619765 EMT-0    /TM/TSC/offCPU1                  116532417841 ticks
001638619 00:27:18.619767 EMT-0    /TM/TSC/offCPU2                  116532419450 ticks
001638619 00:27:18.619769 EMT-0    /TM/TSC/offCPU3                  116532418051 ticks
001638619 00:27:18.619771 EMT-0    /TM/VirtualSync/CurrentOffset      161876 ns
001638619 00:27:18.619773 EMT-0    /VUSB/0/cUrbsInPool                     1 count
001638619 00:27:18.619776 EMT-0    ********************* End of statistics **********************
001638620 00:27:18.619887 EMT-0    VUSB: detached 'HidMouse' from port 1
001638625 00:27:18.625355 EMT-0    NAT: zone(nm:mbuf_cluster, used:0)
001638625 00:27:18.625784 EMT-0    NAT: zone(nm:mbuf_packet, used:0)
001638625 00:27:18.625786 EMT-0    NAT: zone(nm:mbuf, used:1)
001638625 00:27:18.625792 EMT-0    NAT: zone(nm:mbuf_jumbo_pagesize, used:0)
001638626 00:27:18.626227 EMT-0    NAT: zone(nm:mbuf_jumbo_9k, used:0)
001638626 00:27:18.626431 EMT-0    NAT: zone(nm:mbuf_jumbo_16k, used:0)
001638626 00:27:18.626541 EMT-0    NAT: zone(nm:mbuf_ext_refcnt, used:0)
001638643 00:27:18.643847 EMT-0    Changing the VM state from 'DESTROYING' to 'TERMINATED'.
001638798 00:27:18.798396 main     UIMachineView::storeGuestSizeHint: Storing guest size-hint for screen 0 as 1280x936
001639173 00:27:19.173003 TimerLR  ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={8ab7c520-2442-4b66-8d74-4ff1e195d2b6} aComponent={Console} aText={The object is not ready}, preserve=false

and vboxsvc-release.log:

Code: Select all

VirtualBox XPCOM Server 4.3.20 r96996 linux.amd64 (Nov 21 2014 15:55:22) release log
000000007 00:00:00.007140 main     Log opened 2015-01-05T02:33:40.598223000Z
000000007 00:00:00.007142 main     Build Type: release
000000007 00:00:00.007148 main     OS Product: Linux
000000007 00:00:00.007149 main     OS Release: 3.2.0-4-amd64
000000007 00:00:00.007150 main     OS Version: #1 SMP Debian 3.2.63-2+deb7u2
000000007 00:00:00.007184 main     DMI Product Name: Precision WorkStation T7400  
000000007 00:00:00.007196 main     DMI Product Version: 
000000008 00:00:00.007286 main     Host RAM: 12043MB total, 11674MB available
000000008 00:00:00.007292 main     Executable: /usr/lib/virtualbox/VBoxSVC
000000008 00:00:00.007293 main     Process ID: 4235
000000008 00:00:00.007294 main     Package type: LINUX_64BITS_DEBIAN_7_0
000000117 00:00:00.116817 nspr-2   Loading settings file "/home/username/.config/VirtualBox/VirtualBox.xml" with version "1.12-linux"
000000193 00:00:00.192367 nspr-2   Failed to initialise host USB using USBFS
000000204 00:00:00.203924 nspr-2   HostDnsMonitorProxy: Host's DNS information updated:
000000204 00:00:00.203927 nspr-2   DNS server 1: 192.168.0.1
000000204 00:00:00.203929 nspr-2   DNS server 2: 208.67.222.222
000000212 00:00:00.212120 nspr-2   VDInit finished
000000256 00:00:00.255955 nspr-2   Loading settings file "/home/username/VirtualBox VMs/vm2/vm2.vbox" with version "1.14-linux"
000000267 00:00:00.266805 nspr-2   Loading settings file "/home/username/VirtualBox VMs/vm1/vm1.vbox" with version "1.14-linux"
000000294 00:00:00.294190 nspr-2   Loading settings file "/home/username/VirtualBox VMs/vm3/vm3.vbox" with version "1.14-linux"
000000300 00:00:00.299552 nspr-2   Loading settings file "/home/username/VirtualBox VMs/Win7/Win7.vbox" with version "1.14-linux"
000000577 00:00:00.576865 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000000785 00:00:00.784272 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000000786 00:00:00.785532 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004356 00:00:04.356183 nspr-5   ERROR [COM]: aRC=VBOX_E_INVALID_VM_STATE (0x80bb0002) aIID={480cf695-2d8d-4256-9c7c-cce4184fa048} aComponent={Machine} aText={Machine is not locked for session (session state: Unlocked)}, preserve=false
000004398 00:00:04.397862 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004399 00:00:04.398826 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004620 00:00:04.619689 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004621 00:00:04.620837 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004622 00:00:04.621487 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004630 00:00:04.629949 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004632 00:00:04.631354 nspr-2   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={3295e6ce-b051-47b2-9514-2c588bfe7554} aComponent={ExtPackManager} aText={No extension pack by the name 'Oracle VM VirtualBox Extension Pack' was found}, preserve=false
000004639 00:00:04.638287 nspr-5   ERROR [COM]: aRC=VBOX_E_IPRT_ERROR (0x80bb0005) aIID={480cf695-2d8d-4256-9c7c-cce4184fa048} aComponent={SessionMachine} aText={Saved screenshot data is not available (VERR_NOT_SUPPORTED)}, preserve=false
000004643 00:00:04.642720 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004661 00:00:04.660830 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004943 00:00:04.943248 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004963 00:00:04.962480 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000004964 00:00:04.963528 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000005284 00:00:05.283302 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
000005285 00:00:05.284308 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002403277 00:40:03.276593 Watcher  Reaper: Pid 4262 (10a6) was signalled: 6 (0x6)
002403423 00:40:03.422522 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002403424 00:40:03.423927 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002417025 00:40:17.024868 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002417257 00:40:17.256917 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002417259 00:40:17.258268 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418149 00:40:18.148837 nspr-4   ERROR [COM]: aRC=VBOX_E_INVALID_VM_STATE (0x80bb0002) aIID={480cf695-2d8d-4256-9c7c-cce4184fa048} aComponent={Machine} aText={Machine is not locked for session (session state: Unlocked)}, preserve=false
002418185 00:40:18.185191 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418187 00:40:18.186544 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418403 00:40:18.402940 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418409 00:40:18.408557 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418410 00:40:18.409735 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418413 00:40:18.412363 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418414 00:40:18.413680 nspr-2   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={3295e6ce-b051-47b2-9514-2c588bfe7554} aComponent={ExtPackManager} aText={No extension pack by the name 'Oracle VM VirtualBox Extension Pack' was found}, preserve=false
002418421 00:40:18.420355 nspr-4   ERROR [COM]: aRC=VBOX_E_IPRT_ERROR (0x80bb0005) aIID={480cf695-2d8d-4256-9c7c-cce4184fa048} aComponent={SessionMachine} aText={Saved screenshot data is not available (VERR_NOT_SUPPORTED)}, preserve=false
002418422 00:40:18.422094 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418438 00:40:18.438211 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418673 00:40:18.672584 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418780 00:40:18.779848 nspr-5   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418781 00:40:18.780990 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418940 00:40:18.939623 nspr-2   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
002418941 00:40:18.940735 nspr-4   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
004057008 01:07:37.007426 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
004057009 01:07:37.008610 nspr-3   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
004057703 01:07:37.702300 nspr-6   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
004057704 01:07:37.703459 nspr-6   WARNING [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={93269330-48ca-4096-b4a2-1189df336267} aComponent={Host} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND). The service might not be installed on the host computer}, preserve=true 
005369332 01:29:29.331442 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/vm2/vm2.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369332 01:29:29.331621 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/vm1/Snapshots/{95d933fe-b62a-4412-8770-6d25d76c61d9}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369332 01:29:29.331639 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/vm1/vm1.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369332 01:29:29.331854 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/vm3/vm3.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369332 01:29:29.331977 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/Win7/Snapshots/{3b6a7ae0-8ed3-4d1e-ad28-554099773af4}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369332 01:29:29.331992 main     ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={05f2bbb6-a3a6-4fb9-9b49-6d0dda7142ac} aComponent={Medium} aText={Medium '/home/username/VirtualBox VMs/Win7/Win7.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false
005369333 01:29:29.332857 Watcher  ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={fafa4e17-1ee2-4905-a10e-fe7c18bf5554} aComponent={VirtualBox} aText={The object is not ready}, preserve=false
somewhat around the system being aborted. Any ideas?
mpack
Site Moderator
Posts: 39134
Joined: 4. Sep 2008, 17:09
Primary OS: MS Windows 10
VBox Version: PUEL
Guest OSses: Mostly XP

Re: Windows 7 x86-64 gets aborted on Debian.

Post by mpack »

I'm afraid we need complete logs, not just the bits you think are important. Just pack a completed log inside a zip, and attach the zip here. Do not paste text, as the message size limit is too low for that, and in any case pasted text is inconvenient.

p.s. We only need the VBox.log, not the VBoxSVC log (unless we ask for it later).
ygrishin
Posts: 5
Joined: 3. Jan 2015, 21:23
Primary OS: Debian Wheezy
VBox Version: OSE Debian
Guest OSses: Windows 7

Re: Windows 7 x86-64 gets aborted on Debian.

Post by ygrishin »

There you go, right after the VM got aborted.

Got this with the following settings

Code: Select all

export VBOX_RELEASE_LOG="+all+pgm.e.l.f.s.b main gui"
export VBOX_RELEASE_LOG_FLAGS="buffered thread msprog"
export VBOX_RELEASE_LOG_DEST="file=/home/username/temp/vbox-release.log"
Does not look like there is something related to the crash/abortion as the VM were running ~2hrs before crashing. Notice the time in the log in the 1st column --- looks like this related to initialization only.
Attachments
vbox-release-edit.log
(48.43 KiB) Downloaded 21 times
loukingjr
Volunteer
Posts: 8851
Joined: 30. Apr 2009, 09:45
Primary OS: Mac OS X other
VBox Version: PUEL
Guest OSses: just about all that run

Re: Windows 7 x86-64 gets aborted on Debian.

Post by loukingjr »

According to Intel, your CPU has 4 cores and no Hyperthreading. Try reducing the number of cores for the guest to 2 and 4GB RAM.
http://ark.intel.com/products/34447/Int ... 00-MHz-FSB
OSX, Linux and Windows Hosts & Guests
There are three groups of people. Those that can count and those that can't.
ygrishin
Posts: 5
Joined: 3. Jan 2015, 21:23
Primary OS: Debian Wheezy
VBox Version: OSE Debian
Guest OSses: Windows 7

Re: Windows 7 x86-64 gets aborted on Debian.

Post by ygrishin »

I have 2 CPUs with 4 cores each, not sure why HT would matter? I have tried to reduce number of cores down to one, the abortions persisted.
loukingjr
Volunteer
Posts: 8851
Joined: 30. Apr 2009, 09:45
Primary OS: Mac OS X other
VBox Version: PUEL
Guest OSses: just about all that run

Re: Windows 7 x86-64 gets aborted on Debian.

Post by loukingjr »

I just realized that. Although your log does report 8 cores it seems to me there is a problem with dual processors and VirtualBox.
OSX, Linux and Windows Hosts & Guests
There are three groups of people. Those that can count and those that can't.
loukingjr
Volunteer
Posts: 8851
Joined: 30. Apr 2009, 09:45
Primary OS: Mac OS X other
VBox Version: PUEL
Guest OSses: just about all that run

Re: Windows 7 x86-64 gets aborted on Debian.

Post by loukingjr »

You may want to file a bug report on bugtracker
OSX, Linux and Windows Hosts & Guests
There are three groups of people. Those that can count and those that can't.
ygrishin
Posts: 5
Joined: 3. Jan 2015, 21:23
Primary OS: Debian Wheezy
VBox Version: OSE Debian
Guest OSses: Windows 7

Re: Windows 7 x86-64 gets aborted on Debian.

Post by ygrishin »

Cross-referencing the ticket.
Post Reply