VMs Crash Intermittantly

Discussions related to using VirtualBox on Linux hosts.
Post Reply
christr
Posts: 6
Joined: 28. Mar 2009, 20:21
Primary OS: Ubuntu 8.10
VBox Version: OSE Debian
Guest OSses: Solaris, WinXP

VMs Crash Intermittantly

Post by christr »

I run 2 VirtualBox VMs from my Ubuntu home server 24x7. Unfortunately they crash intermittently, and I've never been able to figure out why. Can anyone tell what might be happening from this log output? The host OS is 64-bit Ubuntu 9, and the VM OS's are 32-bit Solaris and Windows XP. I've been running all of the latest versions of VirtualBox and the OS's. Unfortunately with every patch I hope the problem will stop, but it never does.

Code: Select all

06:50:37.794 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=1152 h=883 bpp=0 cbLine=0x200
06:50:37.818 VBVA: Disabled.
06:50:37.872 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=0 cbLine=0x140
06:50:38.045 Changing the VM state from 'RUNNING' to 'RESETTING'.
06:50:38.128 CPUMSetGuestCpuIdFeature: Enabled APIC
06:50:38.128 CPUMSetGuestCpuIdFeature: Disabled x2APIC
06:50:38.128 PIT: mode=3 count=0x10000 (65536) - 18.20 Hz (ch=0)
06:50:38.128 SharedFolders host service: disconnected, u32ClientID = 1
06:50:38.129 VBoxX11ClipboardStopX11: stopping the shared clipboard X11 backend
06:50:38.129 Shared clipboard: host clipboard thread terminated successfully
06:50:38.167 PIIX3 ATA: Ctl#0: finished processing RESET
06:50:38.267 PIIX3 ATA: Ctl#1: finished processing RESET
06:50:38.368 Changing the VM state from 'RESETTING' to 'RUNNING'.
06:50:38.374 Guest Log: BIOS: VirtualBox 2.2.4
06:50:38.375 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
06:50:38.406 PIIX3 ATA: Ctl#0: RESET, DevSel=0 AIOIf=0 CmdIf0=0xe0 (-1 usec ago) CmdIf1=0x00 (-1 usec ago)
06:50:38.406 PIIX3 ATA: Ctl#0: finished processing RESET
06:50:38.417 Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
06:50:38.418 PIIX3 ATA: Ctl#1: RESET, DevSel=0 AIOIf=0 CmdIf0=0xa0 (-1 usec ago) CmdIf1=0x00 (-1 usec ago)
06:50:38.418 PIIX3 ATA: Ctl#1: finished processing RESET
06:50:38.419 PIT: mode=2 count=0x48d3 (18643) - 64.00 Hz (ch=0)
06:50:38.438 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=32 cbLine=0xA00
06:50:40.552 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
06:50:40.554 Guest Log: BIOS: Boot from Floppy 0 failed
06:50:40.556 Guest Log: BIOS: CDROM boot failure code : 0004
06:50:40.556 Guest Log: BIOS: Boot from CD-ROM failed
06:50:40.557 Guest Log: BIOS: Booting from Hard Disk...
06:50:40.572 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=0000000000000000 w=720 h=400 bpp=0 cbLine=0x0
06:50:40.828 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.829 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.829 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.830 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.830 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.831 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:40.831 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
06:50:42.431 PIT: mode=2 count=0x2ead (11949) - 99.85 Hz (ch=0)
             CPUMSetGuestCpuIdFeature: Disabled x2APIC
06:50:42.740 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=0 cbLine=0x140
06:50:44.138 PIIX3 ATA: LUN#0: IDLE IMMEDIATE, CmdIf=0xef (-1 usec ago)
06:50:44.138 PIIX3 ATA: LUN#0: aborting current command
06:50:45.209 Guest Additions information report: additionsVersion = 0x00010004  osType = 0x00033000
06:50:45.247 Guest reported fixed hypervisor window at 0x00000000f6400000 (size = 0xc00000, rc = VINF_SUCCESS)
06:50:49.817 Guest requests mouse pointer integration
06:51:06.035 PCNet#0: Init: ss32=1 GCRDRA=0x065a1420[64] GCTDRA=0x065a1020[64]
06:51:06.331 SharedFolders host service: connected, u32ClientID = 4
06:51:06.425 PCNet#0: Init: ss32=1 GCRDRA=0x065a1420[64] GCTDRA=0x065a1020[64]
06:51:15.920 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=1152 h=883 bpp=32 cbLine=0x1200
06:51:15.921 VBVA: Enabled.
06:51:17.030 Guest Log: VBoxService: Started.
06:51:17.042 Guest Log: vboxTimeSyncThread: Started.
06:51:19.709 PCNet#0: Init: ss32=1 GCRDRA=0x065a1420[64] GCTDRA=0x065a1020[64]
06:51:24.142 Guest Log: VBoxTray: Started.
06:51:24.653 AssertLogRel /home/vbox/vbox-2.2.4/src/VBox/HostServices/SharedClipboard/x11-clipboard.cpp(212) int vboxClipboardConnect(VBOXCLIPBOARDCLIENTDATA*): g_ctxHost.pClient == 0
06:51:24.704 Guest Additions capability report: (0x5) seamless: yes, hostWindowMapping: no, graphics: yes
06:51:25.098 PATM: Disable block at 86616244 - write 8661634a-8661634e
06:51:40.172 Guest Log: VBOXNP: DLL loaded.
06:51:41.019 Guest Log: VBOXNP: DLL unloaded.
06:51:41.044 Guest Log: VBOXNP: DLL loaded.
06:51:41.172 Guest Log: VBOXNP: DLL loaded.
06:51:41.218 Guest Log: VBOXNP: DLL unloaded.
06:51:44.053 PCNet#0: Init: ss32=1 GCRDRA=0x065a1420[64] GCTDRA=0x065a1020[64]
06:51:51.396 Guest Log: VBOXNP: DLL loaded.
07:25:19.852 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=1152 h=883 bpp=0 cbLine=0x200
07:25:19.852 VBVA: Disabled.
07:25:20.069 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=0 cbLine=0x140
07:25:20.187 Changing the VM state from 'RUNNING' to 'RESETTING'.
07:25:20.289 CPUMSetGuestCpuIdFeature: Enabled APIC
07:25:20.289 CPUMSetGuestCpuIdFeature: Disabled x2APIC
07:25:20.289 PIT: mode=3 count=0x10000 (65536) - 18.20 Hz (ch=0)
07:25:20.299 SharedFolders host service: disconnected, u32ClientID = 4
07:25:20.353 PIIX3 ATA: Ctl#0: finished processing RESET
07:25:20.454 PIIX3 ATA: Ctl#1: finished processing RESET
07:25:20.554 TM: Aborting catch-up attempt on reset with a 497788073 ns lag on reset; new total: 497788073 ns
07:25:20.556 Changing the VM state from 'RESETTING' to 'RUNNING'.
07:25:20.561 Guest Log: BIOS: VirtualBox 2.2.4
07:25:20.561 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
07:25:20.589 PIIX3 ATA: Ctl#0: RESET, DevSel=0 AIOIf=0 CmdIf0=0xe0 (-1 usec ago) CmdIf1=0x00 (-1 usec ago)
07:25:20.589 PIIX3 ATA: Ctl#0: finished processing RESET
07:25:20.591 Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
07:25:20.592 PIIX3 ATA: Ctl#1: RESET, DevSel=0 AIOIf=0 CmdIf0=0xa0 (-1 usec ago) CmdIf1=0x00 (-1 usec ago)
07:25:20.592 PIIX3 ATA: Ctl#1: finished processing RESET
07:25:20.594 PIT: mode=2 count=0x48d3 (18643) - 64.00 Hz (ch=0)
07:25:20.606 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=32 cbLine=0xA00
07:25:23.068 PIT: mode=2 count=0x10000 (65536) - 18.20 Hz (ch=0)
07:25:23.071 Guest Log: BIOS: Boot from Floppy 0 failed
07:25:23.072 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=0000000000000000 w=720 h=400 bpp=0 cbLine=0x0
07:25:23.099 Guest Log: BIOS: CDROM boot failure code : 0004
07:25:23.099 Guest Log: BIOS: Boot from CD-ROM failed
07:25:23.147 Guest Log: BIOS: Booting from Hard Disk...
07:25:23.491 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.491 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.491 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.492 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.492 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.492 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:23.493 Guest Log: BIOS: int13_harddisk: function 02, parameters out of range 0000/0000/0001!
07:25:25.403 PIT: mode=2 count=0x2ead (11949) - 99.85 Hz (ch=0)
             CPUMSetGuestCpuIdFeature: Disabled x2APIC
07:25:25.685 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=640 h=480 bpp=0 cbLine=0x140
07:25:27.177 PIIX3 ATA: LUN#0: IDLE IMMEDIATE, CmdIf=0xef (-1 usec ago)
07:25:27.177 PIIX3 ATA: LUN#0: aborting current command
07:25:28.252 Guest Additions information report: additionsVersion = 0x00010004  osType = 0x00033000
07:25:28.294 Guest reported fixed hypervisor window at 0x00000000f6400000 (size = 0xc00000, rc = VINF_SUCCESS)
07:25:32.985 Guest requests mouse pointer integration
07:25:38.853 PCNet#0: Init: ss32=1 GCRDRA=0x06524420[64] GCTDRA=0x06524020[64]
07:25:41.499 SharedFolders host service: connected, u32ClientID = 7
07:25:41.545 PATM: Disable block at 86527acc - write 86527b49-86527b4d
07:25:42.636 PCNet#0: Init: ss32=1 GCRDRA=0x06524420[64] GCTDRA=0x06524020[64]
07:25:57.492 Display::handleDisplayResize(): uScreenId = 0, pvVRAM=00007f08f7257000 w=1152 h=883 bpp=32 cbLine=0x1200
07:25:57.507 VBVA: Enabled.
07:25:58.645 Guest Log: VBoxService: Started.
07:25:58.659 Guest Log: vboxTimeSyncThread: Started.
07:26:00.937 PCNet#0: Init: ss32=1 GCRDRA=0x06524420[64] GCTDRA=0x06524020[64]
07:26:05.163 Guest Log: VBoxTray: Started.
07:26:05.661 AssertLogRel /home/vbox/vbox-2.2.4/src/VBox/HostServices/SharedClipboard/x11-clipboard.cpp(212) int vboxClipboardConnect(VBOXCLIPBOARDCLIENTDATA*): g_ctxHost.pClient == 0
07:26:05.781 Guest Additions capability report: (0x5) seamless: yes, hostWindowMapping: no, graphics: yes
07:26:06.431 PATM: Disable block at 866a58a4 - write 866a598c-866a5990
07:26:22.053 Guest Log: VBOXNP: DLL loaded.
07:26:22.424 Guest Log: VBOXNP: DLL unloaded.
07:26:22.483 Guest Log: VBOXNP: DLL loaded.
07:26:22.575 Guest Log: VBOXNP: DLL loaded.
07:26:22.611 Guest Log: VBOXNP: DLL unloaded.
07:26:25.111 PCNet#0: Init: ss32=1 GCRDRA=0x06524420[64] GCTDRA=0x06524020[64]
07:26:31.693 Guest Log: VBOXNP: DLL loaded.
07:37:53.408 !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!
07:37:53.408 !!
07:37:53.408 !!                 Guru Meditation -2403 (VERR_TRPM_DONT_PANIC)
07:37:53.408 !!
07:37:53.408 !! TRAP=0e ERRCD=0000000000000002 CR2=00000000a0d66e50 EIP=f6c14716 Type=0
07:37:53.408 !! EIP in VMMGC.gc (f6bd8000) at rva 3c716 near symbols:
07:37:53.408 !!    f6c14690 rva 0003c690 off 00000086  RTTimeNanoTSLFenceSync
07:37:53.408 !!    f6c14940 rva 0003c940 off -0000022a RTTimeNanoTSLFenceAsync
07:37:53.408 !! fff8:f6c14716 f0 0f c7 0e             lock cmpxchg8b qword [esi]
07:37:53.409 !!
07:37:53.409 !!
07:37:53.409 !!
07:37:53.409 Hypervisor CPUM state: se
07:37:53.419 .eax=00000000 .ebx=00000000 .ecx=00000000 .edx=0004194d .esi=a0d66e50 .edi=0001b528
07:37:53.420 .eip=f6c14716 .esp=f6567c8c .ebp=f6567d44 .iopl=0        rf nv up di nt zr ac pe nc
07:37:53.420 .cs={fff8 base=0000000000000000 limit=00000000 flags=00000000} .dr0=00000000 .dr1=00000000
07:37:53.420 .ds={fff0 base=0000000000000000 limit=00000000 flags=00000000} .dr2=00000000 .dr3=00000000
07:37:53.420 .es={fff0 base=0000000000000000 limit=00000000 flags=00000000} .dr4=00000000 .dr5=00000000
07:37:53.420 .fs={0030 base=0000000000000000 limit=00000000 flags=00000000} .dr6=00000000 .dr7=00000000
07:37:53.420 .gs={0000 base=0000000000000000 limit=00000000 flags=00000000} .cr0=00000000 .cr2=00000000
07:37:53.420 .ss={fff0 base=0000000000000000 limit=00000000 flags=00000000} .cr3=bbc58000 .cr4=00000000
07:37:53.420 .gdtr=00000000f69ae000:ffff  .idtr=00000000f640f3d0:07ff  .eflags=00010092
07:37:53.420 .ldtr={0000 base=00000000 limit=00000000 flags=00000000}
07:37:53.420 .tr  ={ffe0 base=00000000 limit=00000000 flags=00000000}
07:37:53.420 .SysEnter={cs=0000 eip=00000000 esp=00000000}
07:37:53.420 FPU:
07:37:53.420 .FCW=0000 .FSW=0000 .FTW=00
07:37:53.420 .res1=00 .FOP=0000 .FPUIP=00000000 .CS=0000 .Rsvrd1=0000
07:37:53.420 .FPUDP=0000 .DS=0000 .Rsvrd2=0000 .MXCSR=00000000 .MXCSR_MASK=00000000
07:37:53.420 MSR:
07:37:53.420 .EFER         =0000000000000000
07:37:53.420 .PAT          =0000000000000000
07:37:53.420 .STAR         =0000000000000000
07:37:53.420 .CSTAR        =0000000000000000
07:37:53.420 .LSTAR        =0000000000000000
07:37:53.420 .SFMASK       =0000000000000000
07:37:53.420 .KERNELGSBASE =0000000000000000
07:37:53.420 CR4OrMask=0x204 CR4AndMask=0x403
07:37:53.420 !!
07:37:53.420 !! Call Stack:
07:37:53.420 !!
07:37:53.420 EBP      Ret EBP  Ret CS:EIP    Arg0     Arg1     Arg2     Arg3     CS:EIP        Symbol [line]
07:37:53.420 f6567d44 f6567d94 fff8:f6c08372 f6413a90 80000fff 0040f300 00000000 fff8:00000000f6c14716 RTTimeNanoTSLFenceSync+86
07:37:53.420 f6567d94 f6567da4 fff8:f6c084c9 f6401000 00000001 f6567e24 f6c06ceb fff8:00000000f6c08372 TMVirtualGetEx+62
07:37:53.420 f6567da4 f6567e24 fff8:f6c06ceb f6401000 00000003 00000000 f6567ed4 fff8:00000000f6c084c9 TMVirtualGet+19
07:37:53.420 f6567e24 f6567e94 fff8:f6bda088 f6401000 00000000 00000000 00000000 fff8:00000000f6c06ceb TMTimerPoll+4b
07:37:53.420 f6567e94 f6567ec4 fff8:f6bda22c f6401000 00000000 f6567ed4 f6567ed4 fff8:00000000f6bda088 _ZL14trpmGCExitTrapP2VMiP11CPUMCTXCORE+128
07:37:53.420 f6567ec4 80042000 fff8:f6bdb1b6 f640f380 f6567ed4 8648fda0 864854e8 fff8:00000000f6bda22c TRPMGCTrap0eHandler+5c
07:37:53.420 80042000 0c458b24 fff8:b2d46de0 8b080010 758b0855 eac14008 ffe68110 fff8:00000000f6bdb1b6 gt_HaveHandler+8
07:37:53.421 0c458b24 00000000 fff8:00000000 00000000 00000000 00000000 00000000 fff8:00000000b2d46de0
07:37:53.421 !!
07:37:53.421 !! Raw stack (mind the direction). pbEMTStackRC=f6566000 pbEMTStackBottomRC=f6568000
07:37:53.421 !!
07:37:53.421 0000000005496000 0000: 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 ................

07:37:53.465 Hypervisor Virtual handlers:
07:37:53.465 From     - To (excl) HandlerHC HandlerGC Type     Description
07:37:53.465 00000000f640f3d0 - 00000000f640fbcf  0000000000000000  f6bd9a80  WriteHyp   Shadow IDT write access handler
07:37:53.465 00000000f64108b0 - 00000000f6410937  0000000000000000  f6bd9390  WriteHyp   Shadow TSS write access handler
07:37:53.465 00000000f69ae000 - 00000000f69bdfff  0000000000000000  f6bd94b0  WriteHyp   Shadow GDT write access handler
07:37:53.465 00000000f69bf000 - 00000000f69cffff  0000000000000000  f6bd9420  WriteHyp   Shadow LDT write access handler
07:37:53.465 !!
07:37:53.465 !! {cfgm, <NULL>}
07:37:53.465 !!
07:37:53.465 pRoot=0000000001f63b60:{/}
07:37:53.465 [/] (level 0)
07:37:53.465   Name               <string>  = "tabasco02" (cch=10)
07:37:53.465   UUID               <bytes>   = "4b b8 81 a5 bc ae d0 47 bf 0a 31 2c 21 c4 43 ed" (cb=16)
07:37:53.466   RamSize            <integer> = 0x0000000040000000 (1073741824)
07:37:53.466   RamHoleSize        <integer> = 0x0000000020000000 (536870912)
07:37:53.466   NumCPUs            <integer> = 0x0000000000000001 (1)
07:37:53.466   TimerMillies       <integer> = 0x000000000000000a (10)
07:37:53.466   RawR3Enabled       <integer> = 0x0000000000000001 (1)
07:37:53.466   RawR0Enabled       <integer> = 0x0000000000000001 (1)
07:37:53.466   PATMEnabled        <integer> = 0x0000000000000001 (1)
07:37:53.466   CSAMEnabled        <integer> = 0x0000000000000001 (1)
07:37:53.466   HwVirtExtForced    <integer> = 0x0000000000000000 (0)
07:37:53.466   EnableNestedPaging <integer> = 0x0000000000000000 (0)
07:37:53.466   EnableVPID         <integer> = 0x0000000000000000 (0)
07:37:53.466   EnablePAE          <integer> = 0x0000000000000000 (0)
07:37:53.466 
07:37:53.466 [/HWVirtExt/] (level 1)
07:37:53.466 
07:37:53.466 [/PDM/] (level 1)
07:37:53.466 
07:37:53.466 [/PDM/Drivers/] (level 2)
07:37:53.466 
07:37:53.466 [/PDM/Drivers/VBoxC/] (level 3)
07:37:53.466   Path <string>  = "/usr/lib/virtualbox/components/VBoxC" (cch=37)
07:37:53.466 
07:37:53.466 [/Devices/] (level 1)
07:37:53.466 
07:37:53.466 [/Devices/pcarch/] (level 2)
07:37:53.466 
07:37:53.466 [/Devices/pcarch/0/] (level 3)
07:37:53.466   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.466 
07:37:53.466 [/Devices/pcarch/0/Config/] (level 4) (restricted root)
07:37:53.466 
07:37:53.466 [/Devices/pcbios/] (level 2)
07:37:53.466 
07:37:53.466 [/Devices/pcbios/0/] (level 3)
07:37:53.466   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.466 
07:37:53.466 [/Devices/pcbios/0/Config/] (level 4) (restricted root)
07:37:53.466   RamSize        <integer> = 0x0000000040000000 (1073741824)
07:37:53.466   RamHoleSize    <integer> = 0x0000000020000000 (536870912)
07:37:53.466   NumCPUs        <integer> = 0x0000000000000001 (1)
07:37:53.466   HardDiskDevice <string>  = "piix3ide" (cch=9)
07:37:53.466   FloppyDevice   <string>  = "i82078" (cch=7)
07:37:53.466   IOAPIC         <integer> = 0x0000000000000000 (0)
07:37:53.466   PXEDebug       <integer> = 0x0000000000000000 (0)
07:37:53.466   UUID           <bytes>   = "4b b8 81 a5 bc ae d0 47 bf 0a 31 2c 21 c4 43 ed" (cb=16)
07:37:53.466   BootDevice0    <string>  = "FLOPPY" (cch=7)
07:37:53.466   BootDevice1    <string>  = "DVD" (cch=4)
07:37:53.466   BootDevice2    <string>  = "IDE" (cch=4)
07:37:53.466   BootDevice3    <string>  = "NONE" (cch=5)
07:37:53.466 
07:37:53.466 [/Devices/8237A/] (level 2)
07:37:53.466 
07:37:53.466 [/Devices/8237A/0/] (level 3)
07:37:53.466   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.466 
07:37:53.466 [/Devices/8237A/0/Config/] (level 4) (restricted root)
07:37:53.467 
07:37:53.467 [/Devices/pci/] (level 2)
07:37:53.467 
07:37:53.467 [/Devices/pci/0/] (level 3)
07:37:53.467   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.467 
07:37:53.467 [/Devices/pci/0/Config/] (level 4) (restricted root)
07:37:53.467   IOAPIC <integer> = 0x0000000000000000 (0)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/] (level 2)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/] (level 3)
07:37:53.467   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/Config/] (level 4) (restricted root)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#0/] (level 4)
07:37:53.467   Driver <string>  = "KeyboardQueue" (cch=14)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.467   QueueSize <integer> = 0x0000000000000040 (64)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#0/AttachedDriver/] (level 5)
07:37:53.467   Driver <string>  = "MainKeyboard" (cch=13)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#0/AttachedDriver/Config/] (level 6) (restricted root)
07:37:53.467   Object <integer> = 0x00000000022a28b0 (36317360)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#1/] (level 4)
07:37:53.467   Driver <string>  = "MouseQueue" (cch=11)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#1/Config/] (level 5) (restricted root)
07:37:53.467   QueueSize <integer> = 0x0000000000000080 (128)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#1/AttachedDriver/] (level 5)
07:37:53.467   Driver <string>  = "MainMouse" (cch=10)
07:37:53.467 
07:37:53.467 [/Devices/pckbd/0/LUN#1/AttachedDriver/Config/] (level 6) (restricted root)
07:37:53.467   Object <integer> = 0x00000000022a2a00 (36317696)
07:37:53.467 
07:37:53.467 [/Devices/i82078/] (level 2)
07:37:53.467 
07:37:53.467 [/Devices/i82078/0/] (level 3)
07:37:53.467   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.467 
07:37:53.467 [/Devices/i82078/0/Config/] (level 4) (restricted root)
07:37:53.467   IRQ       <integer> = 0x0000000000000006 (6)
07:37:53.467   DMA       <integer> = 0x0000000000000002 (2)
07:37:53.468   MemMapped <integer> = 0x0000000000000000 (0)
07:37:53.468   IOBase    <integer> = 0x00000000000003f0 (1008)
07:37:53.468 
07:37:53.468 [/Devices/i82078/0/LUN#999/] (level 4)
07:37:53.468   Driver <string>  = "MainStatus" (cch=11)
07:37:53.468 
07:37:53.468 [/Devices/i82078/0/LUN#999/Config/] (level 5) (restricted root)
07:37:53.468   papLeds <integer> = 0x00000000022a1dd0 (36314576)
07:37:53.468   First   <integer> = 0x0000000000000000 (0)
07:37:53.468   Last    <integer> = 0x0000000000000000 (0)
07:37:53.468 
07:37:53.468 [/Devices/i82078/0/LUN#0/] (level 4)
07:37:53.468   Driver <string>  = "Block" (cch=6)
07:37:53.468 
07:37:53.468 [/Devices/i82078/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.468   Type      <string>  = "Floppy 1.44" (cch=12)
07:37:53.468   Mountable <integer> = 0x0000000000000001 (1)
07:37:53.468 
07:37:53.468 [/Devices/acpi/] (level 2)
07:37:53.468 
07:37:53.468 [/Devices/acpi/0/] (level 3)
07:37:53.468   Trusted       <integer> = 0x0000000000000001 (1)
07:37:53.468   PCIDeviceNo   <integer> = 0x0000000000000007 (7)
07:37:53.468   PCIFunctionNo <integer> = 0x0000000000000000 (0)
07:37:53.468 
07:37:53.468 [/Devices/acpi/0/Config/] (level 4) (restricted root)
07:37:53.468   RamSize     <integer> = 0x0000000040000000 (1073741824)
07:37:53.468   RamHoleSize <integer> = 0x0000000020000000 (536870912)
07:37:53.468   NumCPUs     <integer> = 0x0000000000000001 (1)
07:37:53.468   IOAPIC      <integer> = 0x0000000000000000 (0)
07:37:53.468   FdcEnabled  <integer> = 0x0000000000000001 (1)
07:37:53.468 
07:37:53.468 [/Devices/acpi/0/LUN#0/] (level 4)
07:37:53.468   Driver <string>  = "ACPIHost" (cch=9)
07:37:53.468 
07:37:53.468 [/Devices/acpi/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.468 
07:37:53.468 [/Devices/i8254/] (level 2)
07:37:53.468 
07:37:53.468 [/Devices/i8254/0/] (level 3)
07:37:53.468 
07:37:53.468 [/Devices/i8254/0/Config/] (level 4) (restricted root)
07:37:53.468 
07:37:53.468 [/Devices/i8259/] (level 2)
07:37:53.468 
07:37:53.468 [/Devices/i8259/0/] (level 3)
07:37:53.468   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.468 
07:37:53.468 [/Devices/i8259/0/Config/] (level 4) (restricted root)
07:37:53.468 
07:37:53.468 [/Devices/apic/] (level 2)
07:37:53.468 
07:37:53.468 [/Devices/apic/0/] (level 3)
07:37:53.469   Trusted <integer> = 0x0000000000000001 (1)
07:37:53.469 
07:37:53.469 [/Devices/apic/0/Config/] (level 4) (restricted root)
07:37:53.469   IOAPIC  <integer> = 0x0000000000000000 (0)
07:37:53.469   NumCPUs <integer> = 0x0000000000000001 (1)
07:37:53.469 
07:37:53.469 [/Devices/mc146818/] (level 2)
07:37:53.469 
07:37:53.469 [/Devices/mc146818/0/] (level 3)
07:37:53.469 
07:37:53.469 [/Devices/mc146818/0/Config/] (level 4) (restricted root)
07:37:53.469 
07:37:53.469 [/Devices/vga/] (level 2)
07:37:53.469 
07:37:53.469 [/Devices/vga/0/] (level 3)
07:37:53.469   Trusted       <integer> = 0x0000000000000001 (1)
07:37:53.469   PCIDeviceNo   <integer> = 0x0000000000000002 (2)
07:37:53.469   PCIFunctionNo <integer> = 0x0000000000000000 (0)
07:37:53.469 
07:37:53.469 [/Devices/vga/0/Config/] (level 4) (restricted root)
07:37:53.469   VRamSize         <integer> = 0x0000000008000000 (134217728)
07:37:53.469   FadeIn           <integer> = 0x0000000000000001 (1)
07:37:53.469   FadeOut          <integer> = 0x0000000000000001 (1)
07:37:53.469   LogoTime         <integer> = 0x0000000000000000 (0)
07:37:53.469   LogoFile         <string>  = "" (cch=1)
07:37:53.469   ShowBootMenu     <integer> = 0x0000000000000002 (2)
07:37:53.469   CustomVideoModes <integer> = 0x0000000000000000 (0)
07:37:53.469   HeightReduction  <integer> = 0x0000000000000000 (0)
07:37:53.469 
07:37:53.469 [/Devices/vga/0/LUN#0/] (level 4)
07:37:53.469   Driver <string>  = "MainDisplay" (cch=12)
07:37:53.469 
07:37:53.469 [/Devices/vga/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.469   Object <integer> = 0x00000000022a2b50 (36318032)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/] (level 2)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/0/] (level 3)
07:37:53.469   Trusted       <integer> = 0x0000000000000001 (1)
07:37:53.469   PCIDeviceNo   <integer> = 0x0000000000000001 (1)
07:37:53.469   PCIFunctionNo <integer> = 0x0000000000000001 (1)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/0/Config/] (level 4) (restricted root)
07:37:53.469   Type <string>  = "PIIX4" (cch=6)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/0/LUN#999/] (level 4)
07:37:53.469   Driver <string>  = "MainStatus" (cch=11)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/0/LUN#999/Config/] (level 5) (restricted root)
07:37:53.469   papLeds <integer> = 0x00000000022a1de0 (36314592)
07:37:53.469   First   <integer> = 0x0000000000000000 (0)
07:37:53.469   Last    <integer> = 0x0000000000000003 (3)
07:37:53.469 
07:37:53.469 [/Devices/piix3ide/0/LUN#2/] (level 4)
07:37:53.469   Driver <string>  = "Block" (cch=6)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#2/Config/] (level 5) (restricted root)
07:37:53.470   Type      <string>  = "DVD" (cch=4)
07:37:53.470   Mountable <integer> = 0x0000000000000001 (1)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#2/AttachedDriver/] (level 5)
07:37:53.470   Driver <string>  = "MediaISO" (cch=9)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#2/AttachedDriver/Config/] (level 6) (restricted root)
07:37:53.470   Path <string>  = "/usr/share/virtualbox/VBoxGuestAdditions.iso" (cch=45)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#0/] (level 4)
07:37:53.470   Driver <string>  = "Block" (cch=6)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.470   Type      <string>  = "HardDisk" (cch=9)
07:37:53.470   Mountable <integer> = 0x0000000000000000 (0)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#0/AttachedDriver/] (level 5)
07:37:53.470   Driver <string>  = "VD" (cch=3)
07:37:53.470 
07:37:53.470 [/Devices/piix3ide/0/LUN#0/AttachedDriver/Config/] (level 6) (restricted root)
07:37:53.470   Path   <string>  = "/home/chris/.VirtualBox/HardDisks/tabasco02.vdi" (cch=48)
07:37:53.470   Format <string>  = "VDI" (cch=4)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/] (level 2)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/] (level 3)
07:37:53.470   Trusted       <integer> = 0x0000000000000001 (1)
07:37:53.470   PCIDeviceNo   <integer> = 0x0000000000000003 (3)
07:37:53.470   PCIFunctionNo <integer> = 0x0000000000000000 (0)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/Config/] (level 4) (restricted root)
07:37:53.470   Am79C973       <integer> = 0x0000000000000001 (1)
07:37:53.470   MAC            <bytes>   = "08 00 27 b9 32 40" (cb=6)
07:37:53.470   CableConnected <integer> = 0x0000000000000001 (1)
07:37:53.470   LineSpeed      <integer> = 0x0000000000000000 (0)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/LUN#999/] (level 4)
07:37:53.470   Driver <string>  = "MainStatus" (cch=11)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/LUN#999/Config/] (level 5) (restricted root)
07:37:53.470   papLeds <integer> = 0x00000000022a1f70 (36314992)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/LUN#0/] (level 4)
07:37:53.470   Driver <string>  = "IntNet" (cch=7)
07:37:53.470 
07:37:53.470 [/Devices/pcnet/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.470   Trunk     <string>  = "eth0" (cch=5)
07:37:53.470   TrunkType <integer> = 0x0000000000000003 (3)
07:37:53.471   Network   <string>  = "HostInterfaceNetworking-eth0" (cch=29)
07:37:53.471 
07:37:53.471 [/Devices/e1000/] (level 2)
07:37:53.471 
07:37:53.471 [/Devices/serial/] (level 2)
07:37:53.471 
07:37:53.471 [/Devices/parallel/] (level 2)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/] (level 2)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/] (level 3)
07:37:53.471   Trusted       <integer> = 0x0000000000000001 (1)
07:37:53.471   PCIDeviceNo   <integer> = 0x0000000000000004 (4)
07:37:53.471   PCIFunctionNo <integer> = 0x0000000000000000 (0)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/Config/] (level 4) (restricted root)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/LUN#0/] (level 4)
07:37:53.471   Driver <string>  = "MainVMMDev" (cch=11)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.471   Object <integer> = 0x00000000022a2250 (36315728)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/LUN#999/] (level 4)
07:37:53.471   Driver <string>  = "MainStatus" (cch=11)
07:37:53.471 
07:37:53.471 [/Devices/VMMDev/0/LUN#999/Config/] (level 5) (restricted root)
07:37:53.471   papLeds <integer> = 0x00000000022a1fb0 (36315056)
07:37:53.471   First   <integer> = 0x0000000000000000 (0)
07:37:53.471   Last    <integer> = 0x0000000000000000 (0)
07:37:53.471 
07:37:53.471 [/Devices/AudioSniffer/] (level 2)
07:37:53.471 
07:37:53.471 [/Devices/AudioSniffer/0/] (level 3)
07:37:53.471 
07:37:53.471 [/Devices/AudioSniffer/0/Config/] (level 4) (restricted root)
07:37:53.471 
07:37:53.471 [/Devices/AudioSniffer/0/LUN#0/] (level 4)
07:37:53.471   Driver <string>  = "MainAudioSniffer" (cch=17)
07:37:53.471 
07:37:53.471 [/Devices/AudioSniffer/0/LUN#0/Config/] (level 5) (restricted root)
07:37:53.471   Object <integer> = 0x00000000022a3270 (36319856)
07:37:53.471 
07:37:53.471 [/TM/] (level 1)
07:37:53.471   UTCOffset <integer> = 0x0000000000000000 (0)
07:37:53.471 
07:37:53.471 [/MM/] (level 1)
07:37:53.471 
07:37:53.471 !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!
07:37:54.471 Changing the VM state from 'RUNNING' to 'GURU_MEDITATION'.
09:09:49.667 Console::powerDown(): A request to power off the VM has been issued (mMachineState=6, InUninit=0)
09:09:49.851 SharedFolders host service: disconnected, u32ClientID = 7
09:09:49.879 vboxClipboardDestroy: shutting down host clipboard
09:09:49.899 Changing the VM state from 'GURU_MEDITATION' to 'OFF'.
09:09:49.960 Changing the VM state from 'OFF' to 'DESTROYING'.
09:09:49.960 ************************* Statistics *************************
09:09:49.960 /Devices/ATA0/Unit0/AtapiDMA            0 times
09:09:49.960 /Devices/ATA0/Unit0/AtapiPIO            0 times
09:09:49.960 /Devices/ATA0/Unit0/DMA                 0 times
09:09:49.960 /Devices/ATA0/Unit0/PIO             78148 times
09:09:49.960 /Devices/ATA0/Unit0/ReadBytes    1553538048 bytes
09:09:49.960 /Devices/ATA0/Unit0/WrittenBytes 884425216 bytes
09:09:49.960 /Devices/ATA0/Unit1/AtapiDMA            0 times
09:09:49.960 /Devices/ATA0/Unit1/AtapiPIO            0 times
09:09:49.960 /Devices/ATA0/Unit1/DMA                 0 times
09:09:49.960 /Devices/ATA0/Unit1/PIO                 0 times
09:09:49.960 /Devices/ATA0/Unit1/ReadBytes           0 bytes
09:09:49.960 /Devices/ATA0/Unit1/WrittenBytes        0 bytes
09:09:49.960 /Devices/ATA1/Unit0/AtapiDMA           81 times
09:09:49.961 /Devices/ATA1/Unit0/AtapiPIO        27479 times
09:09:49.961 /Devices/ATA1/Unit0/DMA                 0 times
09:09:49.961 /Devices/ATA1/Unit0/PIO                 0 times
09:09:49.961 /Devices/ATA1/Unit0/ReadBytes      104448 bytes
09:09:49.961 /Devices/ATA1/Unit0/WrittenBytes        0 bytes
09:09:49.961 /Devices/ATA1/Unit1/AtapiDMA            0 times
09:09:49.961 /Devices/ATA1/Unit1/AtapiPIO            0 times
09:09:49.961 /Devices/ATA1/Unit1/DMA                 0 times
09:09:49.961 /Devices/ATA1/Unit1/PIO                 0 times
09:09:49.961 /Devices/ATA1/Unit1/ReadBytes           0 bytes
09:09:49.961 /Devices/ATA1/Unit1/WrittenBytes        0 bytes
09:09:49.961 /Devices/PCNet0/ReceiveBytes     20371683 bytes
09:09:49.961 /Devices/PCNet0/TransmitBytes      400609 bytes
09:09:49.961 /GVMM/Sum/HaltBlocking           78120143 calls
09:09:49.961 /GVMM/Sum/HaltCalls              78227177 calls
09:09:49.961 /GVMM/Sum/HaltNotBlocking          107034 calls
09:09:49.961 /GVMM/Sum/HaltTimeouts           38301343 calls
09:09:49.961 /GVMM/Sum/HaltWakeUps             1332577 calls
09:09:49.961 /GVMM/Sum/PollCalls                196834 calls
09:09:49.961 /GVMM/Sum/PollHalts                     0 calls
09:09:49.961 /GVMM/Sum/PollWakeUps                3017 calls
09:09:49.961 /GVMM/Sum/WakeUpCalls            70544209 calls
09:09:49.961 /GVMM/Sum/WakeUpNotHalted        58585166 calls
09:09:49.961 /GVMM/Sum/WakeUpWakeUps           3033064 calls
09:09:49.961 /GVMM/VM/HaltBlocking             7514500 calls
09:09:49.961 /GVMM/VM/HaltCalls                7515680 calls
09:09:49.961 /GVMM/VM/HaltNotBlocking             1180 calls
09:09:49.961 /GVMM/VM/HaltTimeouts             3409040 calls
09:09:49.961 /GVMM/VM/HaltWakeUps               727620 calls
09:09:49.961 /GVMM/VM/PollCalls                     18 calls
09:09:49.961 /GVMM/VM/PollHalts                      0 calls
09:09:49.961 /GVMM/VM/PollWakeUps                    1 calls
09:09:49.961 /GVMM/VM/WakeUpCalls              6614808 calls
09:09:49.961 /GVMM/VM/WakeUpNotHalted          5384236 calls
09:09:49.961 /GVMM/VM/WakeUpWakeUps            1407195 calls
09:09:49.961 /GVMM/VMs                               2 calls
09:09:49.961 /MM/HyperHeap/cbFree               773040 bytes
09:09:49.961 /MM/HyperHeap/cbHeap              1310592 bytes
09:09:49.961 /Net/IntNet0/Bytes/Received      21677585 bytes
09:09:49.961 /Net/IntNet0/Bytes/Sent            400609 bytes
09:09:49.961 /Net/IntNet0/Packets/Lost               0 bytes
09:09:49.961 /Net/IntNet0/Packets/Received      115247 bytes
09:09:49.961 /Net/IntNet0/Packets/Sent            3784 bytes
09:09:49.961 /Net/IntNet0/YieldNok                   0 bytes
09:09:49.961 /PDM/CritSects/ATA0/ContentionR3        0 times
09:09:49.961 /PDM/CritSects/ATA0/ContentionRZLock      775 times
09:09:49.961 /PDM/CritSects/ATA0/ContentionRZUnlock       89 times
09:09:49.961 /PDM/CritSects/ATA1/ContentionR3        0 times
09:09:49.961 /PDM/CritSects/ATA1/ContentionRZLock     6576 times
09:09:49.961 /PDM/CritSects/ATA1/ContentionRZUnlock      932 times
09:09:49.961 /PDM/CritSects/PCNet#0/ContentionR3        0 times
09:09:49.961 /PDM/CritSects/PCNet#0/ContentionRZLock       72 times
09:09:49.961 /PDM/CritSects/PCNet#0/ContentionRZUnlock        4 times
09:09:49.961 /PDM/CritSects/PDM/ContentionR3         0 times
09:09:49.961 /PDM/CritSects/PDM/ContentionRZLock     4528 times
09:09:49.961 /PDM/CritSects/PDM/ContentionRZUnlock     1118 times
09:09:49.961 /PDM/CritSects/PGM/ContentionR3         0 times
09:09:49.961 /PDM/CritSects/PGM/ContentionRZLock      139 times
09:09:49.961 /PDM/CritSects/PGM/ContentionRZUnlock      283 times
09:09:49.961 /PGM/ChunkR3Map/c                    1984 times
09:09:49.961 /PGM/ChunkR3Map/cMax             4294967295 times
09:09:49.961 /PGM/Page/cAllPages                296141 times
09:09:49.961 /PGM/Page/cHandyPages                 115 times
09:09:49.961 /PGM/Page/cPrivatePages            296049 times
09:09:49.961 /PGM/Page/cSharedPages                  0 times
09:09:49.961 /PGM/Page/cZeroPages                   92 times
09:09:49.961 /PGM/cGuestModeChanges               2030 times
09:09:49.961 /PGM/cRelocations                       5 times
09:09:49.961 /PROF/EM/ForcedActions              16765 ticks/call ( 50636200536 ticks, 3020265 times, max 895499190, min     180)
09:09:49.961 /PROF/EM/Halted                  22531705 ticks/call (62840791222020 ticks, 2788994 times, max  67103298, min     225)
09:09:49.961 /PROF/EM/RAWTotal                  936973 ticks/call (2925820282716 ticks, 3122629 times, max 2396981628, min   29340)
09:09:49.961 /PROF/EM/REMTotal                  872773 ticks/call (111333656106 ticks,  127563 times, max 5845668993, min    2871)
09:09:49.961 /PROF/EM/Total                   65936828660148 ticks/call (65936828660148 ticks,       1 times, max 65936828660148, min 65936828660148)
09:09:49.961 /PROF/VM/Halt/Block               8351653 ticks/call (62722251277191 ticks, 7510160 times, max  60499179, min    2718)
09:09:49.961 /PROF/VM/Halt/Timers                 8664 ticks/call ( 90564173415 ticks, 10452923 times, max  17103555, min     765)
09:09:49.961 /PROF/VM/Halt/Yield                  8002 ticks/call (      144045 ticks,      18 times, max     17874, min    6183)
09:09:49.961 /REM/TbFlushCount                  107761 times
09:09:49.961 /REM/TbPhysInvldCount              211448 times
09:09:49.961 /REM/TlbFlushCount                 566495 times
09:09:49.961 /TM/GC/1nsSteps                    374968 times
09:09:49.961 /TM/R3/1nsSteps                   1239955 times
09:09:49.961 /TM/VirtualSync/CurrentOffset    500496055 ns
09:09:49.961 /TM/VirtualSync/GivenUp          497788073 ns
09:09:49.961 ********************* End of statistics **********************
09:09:50.032 Changing the VM state from 'DESTROYING' to 'TERMINATED'.
Post Reply