All pastes #1282042 Raw Edit

Something

public text v1 · immutable
#1282042 ·published 2008-12-10 22:19 UTC
rendered paste body
Nov 18 12:28:43.375: vmx| Log for VMware Workstation pid=4672 version=6.0.4 build=build-93057 option=Release
Nov 18 12:28:43.375: vmx| Hostname=TASWIN
Nov 18 12:28:43.375: vmx| Command line: "C:\Program Files\VMware\VMware Workstation\bin\vmware-vmx.exe" "-#" "name=VMware Workstation;version=6.0.4;licensename=VMware Workstation for Win32;licenseversion=6.0 build-93057;" "-@" "pipe=\\.\pipe\vmx534919f8c1500d3e;" "C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx"
Nov 18 12:28:43.390: vmx| UI Connecting to pipe '\\.\pipe\vmx534919f8c1500d3e' with user '(null)'
Nov 18 12:28:43.500: vmx| HD: host version is 5.1.2600
Nov 18 12:28:43.500: vmx| HD: addr 80509850
Nov 18 12:28:43.500: vmx| HD: 805620dc, 80554280
Nov 18 12:28:43.500: vmx| CPU #0 TSC = 7763143216224
Nov 18 12:28:43.500: vmx| CPU #1 TSC = 7763143216200
Nov 18 12:28:43.500: vmx| TSC delta 24
Nov 18 12:28:43.500: vmx| VMMon_GetkHzEstimate: Calculated 875700 kHz
Nov 18 12:28:43.500: vmx| Measured CPU as 875700 kHz, but OS says 2394000 kHz; using 2394000
Nov 18 12:28:43.500: vmx| Msg_Hint: msg.hostWin32.cpuSpeedMismatch (sent)
Nov 18 12:28:43.500: vmx| VMware Workstation has measured your CPU speed to be 875 MHz, but Windows reports that it is 2394 MHz. This may mean that your computer has a power-saving feature that varies the processor speed. As a result, the clock in your virtual machine may run too fast or too slow.
Nov 18 12:28:43.500: vmx| 
Nov 18 12:28:43.500: vmx| For a workaround, please refer to the VMware knowledge base article at:
Nov 18 12:28:43.500: vmx| http://www.vmware.com/info?id=97
Nov 18 12:28:43.500: vmx| ---------------------------------------
Nov 18 12:28:43.718: vmx| VMMon_RememberkHzEstimate: Calculated 2394000 kHz
Nov 18 12:28:43.718: vmx| CPUID[0] vendor: GenuntelineI
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000001, 0: 0x000006fb 0x00020800 0x0000e3bd 0xbfebfbff
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000004, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100000
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x54202020
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000004, 0: 0x30303737 0x20402020 0x30342e32 0x007a4847
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[0] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] vendor: GenuntelineI
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000001, 0: 0x000006fb 0x01020800 0x0000e3bd 0xbfebfbff
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000004, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100000
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x54202020
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000004, 0: 0x30303737 0x20402020 0x30342e32 0x007a4847
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID[1] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID vendor: GenuntelineI
Nov 18 12:28:43.718: vmx| hostCPUID level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Nov 18 12:28:43.718: vmx| hostCPUID level 00000001, 0: 0x000006fb 0x00020800 0x0000e3bd 0xbfebfbff
Nov 18 12:28:43.718: vmx| hostCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Nov 18 12:28:43.718: vmx| hostCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 00000004, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Nov 18 12:28:43.718: vmx| hostCPUID level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Nov 18 12:28:43.718: vmx| hostCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100000
Nov 18 12:28:43.718: vmx| hostCPUID level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Nov 18 12:28:43.718: vmx| hostCPUID level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x54202020
Nov 18 12:28:43.718: vmx| hostCPUID level 80000004, 0: 0x30303737 0x20402020 0x30342e32 0x007a4847
Nov 18 12:28:43.718: vmx| hostCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| hostCPUID level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Nov 18 12:28:43.718: vmx| CPUID Maximum Physical Address Bits supported across all CPUs : 36
Nov 18 12:28:43.765: vmx| Host ACPI: can't find SRAT
Nov 18 12:28:43.765: vmx| Host: SRAT tables not found in memory
Nov 18 12:28:43.781: vmx| ACL_InitCapabilities: current IPC thread
Nov 18 12:28:43.781: vmx| ACL_InitCapabilities: done
Nov 18 12:28:43.781: vmx| changing directory to C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\.
Nov 18 12:28:43.781: vmx| Config file: C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx
Nov 18 12:28:43.875: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Nov 18 12:28:43.906: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOn without reset
Nov 18 12:28:43.906: vmx| PowerOn
Nov 18 12:28:43.906: vmx| Host: WIN32 highest NUMA node 0
Nov 18 12:28:43.906: vmx| Host: WIN32 NUMA node 0, CPU mask 0x0000000000000003
Nov 18 12:28:43.906: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Nov 18 12:28:43.921: vmx| HOST Windows version 5.1, build 2600, platform 2, "Service Pack 3", SMP
Nov 18 12:28:43.921: vmx| DICT --- USER PREFERENCES
Nov 18 12:28:43.921: vmx| DICT       pref.eula.0.appName = VMware Workstation
Nov 18 12:28:43.921: vmx| DICT   pref.eula.0.buildNumber = 93057
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest0.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest0.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest0.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest1.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest1.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest1.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest2.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest2.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest2.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest3.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest3.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest3.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest4.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest4.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest4.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest5.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest5.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest5.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest6.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest6.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest6.user = 
Nov 18 12:28:43.921: vmx| DICT     pref.mruDest7.present = FALSE
Nov 18 12:28:43.921: vmx| DICT  pref.mruDest7.destString = 
Nov 18 12:28:43.921: vmx| DICT        pref.mruDest7.user = 
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS0.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS0.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS0.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS0.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS0.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS0.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS1.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS1.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS1.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS1.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS1.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS1.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS2.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS2.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS2.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS2.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS2.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS2.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS3.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS3.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS3.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS3.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS3.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS3.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS4.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS4.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS4.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS4.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS4.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS4.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS5.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS5.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS5.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS5.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS5.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS5.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS6.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS6.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS6.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS6.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS6.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS6.port = 0
Nov 18 12:28:43.921: vmx| DICT      pref.mruATS7.present = FALSE
Nov 18 12:28:43.921: vmx| DICT    pref.mruATS7.atsString = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS7.domain = 
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS7.user = 
Nov 18 12:28:43.921: vmx| DICT       pref.mruATS7.secure = FALSE
Nov 18 12:28:43.921: vmx| DICT         pref.mruATS7.port = 0
Nov 18 12:28:43.921: vmx| DICT       webUpdate.checkLast = 1226955612
Nov 18 12:28:43.921: vmx| DICT   pref.view.toolbars.list = _SEP_,POWER_OFF,SUSPEND,POWER_ON,RESET,SNAPSHOT,REVERT,SNAPSHOT_MANAGER,FAVORITES,QUICK_SWITCH,FULL_SCREEN,SUMMARY,APPLIANCE,CONSOLE,QUICK_MINIMIZE,FILE_EXIT,VPLAY_PLAY,VPLAY_RECORD,VPLAY_STOP
Nov 18 12:28:43.921: vmx| DICT pref.ws.openedObj0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj0.name = Home
Nov 18 12:28:43.921: vmx| DICT  pref.ws.openedObj.maxNum = 2
Nov 18 12:28:43.921: vmx| DICT       pref.placement.left = 27
Nov 18 12:28:43.921: vmx| DICT        pref.placement.top = -20
Nov 18 12:28:43.921: vmx| DICT      pref.placement.right = 1397
Nov 18 12:28:43.921: vmx| DICT     pref.placement.bottom = 972
Nov 18 12:28:43.921: vmx| DICT            pref.tip.index = 19
Nov 18 12:28:43.921: vmx| DICT webUpdate.lastCheck.status = done_updates
Nov 18 12:28:43.921: vmx| DICT  pref.fullscreen.autohide = TRUE
Nov 18 12:28:43.921: vmx| DICT    pref.autoFitFullScreen = fitHostToGuest
Nov 18 12:28:43.921: vmx| DICT      hint.leaveFullScreen = FALSE
Nov 18 12:28:43.921: vmx| DICT pref.fullscreen.toolbarPixels = 0
Nov 18 12:28:43.921: vmx| DICT          pref.view.navBar = TRUE
Nov 18 12:28:43.921: vmx| DICT              pref.autoFit = FALSE
Nov 18 12:28:43.921: vmx| DICT       pref.view.statusBar = FALSE
Nov 18 12:28:43.921: vmx| DICT            pref.view.tabs = FALSE
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.menu.position.ix = 0
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.menu.position.newLine = TRUE
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.menu.position.length = 0
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.power.position.ix = 1
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.power.position.length = 114
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.snapshot.position.ix = 2
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.snapshot.position.length = 75
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.position.ix = 3
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.position.length = 158
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.vplay.position.ix = 4
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.vplay.position.length = 75
Nov 18 12:28:43.921: vmx| DICT   pref.ws.currentObj.path = 
Nov 18 12:28:43.921: vmx| DICT   pref.ws.currentObj.type = home
Nov 18 12:28:43.921: vmx| DICT pref.ws.openedObj1.present = TRUE
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj1.name = Ubuntu 8.04
Nov 18 12:28:43.921: vmx| DICT pref.ws.openedObj2.present = TRUE
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj2.type = vm
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj2.path = /vm/#534919f8c1500d3e/
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj2.file = C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj2.name = Ubuntu 8.04
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj1.type = vm
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj1.path = /vm/#534919f8c1500d3e/
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj1.file = C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.items.count = 7
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item0.id = FAVORITES
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item1.id = QUICK_SWITCH
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item2.id = FULL_SCREEN
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item3.id = _SEP_
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item4.id = SUMMARY
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item5.id = APPLIANCE
Nov 18 12:28:43.921: vmx| DICT pref.view.toolbars.view.1.item6.id = CONSOLE
Nov 18 12:28:43.921: vmx| DICT             hints.hideAll = TRUE
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj3.type = vm
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj3.path = /vm/#534919f8c1500d3e/
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj3.file = C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx
Nov 18 12:28:43.921: vmx| DICT   pref.ws.openedObj3.name = Ubuntu 8.04
Nov 18 12:28:43.921: vmx| DICT pref.enableAllSharedFolders = TRUE
Nov 18 12:28:43.921: vmx| DICT pref.autoFitGuestToWindow = FALSE
Nov 18 12:28:43.921: vmx| DICT --- USER DEFAULTS
Nov 18 12:28:43.921: vmx| DICT --- HOST DEFAULTS
Nov 18 12:28:43.921: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Nov 18 12:28:43.921: vmx| DICT --- SITE DEFAULTS
Nov 18 12:28:43.921: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Nov 18 12:28:43.921: vmx| DICT --- COMMAND LINE
Nov 18 12:28:43.921: vmx| DICT             gui.available = TRUE
Nov 18 12:28:43.921: vmx| DICT --- CONFIGURATION
Nov 18 12:28:43.921: vmx| DICT            config.version = 8
Nov 18 12:28:43.921: vmx| DICT         virtualHW.version = 6
Nov 18 12:28:43.921: vmx| DICT             scsi0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT          scsi0.virtualDev = lsilogic
Nov 18 12:28:43.921: vmx| DICT                   memsize = 512
Nov 18 12:28:43.921: vmx| DICT           scsi0:0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT          scsi0:0.fileName = Ubuntu.vmdk
Nov 18 12:28:43.921: vmx| DICT            ide1:0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT           ide1:0.fileName = auto detect
Nov 18 12:28:43.921: vmx| DICT         ide1:0.deviceType = cdrom-raw
Nov 18 12:28:43.921: vmx| DICT        floppy0.autodetect = TRUE
Nov 18 12:28:43.921: vmx| DICT         ethernet0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT   ethernet0.wakeOnPcktRcv = FALSE
Nov 18 12:28:43.921: vmx| DICT               usb.present = TRUE
Nov 18 12:28:43.921: vmx| DICT              ehci.present = TRUE
Nov 18 12:28:43.921: vmx| DICT             sound.present = TRUE
Nov 18 12:28:43.921: vmx| DICT            sound.fileName = -1
Nov 18 12:28:43.921: vmx| DICT          sound.autodetect = TRUE
Nov 18 12:28:43.921: vmx| DICT           svga.autodetect = TRUE
Nov 18 12:28:43.921: vmx| DICT        pciBridge0.present = TRUE
Nov 18 12:28:43.921: vmx| DICT        mks.keyboardFilter = allow
Nov 18 12:28:43.921: vmx| DICT               displayName = Ubuntu 8.04
Nov 18 12:28:43.921: vmx| DICT                   guestOS = ubuntu
Nov 18 12:28:43.921: vmx| DICT                     nvram = Ubuntu.nvram
Nov 18 12:28:43.921: vmx| DICT        deploymentPlatform = windows
Nov 18 12:28:43.921: vmx| DICT virtualHW.productCompatibility = hosted
Nov 18 12:28:43.921: vmx| DICT      tools.upgrade.policy = useGlobal
Nov 18 12:28:43.921: vmx| DICT         ide1:0.autodetect = TRUE
Nov 18 12:28:43.921: vmx| DICT          floppy0.fileName = A:
Nov 18 12:28:43.921: vmx| DICT        extendedConfigFile = Ubuntu.vmxf
Nov 18 12:28:43.921: vmx| DICT     ide1:0.startConnected = TRUE
Nov 18 12:28:43.921: vmx| DICT     ethernet0.addressType = generated
Nov 18 12:28:43.921: vmx| DICT             uuid.location = 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:43.921: vmx| DICT                 uuid.bios = 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:43.921: vmx| DICT              scsi0:0.redo = 
Nov 18 12:28:43.921: vmx| DICT  pciBridge0.pciSlotNumber = 17
Nov 18 12:28:43.921: vmx| DICT       scsi0.pciSlotNumber = 16
Nov 18 12:28:43.921: vmx| DICT   ethernet0.pciSlotNumber = 32
Nov 18 12:28:43.921: vmx| DICT       sound.pciSlotNumber = 33
Nov 18 12:28:43.921: vmx| DICT        ehci.pciSlotNumber = 34
Nov 18 12:28:43.921: vmx| DICT ethernet0.generatedAddress = 00:0c:29:8d:3f:3d
Nov 18 12:28:43.921: vmx| DICT ethernet0.generatedAddressOffset = 0
Nov 18 12:28:43.921: vmx| DICT            tools.syncTime = FALSE
Nov 18 12:28:43.921: vmx| DICT  ethernet0.connectionType = nat
Nov 18 12:28:43.921: vmx| DICT        checkpoint.vmState = 
Nov 18 12:28:43.921: vmx| DICT       tools.remindInstall = TRUE
Nov 18 12:28:43.921: vmx| DICT    floppy0.startConnected = FALSE
Nov 18 12:28:43.921: vmx| DICT --- USER DEFAULTS
Nov 18 12:28:43.921: vmx| DICT --- HOST DEFAULTS
Nov 18 12:28:43.921: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Nov 18 12:28:43.921: vmx| DICT --- SITE DEFAULTS
Nov 18 12:28:43.921: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Nov 18 12:28:43.921: vmx| DICT --- GLOBAL SETTINGS
Nov 18 12:28:43.937: vmx| hostCpuFeatures = 0x500001fa
Nov 18 12:28:43.937: vmx| hostNumPerfCounters = 2
Nov 18 12:28:43.953: vmx| Host display topology 1400x1050.
Nov 18 12:28:43.953: vmx| SVGA using 2360x1770.
Nov 18 12:28:43.953: vmx| WSSCAN: reserved mem (in MB) min=32 max=2944 recommended=2944
Nov 18 12:28:43.953: vmx|         hostMem=3072 maxAllowedAll=-1 maxAllowedVM=8192
Nov 18 12:28:43.953: vmx|         totOverhead=16
Nov 18 12:28:43.953: vmx| WSSCAN: used rec mem (in MB) 2944
Nov 18 12:28:43.953: vmx| WSSCAN: Overhead 139069 paged 6585 nonpaged 4096 maxFBSize
Nov 18 12:28:43.953: vmx| WSSCAN 1 1 622551 691344 753664 622551 50 0
Nov 18 12:28:43.953: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Workstation\License.ws.6.0.200907' 
Nov 18 12:28:44.015: vmx| LOG failed to remove stats32-2 failed: The system cannot find the file specified
Nov 18 12:28:44.015: vmx| LOG failed to remove stats64-2 failed: The system cannot find the file specified
Nov 18 12:28:44.062: vmx| guestCpuFeatures = 0x500001f0
Nov 18 12:28:44.062: vmx| APIC: Host Local APIC at 0xfee00000
Nov 18 12:28:44.078: vmx| vmm32-modules: [vmm.vmm32 .data:0x2b000 .sdata:0x2c000 .statvars:0x2d000 .peer:0x2e000 .shared:0x54000 .bss:0x65000 .rodata:0x6c000 .text:0x78000 .kstatvars:0x3000 ,mmu-pae.vmm32 .rodata:0x76dcc .data:0x2bdb0 .peer:0x5293c .shared:0x63a4d .bss:0x6abc0 .text:0xcb584 .comment:0x40000cf0 .statvars:0x2000 .kstatvars:0x2000 .scb:0x400035a0 .shared_meta:0x40003480 .peer_meta:0x40000bd0 ,sharedmmu-none.vmm32 .text:0xd5504 .comment:0x40000dec ,pv-none.vmm32 .data:0x2bdcc .peer:0x1000 .shared:0x6435d .bss:0x6b120 .text:0xd552c .comment:0x40000dfe .statvars:0x1000 .kstatvars:0x1000 .shared_meta:0x400036f0 ,hv-none.vmm32 .data:0x2bdd0 .peer:0x1000 .shared:0x1000 .bss:0x6b1a4 .text:0xd5634 .comment:0x40000e46 .statvars:0x1000 .kstatvars:0x1000 ,<MonSrcFile> .rodata:0x76ddc ]
Nov 18 12:28:44.078: vmx| KHZEstimate 2394000
Nov 18 12:28:44.078: vmx| MHZEstimate 2394
Nov 18 12:28:44.078: vmx| NumVCPUs 1
Nov 18 12:28:44.078: vmx| guestCPUID vendor: GenuntelineI
Nov 18 12:28:44.078: vmx| guestCPUID level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Nov 18 12:28:44.078: vmx| guestCPUID level 00000001, 0: 0x000006f8 0x00010800 0x00000211 0x0febfbff
Nov 18 12:28:44.078: vmx| guestCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Nov 18 12:28:44.078: vmx| guestCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 00000004, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Nov 18 12:28:44.078: vmx| guestCPUID level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Nov 18 12:28:44.078: vmx| guestCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100800
Nov 18 12:28:44.078: vmx| guestCPUID level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Nov 18 12:28:44.078: vmx| guestCPUID level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x54202020
Nov 18 12:28:44.078: vmx| guestCPUID level 80000004, 0: 0x30303737 0x20402020 0x30342e32 0x007a4847
Nov 18 12:28:44.078: vmx| guestCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| guestCPUID level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Nov 18 12:28:44.078: vmx| PShare: enabled 1, scanRate 32, checkRate 16
Nov 18 12:28:44.078: vmx| UUID: location-UUID is 56 4d 4b e7 2c 87 5d 48-23 15 53 8e 71 e8 14 5b
Nov 18 12:28:44.078: vmx| UUID: canonical path is c:\documents and settings\thinkpad2\my documents\my virtual machines\ubuntu 8.04\ubuntu.vmx
Nov 18 12:28:44.078: vmx| UUID: location-UUID is 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:44.078: vmx| UUID: canonical path is c:\documents and settings\thinkpad2\my documents\my virtual machines\ubuntu 8.04\ubuntu.vmx
Nov 18 12:28:44.078: vmx| UUID: location-UUID is 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:44.078: vmx| WORKER: Creating new group with numThreads=18 (18)
Nov 18 12:28:44.078: vmx| MM: Using partialmap, 131072 pages AC 0 CE 1 TM 0 DOHU 0
Nov 18 12:28:44.078: vmx| UUID: canonical path is c:\documents and settings\thinkpad2\my documents\my virtual machines\ubuntu 8.04\ubuntu.vmx
Nov 18 12:28:44.078: vmx| UUID: location-UUID is 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:44.093: vmx| FILE: ScanDirectory discarding file 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\564da852-512e-da8e-4113-827b2b8d3f3d.vmem.lck\M55006.lck'; invalid executionID.
Nov 18 12:28:44.093: vmx| MM: using 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\564da852-512e-da8e-4113-827b2b8d3f3d.vmem' as a paging file
Nov 18 12:28:44.093: vmx| Msg_Reset:
Nov 18 12:28:44.093: vmx| ----------------------------------------
Nov 18 12:28:44.093: vmx| Opened paging file C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\564da852-512e-da8e-4113-827b2b8d3f3d.vmem
Nov 18 12:28:44.093: vmx| Mapped mainmem as pageable
Nov 18 12:28:44.093: vmx| MStat: Creating Stat vm.uptime
Nov 18 12:28:44.093: vmx| MStat: Creating Stat vm.suspendTime
Nov 18 12:28:44.093: vmx| MStat: Creating Stat vm.powerOnTimeStamp
Nov 18 12:28:44.109: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Nov 18 12:28:44.109: vmx| DISK: OPEN scsi0:0 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk' persistent R[(null)]
Nov 18 12:28:44.125: vmx| FILE: ScanDirectory discarding file 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk.lck\M00381.lck'; invalid executionID.
Nov 18 12:28:44.125: vmx| DISKLIB-DSCPTR: Opened [0]: "Ubuntu-flat.vmdk" 0 (0xa)
Nov 18 12:28:44.125: vmx| DISKLIB-LINK  : Opened 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk' (0xa): monolithicFlat, 73400320 sectors / 35840 Mb.
Nov 18 12:28:44.125: vmx| DISKLIB-LIB   : Opened "C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk" (flags 0xa). 1521A24
Nov 18 12:28:44.125: vmx| DiskGetGeometry: Reading of disk partition table
Nov 18 12:28:44.156: vmx| DISK: OPEN 'C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk' Geo (4568/255/63) BIOS Geo (4568/255/63) freeSpace=59394Mb, lsilogic
Nov 18 12:28:44.156: vmx| Msg_Reset:
Nov 18 12:28:44.156: vmx| ----------------------------------------
Nov 18 12:28:44.156: vmx| TimeTracker host to guest rate conversion 7764440481540 @ 2394000000Hz -> 7764440481540 @ 2394000000Hz
Nov 18 12:28:44.156: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0
Nov 18 12:28:44.156: vmx| USB: Initializing 'Generic' backend
Nov 18 12:28:44.156: vmx| USBGW: Connected to HCMON version 2.3
Nov 18 12:28:44.156: vmx| USBGW: Skipping disk backing for file (C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmx).
Nov 18 12:28:44.156: vmx| USBGW: Skipping disk backing for file (C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmdk).
Nov 18 12:28:44.171: vmx| USBGW: Skipping disk backing for file (C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.vmsd).
Nov 18 12:28:44.171: vmx| USBGW: Skipping disk backing for file (C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\Ubuntu.nvram).
Nov 18 12:28:44.187: vmx| USB: Initializing 'Virtual Hub' backend
Nov 18 12:28:44.187: vmx| USB: Initializing 'Virtual Mouse' backend
Nov 18 12:28:44.234: vmx| Host display topology 1400x1050.
Nov 18 12:28:44.234: vmx| SVGA using 2360x1770.
Nov 18 12:28:44.234: vmx| MKS REMOTE Loading VNC Configuration from VM config file
Nov 18 12:28:44.234: vmx| Host display topology 1400x1050 with 1 displays.
Nov 18 12:28:44.234: vmx| SVGA using 2360x1770.
Nov 18 12:28:44.234: vmx| DISKUTIL: scsi0:0 : capacity=73400320
Nov 18 12:28:44.234: vmx| DISKUTIL: scsi0:0 : geometry=4568/255/63
Nov 18 12:28:44.234: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags.
Nov 18 12:28:44.234: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks
Nov 18 12:28:44.234: vmx| Ethernet0 MAC Address: 00:0c:29:8d:3f:3d
Nov 18 12:28:44.234: vmx| VMXNET: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks, dontClusterSize is 128
Nov 18 12:28:44.234: vmx| E1000: checksum cycles/kB: C=1028 asm=733
Nov 18 12:28:44.234: vmx| USB: Initializing 'UHCI' host controller
Nov 18 12:28:44.234: vmx| USB: Initializing 'EHCI' host controller
Nov 18 12:28:44.234: vmx| MStat: Creating Stat vm.heartbeat
Nov 18 12:28:44.234: vmx| DISKUTIL: scsi0:0 : toolsVersion = 0
Nov 18 12:28:44.234: vmx| DISKUTIL: Offline toolsVersion = 0
Nov 18 12:28:44.234: vmx| Msg_Hint: msg.tools.toolsReminder (sent)
Nov 18 12:28:44.234: vmx| Do not forget to install the VMware Tools package inside this virtual machine: wait until your guest operating system finishes booting, then choose VM > Install VMware Tools… and follow the instructions.
Nov 18 12:28:44.234: vmx| 
Nov 18 12:28:44.234: vmx| ---------------------------------------
Nov 18 12:28:44.250: vmx| TOOLS INSTALL initializing state to IDLE on power on.
Nov 18 12:28:44.250: vmx| PTSC to VMI Wallclock (nsec) 7764666834780 @ 2394000000Hz -> 1227040124000000000 @ 1000000000Hz
Nov 18 12:28:44.250: vmx| PTSC to VMI Wallclock (nsec) ((x * 3588109687) >> 33) + 1227036880613686891
Nov 18 12:28:44.250: vmx| VirtualProtect MapProtectMem(0x1a10000,0x1000) returns 0x1e7
Nov 18 12:28:44.250: vmx| VirtualProtect MapProtectMem(0x1a12000,0x0) returns 0x57
Nov 18 12:28:44.250: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '1'
Nov 18 12:28:44.250: vmx| TOOLS received request in VMX to set option 'copypaste' -> '1'
Nov 18 12:28:44.265: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1
Nov 18 12:28:44.265: vmx| VMX setting maximum IPC write buffers to 0 packets, 0 bytes
Nov 18 12:28:44.265: mks| Async MKS thread is alive
Nov 18 12:28:44.265: vmx| DnD rpc already set to 1
Nov 18 12:28:44.265: vmx| DnD CopyPasteRegisterRpc already set to 1
Nov 18 12:28:44.265: vcpu-0| APIC: version = 0x14, max LVT = 5
Nov 18 12:28:44.265: vcpu-0| APIC: LDR = 0x1000000, DFR = 0xffffffff
Nov 18 12:28:44.281: vcpu-0| guestCpuFeatures = 0x500001f0
Nov 18 12:28:44.281: vcpu-0| Init modules.
Nov 18 12:28:44.281: vcpu-0| CPU reset: hard
Nov 18 12:28:44.312: vmx| SOUND 000.930228 ES1371Win32GetSelected mixerGetControlDetails error 11
Nov 18 12:28:44.312: vmx| VNET: Notification enabled for Ethernet0
Nov 18 12:28:44.312: vmx| CDROM: Using autodetect backend F: for ide1:0.
Nov 18 12:28:44.312: vmx| CDROM: Connecting ide1:0 to 'F:'. img=0 raw=1 excl=0 remote=0
Nov 18 12:28:44.343: vcpu-0| sz=3047392
Nov 18 12:28:44.343: vcpu-0| vmm32 initialized: Releasebuild-93057. cflags: 0x00000002.09000002.a000070c.00000006
Nov 18 12:28:44.359: vcpu-0| MonitorInitNumaUnmapVMM32
Nov 18 12:28:44.390: mks| Connecting to window system.
Nov 18 12:28:44.390: mks| KHBKL: Unable to parse keystring at: ''
Nov 18 12:28:44.406: mks| Ignoring update request in VGA_Expose (mode change pending).
Nov 18 12:28:44.406: mks| VMXAIOMGR: Disallowing USB connect.  1025584 us since last reopen
Nov 18 12:28:44.437: mks| Ignoring update request in VGA_Expose (mode change pending).
Nov 18 12:28:44.671: mks| VMXAIOMGR: Disallowing USB connect.  1294351 us since last reopen
Nov 18 12:28:44.734: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0x0) and 0xe8000000(0x0)
Nov 18 12:28:44.750: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:28:44.765: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:28:44.781: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:28:44.781: vcpu-0| SVGA: Registering IOSpace at 0x1400
Nov 18 12:28:44.781: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:28:45.125: vcpu-0| CDROM-WIN: 'F:' Length 24 MaxTransferLength 131072 MaxPhysPages 17
Nov 18 12:28:45.125: vcpu-0| CDROM-WIN: AlignMask 0x0 !AsyncEvent !TaggedQ ScanUp PIO
Nov 18 12:28:45.140: vcpu-0| DISKUTIL: scsi0:0 : geometry=4568/255/63
Nov 18 12:28:45.187: vcpu-0| BIOS-UUID is 56 4d a8 52 51 2e da 8e-41 13 82 7b 2b 8d 3f 3d
Nov 18 12:28:45.328: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 0
Nov 18 12:28:45.328: vcpu-0| DISKUTIL: Offline toolsVersion = 0
Nov 18 12:28:47.359: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 18 12:28:47.359: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 12:28:53.781: vmx| PTSC slow TSC 0.5555
Nov 18 12:28:53.781: vmx| PTSC TSC 7782132012612 - 7775439807312, 2394 MHz
Nov 18 12:28:53.781: vmx| PTSC PC  41599202430 - 41581192320, 3579 kHz
Nov 18 12:28:53.781: vmx| PTSC using fake TSC
Nov 18 12:28:53.781: vmx| PTSC 41599202841 @ 3579545Hz -> 7782132287220 @ 2394000000Hz
Nov 18 12:28:53.781: vmx| PTSC ((x * 2805150871) >> 22) + -20039418101673
Nov 18 12:28:55.000: mks| SVGA: Remote display status changed, enabling local optimizations
Nov 18 12:28:57.234: vcpu-0| Unknown int 10h func 0x0000
Nov 18 12:28:59.453: vcpu-0| SVGA: Unregistering IOSpace at 0x1400
Nov 18 12:28:59.453: vcpu-0| SVGA: Registering IOSpace at 0xfffffff0
Nov 18 12:28:59.453: vcpu-0| SVGA: Unregistering IOSpace at 0xfffffff0
Nov 18 12:28:59.453: vcpu-0| SVGA: Registering IOSpace at 0x1400
Nov 18 12:29:00.375: vcpu-0| UHCI: HCReset
Nov 18 12:29:03.468: vcpu-0| BM-VIDE: Access to busmaster registers w/o busmaster enabled
Nov 18 12:29:03.468: vcpu-0| BM-VIDE: Access to busmaster registers w/o busmaster enabled
Nov 18 12:29:04.484: vcpu-0| UHCI: HCReset
Nov 18 12:29:04.984: vcpu-0| SCSI0: RESET BUS
Nov 18 12:29:05.046: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0
Nov 18 12:29:05.046: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x8
Nov 18 12:29:05.046: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0
Nov 18 12:29:05.046: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x8
Nov 18 12:29:05.109: vcpu-0| SCSI DEVICE (scsi0:0): INQUIRY request with EVPD set
Nov 18 12:29:05.390: vmx| VIDE CDROM: Emulating Inquiry response on raw drive
Nov 18 12:29:55.343: vcpu-0| SCSI DEVICE (scsi0:0): INQUIRY request with EVPD set
Nov 18 12:29:55.359: vmx| VIDE CDROM: Emulating Inquiry response on raw drive
Nov 18 12:29:57.437: vcpu-0| VLANCE: Returning 0x0 for LANCE_EXTINT IN
Nov 18 12:29:57.437: vcpu-0| VLANCE: Ignoring LANCE_EXTINT OUT of 0x1
Nov 18 12:29:57.640: vcpu-0| VLANCE: IN on LANCE_MODE while not stopped: 0x73
Nov 18 12:29:57.640: vcpu-0| VLANCE: OUT on LANCE_PADR2 while not stopped: 0x73, word: 0x0
Nov 18 12:29:57.640: vcpu-0| VLANCE: OUT on LANCE_LADRF0 while not stopped: 0x73, word: 0x0
Nov 18 12:29:57.640: vcpu-0| VLANCE: OUT on LANCE_LADRF1 while not stopped: 0x73, word: 0x0
Nov 18 12:29:57.640: vcpu-0| VLANCE: OUT on LANCE_LADRF2 while not stopped: 0x73, word: 0x0
Nov 18 12:29:57.640: vcpu-0| VLANCE: OUT on LANCE_LADRF3 while not stopped: 0x73, word: 0x0
Nov 18 12:29:59.953: vcpu-0| SOUND 076.569833 ES1371Win32SetSelected mixerGetControlDetails error 11
Nov 18 12:30:10.296: mks| HostOps hideCursor before defineCursor!
Nov 18 12:30:10.812: vcpu-0| SVGA: Unregistering IOSpace at 0x1400
Nov 18 12:30:10.812: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:30:10.828: vcpu-0| SVGA: Registering IOSpace at 0x1400
Nov 18 12:30:10.828: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Nov 18 12:30:11.078: vcpu-0| Guest OS = 0x5008
Nov 18 12:30:11.078: mks| HostOps hideCursor before defineCursor!
Nov 18 12:30:11.531: vcpu-0| VMMouse: CMD Read ID
Nov 18 12:30:11.531: vcpu-0| VMMouse: CMD Disable
Nov 18 12:30:11.531: vcpu-0| VMMouse: Disabling VMMouse mode
Nov 18 12:30:12.828: vcpu-0| VMMouse: CMD Read ID
Nov 18 12:30:12.828: vcpu-0| MKS switching absolute mouse on
Nov 18 12:34:46.140: vmx| SOCKET 2 client closed connection
Nov 18 12:36:10.437: vmx| SCSI0:0: Command READ(10) took 1.138 seconds (ok)
Nov 18 12:38:44.234: vmx| TOOLS setting the tools version to '0'
Nov 18 13:34:22.000: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 18 17:26:11.640: vmx| DISKLIB-LIB   :numIOs = 50000 numMergedIOs = 0 numSplitIOs = 0
Nov 18 18:26:39.750: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 18 18:26:39.750: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:26:39.750: vmx| USB: Found device [name:Logitech\ USB\ Device vid:046d pid:09c1 path:1/6/1 speed:high family:other]
Nov 18 18:30:24.828: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 18 18:30:24.828: vmx| USB: Found device [name:Logitech\ USB\ Device vid:046d pid:09c1 path:1/3/1 speed:full family:other]
Nov 18 18:30:24.828: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:30:30.625: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 18 18:30:30.625: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:30:33.453: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 18 18:30:33.453: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:30:33.453: vmx| USB: Found device [name:Logitech\ USB\ Device vid:046d pid:09c1 path:1/6/1 speed:high family:other]
Nov 18 18:32:14.515: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 18 18:32:14.515: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:32:23.562: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 18 18:32:23.562: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:32:23.562: vmx| USB: Found device [name:Logitech\ USB\ Device vid:046d pid:09c1 path:1/6/1 speed:high family:other]
Nov 18 18:32:45.515: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 18 18:32:45.515: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:32:56.562: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 18 18:32:56.562: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 18 18:32:56.562: vmx| USB: Found device [name:Logitech\ USB\ Device vid:046d pid:09c1 path:1/6/1 speed:high family:other]
Nov 18 21:18:07.718: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [166->166]
Nov 19 01:04:07.093: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 19 01:04:07.093: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 19 01:27:20.375: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 01:27:20.375: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 01:27:20.375: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 10:03:01.046: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:12:16.718: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 19 10:12:16.718: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 19 10:16:11.296: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 19 10:16:11.296: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 10:19:30.265: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:06:08.265: vmx| DISK: DISK/CDROM timeout of 31509.214 seconds on ide1:0 (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.046 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.046 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.046 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.046 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.046 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.047 seconds (ok)
Nov 19 19:06:34.531: vmx| SCSI0:0: Command WRITE(10) took 1.047 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.234 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.234 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.235 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.235 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.236 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.236 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.236 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.236 seconds (ok)
Nov 19 19:06:34.718: vmx| SCSI0:0: Command WRITE(10) took 1.240 seconds (ok)
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 1 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 2 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 1 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 3 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 2 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 4 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 3 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 5 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 4 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: Ethernet0 skipped 6 time(s)
Nov 19 19:06:48.919: vcpu-0| VLANCE: 5 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:48.919: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: Ethernet0 skipped 7 time(s)
Nov 19 19:06:49.091: vcpu-0| VLANCE: 6 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: Ethernet0 skipped 8 time(s)
Nov 19 19:06:49.091: vcpu-0| VLANCE: 6 1 0 0 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: Ethernet0 skipped 9 time(s)
Nov 19 19:06:49.091: vcpu-0| VLANCE: 6 1 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 19 19:06:49.091: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 19 19:18:29.373: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:19:18.935: vmx| SCSI0:0: Command WRITE(10) took 1.002 seconds (ok)
Nov 19 19:21:21.607: vmx| SCSI0:0: Command WRITE(10) took 4.981 seconds (ok)
Nov 19 19:21:21.607: vmx| SCSI0:0: Command WRITE(10) took 3.713 seconds (ok)
Nov 19 19:22:32.013: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 19 19:22:50.232: vmx| SCSI0:0: Command WRITE(10) took 11.500 seconds (ok)
Nov 19 19:39:50.748: vmx| SCSI0:0: Command READ(10) took 1.130 seconds (ok)
Nov 19 19:39:50.748: vmx| SCSI0:0: Command READ(10) took 2.718 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 3.621 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.623 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.624 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.624 seconds (ok)
Nov 19 20:33:43.434: vmx| SCSI0:0: Command WRITE(10) took 8.621 seconds (ok)
Nov 20 08:41:34.234: vcpu-0| VLANCE: Ethernet0 skipped 10 time(s)
Nov 20 08:41:34.234: vcpu-0| VLANCE: 7 1 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 08:41:34.234: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 08:41:34.234: vcpu-0| VLANCE: Ethernet0 skipped 11 time(s)
Nov 20 08:41:34.234: vcpu-0| VLANCE: 7 2 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 08:41:34.234: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 08:41:34.921: vmx| VMXVmdbLoadUsbDevices: New set of 0 USB devices
Nov 20 08:41:41.578: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 08:41:41.578: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:42:40.406: vmx| SCSI0:0: Command WRITE(10) took 1.190 seconds (ok)
Nov 20 08:42:42.609: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 08:42:42.609: vmx| USB: Found device [name:Research\ In\ Motion\ USB\ Device vid:0fca pid:0001 path:1/3/1 speed:full family:vendor]
Nov 20 08:42:42.609: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:43:03.531: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 08:43:03.531: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:45:43.328: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 08:45:43.328: vmx| USB: Found device [name:Research\ In\ Motion\ USB\ Device vid:0fca pid:0001 path:1/3/1 speed:full family:vendor]
Nov 20 08:45:43.328: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:45:46.265: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 08:45:46.265: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:45:55.421: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 08:45:55.421: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/1 speed:full family:vendor,storage]
Nov 20 08:45:55.421: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:48:50.796: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 08:48:50.796: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:48:54.000: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 08:48:54.000: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/1 speed:full family:vendor,storage]
Nov 20 08:48:54.000: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 08:49:28.468: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 08:52:59.500: vmx| DISKLIB-LIB   :numIOs = 100000 numMergedIOs = 0 numSplitIOs = 0
Nov 20 08:58:28.250: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 09:08:51.078: vmx| SCSI0:0: Command WRITE(10) took 3.001 seconds (ok)
Nov 20 09:24:22.109: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 09:24:22.109: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 09:24:22.109: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 10:01:11.671: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 10:01:11.671: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 11:41:34.234: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Workstation\License.ws.6.0.200907' 
Nov 20 15:21:31.406: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 15:58:20.421: vmx| SCSI0:0: Command WRITE(10) took 2.999 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.001 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.002 seconds (ok)
Nov 20 15:58:28.625: vmx| SCSI0:0: Command WRITE(10) took 6.003 seconds (ok)
Nov 20 15:59:45.765: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 20 16:10:25.187: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 20 16:10:25.187: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 20 16:10:25.187: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 20 16:12:03.515: vmx| SCSI0:0: Command READ(10) took 1.109 seconds (ok)
Nov 20 16:12:03.515: vmx| SCSI0:0: Command READ(10) took 1.109 seconds (ok)
Nov 20 16:12:03.515: vmx| SCSI0:0: Command READ(10) took 1.110 seconds (ok)
Nov 20 16:12:03.515: vmx| SCSI0:0: Command READ(10) took 1.110 seconds (ok)
Nov 20 16:12:03.515: vmx| SCSI0:0: Command READ(10) took 1.112 seconds (ok)
Nov 20 16:36:15.890: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 20 16:36:15.890: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 20 16:36:19.718: vmx| SCSI0:0: Command READ(10) took 1.035 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 16:36:46.484: vmx| SCSI0:0: Command WRITE(10) took 4.501 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.228 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.229 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.229 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.229 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.229 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.229 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.230 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.230 seconds (ok)
Nov 20 17:09:29.828: vmx| SCSI0:0: Command WRITE(10) took 3.226 seconds (ok)
Nov 20 19:22:34.375: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 19:22:34.375: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/1 speed:full family:vendor,storage]
Nov 20 19:22:34.375: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 19:22:39.109: usbEnum| USBGW: Autoconnecting e30000010fca0004
Nov 20 19:22:39.109: usbEnum| USB: Automatically connecting virtual hub
Nov 20 19:22:39.109: usbEnum| USB: Connecting device 0xc00000010e0f0002
Nov 20 19:22:39.125: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 20 19:22:39.125: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/1 speed:full family:vendor,storage]
Nov 20 19:22:39.125: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 19:24:38.265: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [312->312]
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.482 seconds (ok)
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.483 seconds (ok)
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.483 seconds (ok)
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.483 seconds (ok)
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.483 seconds (ok)
Nov 20 19:39:29.218: vmx| SCSI0:0: Command WRITE(10) took 1.483 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 20:07:20.531: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 20 20:12:53.218: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [366->366]
Nov 20 20:32:05.906: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [376->376]
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.502 seconds (ok)
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.502 seconds (ok)
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.502 seconds (ok)
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:41:30.015: vmx| SCSI0:0: Command WRITE(10) took 1.503 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.506 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.505 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.507 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.510 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.512 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.512 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.514 seconds (ok)
Nov 20 20:41:30.031: vmx| SCSI0:0: Command WRITE(10) took 1.514 seconds (ok)
Nov 20 20:41:30.140: vmx| SCSI0:0: Command WRITE(10) took 1.618 seconds (ok)
Nov 20 20:41:30.156: vmx| SCSI0:0: Command WRITE(10) took 1.635 seconds (ok)
Nov 20 20:41:37.687: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [382->382]
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.002 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.002 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.002 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.002 seconds (ok)
Nov 20 20:44:30.375: vmx| SCSI0:0: Command WRITE(10) took 2.002 seconds (ok)
Nov 20 21:10:21.843: usbEnum| USB: Disconnecting device 0xe30000010fca0004
Nov 20 21:10:24.250: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 20 21:10:24.250: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 20 22:22:42.593: vmx| VLANCE: Ethernet0 skipped 12 time(s)
Nov 20 22:22:42.593: vmx| VLANCE: 8 2 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 22:22:42.593: vmx| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 22:22:42.593: vcpu-0| VLANCE: Ethernet0 skipped 13 time(s)
Nov 20 22:22:42.593: vcpu-0| VLANCE: 8 3 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 22:22:42.593: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 22:54:51.812: vcpu-0| VLANCE: Ethernet0 skipped 14 time(s)
Nov 20 22:54:51.812: vcpu-0| VLANCE: 9 3 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 22:54:51.812: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 22:54:51.812: vcpu-0| VLANCE: Ethernet0 skipped 15 time(s)
Nov 20 22:54:51.812: vcpu-0| VLANCE: 9 4 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 22:54:51.812: vcpu-0| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 22:56:11.875: vmx| SCSI0:0: Command WRITE(10) took 4.362 seconds (ok)
Nov 20 22:56:11.875: vmx| SCSI0:0: Command WRITE(10) took 4.362 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.365 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.366 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:11.890: vmx| SCSI0:0: Command WRITE(10) took 4.367 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:30.281: vmx| SCSI0:0: Command WRITE(10) took 1.028 seconds (ok)
Nov 20 22:56:49.218: vmx| SCSI0:0: Command WRITE(10) took 10.000 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.022 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.023 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.023 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.025 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.024 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.024 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.017 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.017 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.008 seconds (ok)
Nov 20 23:19:51.687: vmx| SCSI0:0: Command WRITE(10) took 1.008 seconds (ok)
Nov 20 23:20:38.406: vmx| VLANCE: Ethernet0 skipped 16 time(s)
Nov 20 23:20:38.406: vmx| VLANCE: 10 4 0 1 0 1 0 0 0 0 0 0 0 0 0 0
Nov 20 23:20:38.406: vmx| VLANCE: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Nov 20 23:22:08.515: vmx| SCSI0:0: Command WRITE(10) took 3.500 seconds (ok)
Nov 20 23:22:08.515: vmx| SCSI0:0: Command WRITE(10) took 3.503 seconds (ok)
Nov 20 23:22:08.531: vmx| SCSI0:0: Command WRITE(10) took 3.505 seconds (ok)
Nov 20 23:22:39.000: vmx| SCSI0:0: Command READ(10) took 2.119 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.215 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.216 seconds (ok)
Nov 21 00:03:35.359: vmx| SCSI0:0: Command WRITE(10) took 1.216 seconds (ok)
Nov 21 00:03:35.937: vmx| SCSI0:0: Command WRITE(10) took 1.798 seconds (ok)
Nov 21 00:03:35.937: vmx| SCSI0:0: Command WRITE(10) took 1.799 seconds (ok)
Nov 21 00:03:35.937: vmx| SCSI0:0: Command WRITE(10) took 1.799 seconds (ok)
Nov 21 00:03:35.937: vmx| SCSI0:0: Command WRITE(10) took 1.800 seconds (ok)
Nov 21 00:03:35.937: vmx| SCSI0:0: Command WRITE(10) took 1.800 seconds (ok)
Nov 21 00:33:21.609: vmx| SCSI0:0: Command WRITE(10) took 5.001 seconds (ok)
Nov 21 00:33:21.609: vmx| SCSI0:0: Command WRITE(10) took 5.001 seconds (ok)
Nov 21 00:33:37.562: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 00:33:37.562: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 00:33:37.562: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 00:33:37.562: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 00:33:37.562: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.004 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.005 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.002 seconds (ok)
Nov 21 00:37:44.484: vmx| SCSI0:0: Command WRITE(10) took 1.002 seconds (ok)
Nov 21 01:29:26.781: vmx| SCSI0:0: Command WRITE(10) took 13.000 seconds (ok)
Nov 21 09:56:01.796: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 21 09:58:02.593: vmx| SCSI0:0: Command WRITE(10) took 2.812 seconds (ok)
Nov 21 10:06:17.625: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 21 10:06:17.625: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 21 10:06:17.625: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 21 10:09:58.031: vmx| SCSI0:0: Command WRITE(10) took 2.251 seconds (ok)
Nov 21 10:14:04.984: vmx| SCSI0:0: Command WRITE(10) took 1.283 seconds (ok)
Nov 21 11:14:07.812: vmx| SCSI0:0: Command WRITE(10) took 2.451 seconds (ok)
Nov 21 16:11:36.109: vcpu-0| DISKLIB-LIB   :numIOs = 150000 numMergedIOs = 0 numSplitIOs = 0
Nov 21 17:47:11.703: vmx| SCSI0:0: Command WRITE(10) took 22.000 seconds (ok)
Nov 21 17:47:11.703: vmx| SCSI0:0: Command WRITE(10) took 22.000 seconds (ok)
Nov 21 17:47:11.703: vmx| SCSI0:0: Command WRITE(10) took 22.001 seconds (ok)
Nov 21 17:47:20.843: vmx| SCSI0:0: Command WRITE(10) took 4.001 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 17:59:05.640: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 17:59:05.656: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 17:59:05.656: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 17:59:05.656: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 17:59:05.656: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 17:59:05.656: vmx| SCSI0:0: Command WRITE(10) took 1.006 seconds (ok)
Nov 21 18:15:52.078: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 21 18:15:52.078: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 21 18:15:52.078: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 18:29:50.515: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 21 19:37:02.031: vmx| SCSI0:0: Command WRITE(10) took 2.774 seconds (ok)
Nov 21 19:38:55.750: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 21 19:38:55.750: vmx| SCSI0:0: Command WRITE(10) took 1.501 seconds (ok)
Nov 21 19:48:56.937: vmx| SCSI0:0: Command WRITE(10) took 1.950 seconds (ok)
Nov 21 19:48:56.937: vmx| SCSI0:0: Command WRITE(10) took 1.951 seconds (ok)
Nov 21 19:55:26.265: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Workstation\License.ws.6.0.200907' 
Nov 21 20:22:23.203: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 21 20:25:19.078: vmx| SCSI0:0: Command WRITE(10) took 1.999 seconds (ok)
Nov 21 20:28:56.796: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 21 20:28:56.796: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 21 20:28:56.796: vmx| SCSI0:0: Command WRITE(10) took 2.001 seconds (ok)
Nov 21 20:35:19.359: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 21 20:55:08.187: vmx| SCSI0:0: Command WRITE(10) took 3.500 seconds (ok)
Nov 21 20:55:08.187: vmx| SCSI0:0: Command WRITE(10) took 3.500 seconds (ok)
Nov 21 20:56:01.937: vmx| SCSI0:0: Command WRITE(10) took 2.230 seconds (ok)
Nov 21 21:00:26.531: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 22 07:32:06.515: vmx| VMXVmdbLoadUsbDevices: New set of 0 USB devices
Nov 22 07:32:12.343: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 22 07:32:12.343: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 07:59:08.984: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 22 07:59:08.984: vmx| USB: Found device [name:Research\ In\ Motion\ USB\ Device vid:0fca pid:0006 path:1/3/0 speed:full family:unknown]
Nov 22 07:59:08.984: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 07:59:11.796: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 22 07:59:11.796: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 07:59:17.484: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 22 07:59:17.484: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/0 speed:full family:vendor,storage]
Nov 22 07:59:17.484: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 08:12:33.000: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 08:12:33.109: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 22 08:12:33.109: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 11:08:20.609: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 22 11:08:20.609: vmx| USB: Found device [name:Research\ In\ Motion\ USB\ Device vid:0fca pid:0006 path:1/3/0 speed:full family:unknown]
Nov 22 11:08:20.609: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 11:08:23.375: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Nov 22 11:08:23.375: vmx| USB: Found device [name:Research\ In\ Motion\ Removable\ Disk vid:0fca pid:0004 path:1/3/0 speed:full family:vendor,storage]
Nov 22 11:08:23.375: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 12:36:55.484: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 12:41:07.656: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 22 13:08:41.546: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 13:17:09.812: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 22 13:17:09.812: vmx| SCSI0:0: Command WRITE(10) took 2.000 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:44:45.140: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 13:54:08.984: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [576->576]
Nov 22 13:58:55.500: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:14:15.453: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:14:15.453: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:14:15.453: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:25:50.390: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:25:50.390: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:26:33.578: vmx| SCSI0:0: Command WRITE(10) took 1.196 seconds (ok)
Nov 22 14:29:09.109: vmx| SCSI0:0: Command WRITE(10) took 1.735 seconds (ok)
Nov 22 14:29:53.375: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 22 14:29:53.375: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 22 14:34:00.359: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 14:35:33.359: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 22 14:35:33.359: vmx| SCSI0:0: Command WRITE(10) took 2.308 seconds (ok)
Nov 22 14:38:45.140: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 22 14:38:45.140: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 22 16:13:15.734: vmx| SCSI0:0: Command WRITE(10) took 4.500 seconds (ok)
Nov 22 16:16:32.687: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 22 16:17:36.218: vmx| SCSI0:0: Command WRITE(10) took 7.048 seconds (ok)
Nov 22 16:17:36.218: vmx| SCSI0:0: Command WRITE(10) took 3.853 seconds (ok)
Nov 22 16:34:44.578: vmx| SCSI0:0: Command WRITE(10) took 1.500 seconds (ok)
Nov 22 17:18:55.359: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 22 17:27:55.484: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 22 17:29:05.812: vmx| SCSI0:0: Command WRITE(10) took 1.000 seconds (ok)
Nov 22 17:30:42.500: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 22 17:30:42.500: vmx| SCSI0:0: Command WRITE(10) took 1.001 seconds (ok)
Nov 22 17:31:15.796: vmx| SCSI0:0: Command WRITE(10) took 3.000 seconds (ok)
Nov 22 18:13:21.656: vmx| SCSI0:0: Command WRITE(10) took 1.079 seconds (ok)
Nov 23 07:38:11.625: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Workstation\License.ws.6.0.200907' 
Nov 23 08:57:31.109: vmx| SCSI0:0: Command WRITE(10) took 11.052 seconds (ok)
Nov 23 08:57:31.109: vmx| SCSI0:0: Command WRITE(10) took 11.052 seconds (ok)
Nov 23 08:57:31.109: vmx| SCSI0:0: Command WRITE(10) took 11.052 seconds (ok)
Nov 23 09:01:32.375: vmx| SCSI0:0: Command WRITE(10) took 2.328 seconds (ok)
Nov 23 10:43:28.984: vmx| VMXVmdbLoadUsbDevices: New set of 0 USB devices
Nov 23 10:43:37.750: vmx| VMXVmdbLoadUsbDevices: New set of 1 USB devices
Nov 23 10:43:37.750: vmx| USB: Found device [name:Sierra\ Wireless\ USB\ Device vid:1199 pid:0220 path:1/4/0 speed:full family:vendor]
Nov 23 10:49:42.531: vmx| [Vmdb_Set] Stale data for path: /vm/#_VMX/mks/focusEvent/ (current value '0' -> new value '1') [615->615]
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.500 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.501 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.502 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.502 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.502 seconds (ok)
Nov 23 11:05:14.453: vmx| SCSI0:0: Command WRITE(10) took 2.502 seconds (ok)
Nov 23 11:13:48.484: vmx| SCSI0:0: Command READ(10) took 1.014 seconds (ok)
Nov 23 11:14:28.218: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state suspended without reset
Nov 23 11:14:28.218: vcpu-0| Sync monModules(1).
Nov 23 11:14:28.218: vcpu-0| Done Sync monModules(1).
Nov 23 11:14:28.250: vmx| USB: Disconnecting device 0xc00000010e0f0002
Nov 23 11:14:28.281: vcpu-0| Cpt monModules(2).
Nov 23 11:14:28.281: vcpu-0| Done Cpt monModules(2).
Nov 23 11:14:28.281: vmx| DUMPER: Creating checkpoint file .\Ubuntu.vmss
Nov 23 11:14:28.281: vmx| Checkpointed in VMware Workstation, 6.0.4 build-93057, build-93057, Windows Host
Nov 23 11:14:28.312: vmx| MM: Renamed C:\Documents and Settings\Thinkpad2\My Documents\My Virtual Machines\Ubuntu 8.04\564da852-512e-da8e-4113-827b2b8d3f3d.vmem to .\Ubuntu.vmem
Nov 23 11:14:34.484: vmx| Msg_Reset:
Nov 23 11:14:34.484: vmx| ----------------------------------------
Nov 23 11:14:34.484: vmx| Stopping VCPU threads...
Nov 23 11:14:35.484: mks| Detaching from window system.
Nov 23 11:14:35.484: mks| Async MKS thread is exiting
Nov 23 11:14:35.484: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0'
Nov 23 11:14:35.484: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Nov 23 11:14:35.484: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Nov 23 11:14:35.578: vmx| MKS local poweroff
Nov 23 11:14:35.593: vmx| AIOWIN32: asyncOps=194058 syncOps=0 bufSize=0Kb delayed=57236 fixed=0 sgOp=194058 sgOn=1
Nov 23 11:14:35.593: vmx| WORKER: asyncOps=627231 maxActiveOps=1 maxPending=0 maxCompleted=0
Nov 23 11:14:37.171: vmx| vmdbPipe_Streams: Couldn't read
Nov 23 11:14:37.171: vmx| VMX idle exit
Nov 23 11:14:37.171: vmx| Flushing VMX VMDB connections
Nov 23 11:14:37.171: vmx| IPC_exit: disconnecting all threads
Nov 23 11:14:37.171: vmx| VMX exit (0).