Netzwerkproblem mit VMWare Server 1.0.4-56528

[bert666]

Hallo zusammen,

leider sind mir zwar im Forum viele ähnliche Fälle begegnet, aber keiner der Lösungswege hat geholfen:

Hostsystem: Inter Quad Core mit 2,4GHz & 2GB RAM; Windows Vista Home Premium
Installiert ist weiterhin (außer einigen Progs) die G-Data Internet Security 2007.

Gastsysteme: geplant sind Win98, Windows XP SP2 und ein Dapper Kubuntu

Die installation verlief soweit ohne Probleme, allerdings bekomme ich keinen Netzwerkzugriff hin. Ping ergibt "Zielhost nicht erreichbar" (egal ob vom Host => oder umgekehrt) egal ob dynamische oder statische IPs.

Hintergrund: ich möchte eine heterogene (Linux / Windows) Testumgebung herstellen, welche den DHCP Server meines Routers nutzt.

Hinweis: Ich musste erst VMNet 1 & VMNet8 deaktivieren, um auf dem Host wieder surfen zu können, ansonsten ist der VMWare Server mit Standartsettings installiert.

Ich hoffe es finden sich Antworten.

Vielen Dank im voraus

Th. Bergerhausen

[bert666]

... und noch die Log Datei

-------------------------------------------------------
Oct 14 21:12:19: vmx| Log for VMware Server pid=2760 version=1.0.4 build=build-56528 option=Release
Oct 14 21:12:19: vmx| Command line: "D:\Program Files\VMware\VMware Server\bin\vmware-vmx.exe" "-T" "querytoken" "d:\virtual machines\windows xp professional\windows xp professional.vmx"
Oct 14 21:12:19: vmx| vmxvmdb: Index name being generated from config file
Oct 14 21:12:19: vmx| VMXVmdbConnectServerd - Trying to discover serverd
Oct 14 21:12:19: vmx| MStat: Creating Stat system.cpuusage
Oct 14 21:12:19: vmx| MStat: Creating Stat system.ram
Oct 14 21:12:19: vmx| MStat: Creating Stat system.uptime
Oct 14 21:12:19: vmx| MStat: Creating Stat system.load
Oct 14 21:12:19: vmx| VMMon: failed memory configuration
Oct 14 21:12:19: vmx| CPU #0 TSC = 38387934733910
Oct 14 21:12:19: vmx| CPU #1 TSC = 38387934734486
Oct 14 21:12:19: vmx| CPU #2 TSC = 38387934734234
Oct 14 21:12:19: vmx| CPU #3 TSC = 38387934734306
Oct 14 21:12:19: vmx| TSC delta 576
Oct 14 21:12:19: vmx| VMMon_GetkHzEstimate: Calculated 2394000 kHz
Oct 14 21:12:19: vmx| Measured CPU as 2394000 kHz, but OS says 2400000 kHz; using 2400000
Oct 14 21:12:19: vmx| Msg_Hint: msg.hostWin32.cpuSpeedMismatch (not shown)
Oct 14 21:12:19: vmx| cpuids[0].id81.ecx = 0x1
Oct 14 21:12:19: vmx| cpuids[1].id81.ecx = 0x1
Oct 14 21:12:19: vmx| cpuids[2].id81.ecx = 0x1
Oct 14 21:12:19: vmx| cpuids[3].id81.ecx = 0x1
Oct 14 21:12:19: vmx| pcpu #0 CPUID numEntries=10 GenuntelineI
Oct 14 21:12:19: vmx| pcpu #0 CPUID version=0x6f7 id1.edx=0xbfebfbff id1.ecx=0xe3bd id1.ebx=0x40800
Oct 14 21:12:19: vmx| pcpu #0 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1
Oct 14 21:12:19: vmx| pcpu #1 CPUID numEntries=10 GenuntelineI
Oct 14 21:12:19: vmx| pcpu #1 CPUID version=0x6f7 id1.edx=0xbfebfbff id1.ecx=0xe3bd id1.ebx=0x1040800
Oct 14 21:12:19: vmx| pcpu #1 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1
Oct 14 21:12:19: vmx| pcpu #2 CPUID numEntries=10 GenuntelineI
Oct 14 21:12:19: vmx| pcpu #2 CPUID version=0x6f7 id1.edx=0xbfebfbff id1.ecx=0xe3bd id1.ebx=0x2040800
Oct 14 21:12:19: vmx| pcpu #2 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1
Oct 14 21:12:19: vmx| pcpu #3 CPUID numEntries=10 GenuntelineI
Oct 14 21:12:19: vmx| pcpu #3 CPUID version=0x6f7 id1.edx=0xbfebfbff id1.ecx=0xe3bd id1.ebx=0x3040800
Oct 14 21:12:19: vmx| pcpu #3 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1
Oct 14 21:12:19: vmx| CPUID id1.edx: 0xbfebfbff id1.ecx: 0xe3bd id81.edx: 0x20100000 id81.ecx: 0x1
Oct 14 21:12:19: vmx| CPUID id88.ecx: 0 id88.edx: 0
Oct 14 21:12:19: vmx| ACL_InitCapabilities: here 1 (bug 63252)
Oct 14 21:12:19: vmx| changing directory to d:\virtual machines\windows xp professional\.
Oct 14 21:12:19: vmx| Config file: d:\virtual machines\windows xp professional\windows xp professional.vmx
Oct 14 21:12:20: vmx| VMDB: Connected to serverd
Oct 14 21:12:20: vmx| IPCHandleConnection: ReadFile failed (code 109)
Oct 14 21:12:20: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOn without reset
Oct 14 21:12:20: vmx| PowerOn
Oct 14 21:12:20: vmx| Host: WIN32 highest NUMA node 0
Oct 14 21:12:20: vmx| Host: WIN32 NUMA node 0, CPU mask 0x000000000000000f
Oct 14 21:12:20: vmx| Resuming virtual machine from d:\virtual machines\windows xp professional\windows xp professional.vmss
Oct 14 21:12:20: vmx| DUMPER: restoring checkpoint version 8
Oct 14 21:12:20: vmx| Checkpointed in VMware Server, 1.0.4 build-56528, build-56528, Windows Host
Oct 14 21:12:20: vmx| HOST Windows version 6.0, build 6000, platform 2, "", SMP
Oct 14 21:12:20: vmx| DICT --- USER PREFERENCES
Oct 14 21:12:20: vmx| DICT pref.autoFitFullScreen = fitHostToGuest
Oct 14 21:12:20: vmx| DICT pref.view.navBar.type = favorites
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.items.count = 7
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item0.id = POWER_OFF
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item1.id = SUSPEND
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item2.id = POWER_ON
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item3.id = RESET
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item4.id = _SEP_
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item5.id = PREVIEW_PLAYER
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.item6.id = PREVIEW_WS
Oct 14 21:12:20: vmx| DICT pref.mruDest0.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest0.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest0.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest1.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest1.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest1.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest2.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest2.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest2.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest3.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest3.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest3.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest4.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest4.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest4.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest5.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest5.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest5.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest6.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest6.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest6.user =
Oct 14 21:12:20: vmx| DICT pref.mruDest7.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.mruDest7.destString =
Oct 14 21:12:20: vmx| DICT pref.mruDest7.user =
Oct 14 21:12:20: vmx| DICT webUpdate.checkPeriod = weekly
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.items.count = 3
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.item0.id = SNAPSHOT
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.item1.id = REVERT
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.item2.id = SNAPSHOT_MANAGER
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.items.count = 6
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item0.id = FAVORITES
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item1.id = FULL_SCREEN
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item2.id = QUICK_SWITCH
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item3.id = _SEP_
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item4.id = SUMMARY
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.item5.id = CONSOLE
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.proj.items.count = 4
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.proj.item0.id = ADD_VM
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.proj.item1.id = POLICIES
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.proj.item2.id = PKG_NEW
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.proj.item3.id = EDIT_SETTINGS
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.menu.position.ix = 0
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.menu.position.newLine = TRUE
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.position.ix = 1
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.position.newLine = TRUE
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.power.position.length = 118
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.position.ix = 2
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.snapshot.position.length = 87
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.position.ix = 3
Oct 14 21:12:20: vmx| DICT pref.view.toolbars.view.position.length = 153
Oct 14 21:12:20: vmx| DICT pref.console.currentObj.path = /vm/#a0dd008fc602512e/
Oct 14 21:12:20: vmx| DICT pref.console.currentObj.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj0.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj0.name = Home
Oct 14 21:12:20: vmx| DICT pref.console.openedObj1.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj1.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj1.path = /vm/#c5268053ec91bfe7/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj1.file = D:\Virtual Machines\Ubuntu\Ubuntu.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj1.name = Ubuntu
Oct 14 21:12:20: vmx| DICT pref.console.openedObj.maxNum = 3
Oct 14 21:12:20: vmx| DICT pref.placement.left = 16
Oct 14 21:12:20: vmx| DICT pref.placement.top = 10
Oct 14 21:12:20: vmx| DICT pref.placement.right = 1036
Oct 14 21:12:20: vmx| DICT pref.placement.bottom = 747
Oct 14 21:12:20: vmx| DICT pref.console.openedObj2.present = TRUE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj2.name = Windows XP Professional
Oct 14 21:12:20: vmx| DICT pref.console.openedObj3.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj3.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj3.path = /vm/#c5268053ec91bfe7/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj3.file = D:\Virtual Machines\Ubuntu\Ubuntu.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj3.name = Ubuntu
Oct 14 21:12:20: vmx| DICT webUpdate.checkLast = 1192222703
Oct 14 21:12:20: vmx| DICT webUpdate.lastCheck.status = done_updates
Oct 14 21:12:20: vmx| DICT pref.console.openedObj4.present = TRUE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj4.type = home
Oct 14 21:12:20: vmx| DICT pref.console.openedObj4.path =
Oct 14 21:12:20: vmx| DICT pref.console.openedObj4.file =
Oct 14 21:12:20: vmx| DICT pref.console.openedObj4.name = Home
Oct 14 21:12:20: vmx| DICT pref.console.openedObj5.present = TRUE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj5.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj5.path = /vm/#c5268053ec91bfe7/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj5.file = D:\Virtual Machines\Ubuntu\Ubuntu.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj5.name = Ubuntu
Oct 14 21:12:20: vmx| DICT pref.console.openedObj2.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj2.path = /vm/#a0dd008fc602512e/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj2.file = D:\Virtual Machines\Windows XP Professional\Windows XP Professional.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj6.present = TRUE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj6.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj6.path = /vm/#573a982ff668629b/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj6.file = D:\Virtual Machines\Windows 98\Windows 98.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj6.name = Windows 98
Oct 14 21:12:20: vmx| DICT pref.console.openedObj7.present = FALSE
Oct 14 21:12:20: vmx| DICT pref.console.openedObj7.type = vm
Oct 14 21:12:20: vmx| DICT pref.console.openedObj7.path = /vm/#573a982ff668629b/
Oct 14 21:12:20: vmx| DICT pref.console.openedObj7.file = D:\Virtual Machines\Windows 98\Windows 98.vmx
Oct 14 21:12:20: vmx| DICT pref.console.openedObj7.name = Windows 98
Oct 14 21:12:20: vmx| DICT --- USER DEFAULTS
Oct 14 21:12:20: vmx| DICT --- HOST DEFAULTS
Oct 14 21:12:20: vmx| DICT datastore.name = local
Oct 14 21:12:20: vmx| DICT datastore.localpath = D:\Virtual Machines\
Oct 14 21:12:20: vmx| DICT --- SITE DEFAULTS
Oct 14 21:12:20: vmx| DICT datastore.name = local
Oct 14 21:12:20: vmx| DICT datastore.localpath = D:\Virtual Machines\
Oct 14 21:12:20: vmx| DICT --- COMMAND LINE
Oct 14 21:12:20: vmx| DICT --- CONFIGURATION
Oct 14 21:12:20: vmx| DICT config.version = 8
Oct 14 21:12:20: vmx| DICT virtualHW.version = 4
Oct 14 21:12:20: vmx| DICT scsi0.present = TRUE
Oct 14 21:12:20: vmx| DICT memsize = 1024
Oct 14 21:12:20: vmx| DICT ide0:0.present = TRUE
Oct 14 21:12:20: vmx| DICT ide0:0.fileName = Windows XP Professional.vmdk
Oct 14 21:12:20: vmx| DICT ide1:0.present = TRUE
Oct 14 21:12:20: vmx| DICT ide1:0.fileName = D:\DL\WinXP-SP2\de_winxp_pro_with_sp2.iso
Oct 14 21:12:20: vmx| DICT ide1:0.deviceType = cdrom-image
Oct 14 21:12:20: vmx| DICT floppy0.present = FALSE
Oct 14 21:12:20: vmx| DICT Ethernet0.present = TRUE
Oct 14 21:12:20: vmx| DICT Ethernet0.connectionType = bridged
Oct 14 21:12:20: vmx| DICT displayName = Windows XP Professional
Oct 14 21:12:20: vmx| DICT guestOS = winxppro
Oct 14 21:12:20: vmx| DICT priority.grabbed = normal
Oct 14 21:12:20: vmx| DICT priority.ungrabbed = normal
Oct 14 21:12:20: vmx| DICT ide1:0.autodetect = FALSE
Oct 14 21:12:20: vmx| DICT ide0:0.redo =
Oct 14 21:12:20: vmx| DICT ethernet0.addressType = generated
Oct 14 21:12:20: vmx| DICT uuid.location = 56 4d 1e a3 1d 1c 20 7b-df 4c 9a ed 59 96 2d ab
Oct 14 21:12:20: vmx| DICT uuid.bios = 56 4d 1e a3 1d 1c 20 7b-df 4c 9a ed 59 96 2d ab
Oct 14 21:12:20: vmx| DICT ethernet0.generatedAddress = 00:0c:29:96:2d:ab
Oct 14 21:12:20: vmx| DICT ethernet0.generatedAddressOffset = 0
Oct 14 21:12:20: vmx| DICT workingDir = .
Oct 14 21:12:20: vmx| DICT gui.exitAtPowerOff = TRUE
Oct 14 21:12:20: vmx| DICT checkpoint.vmState = windows xp professional.vmss
Oct 14 21:12:20: vmx| DICT --- USER DEFAULTS
Oct 14 21:12:20: vmx| DICT --- HOST DEFAULTS
Oct 14 21:12:20: vmx| DICT datastore.name = local
Oct 14 21:12:20: vmx| DICT datastore.localpath = D:\Virtual Machines\
Oct 14 21:12:20: vmx| DICT --- SITE DEFAULTS
Oct 14 21:12:20: vmx| DICT datastore.name = local
Oct 14 21:12:20: vmx| DICT datastore.localpath = D:\Virtual Machines\
Oct 14 21:12:20: vmx| DICT --- GLOBAL SETTINGS
Oct 14 21:12:20: vmx| Msg_Hint: msg.guestos.xp (not shown)
Oct 14 21:12:20: vmx| Msg_Hint: msg.hostw32.wrongNTversion (not shown)
Oct 14 21:12:20: vmx| WSSCAN: reserved mem (in MB) min=32 max=1916 recommended=1916
Oct 14 21:12:20: vmx| hostMem=2044 maxAllowedAll=-1 maxAllowedVM=3600
Oct 14 21:12:20: vmx| totOverhead=16
Oct 14 21:12:20: vmx| WSSCAN: used rec mem (in MB) 1916
Oct 14 21:12:20: vmx| WSSCAN: Overhead 268529 paged 7072 nonpaged 4096 maxFBSize
Oct 14 21:12:20: vmx| WSSCAN 1 2 383542 449031 490496 383542 50 0
Oct 14 21:12:20: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Server\License.vs.1.0-00'
Oct 14 21:12:20: vmx| STATDECLGROUP stats Root "" null
Oct 14 21:12:20: vmx| Host CPUID features: version 0x6f8 id1.edx 0xbfebfbff id1.ecx 0xe3bd id81.edx 0x20100000 id81.ecx 0x1
Oct 14 21:12:20: vmx| CPU.cpuFeatures = 0xb971ff37
Oct 14 21:12:20: vmx| CPUID after masking: version 0x6f8 id1.edx 0xfebfbff id1.ecx 0xa215 id81.edx 0x20100800 id81.ecx 0x1 id88.ecx 0x0
Oct 14 21:12:20: vmx| CPU.cpuFeatures = 0x9871ff33
Oct 14 21:12:20: vmx| APIC: Local APIC at 0xfee00000
Oct 14 21:12:20: vmx| KHZEstimate 2400000
Oct 14 21:12:20: vmx| MHZEstimate 2400
Oct 14 21:12:20: vmx| NumVCPUs 1
Oct 14 21:12:20: vmx| UUID: location-UUID is 56 4d 61 63 0e 9f f2 d8-dc d1 bc d5 5b 62 94 d5
Oct 14 21:12:20: vmx| UUID: canonical path is d:\virtual machines\windows xp professional\windows xp professional.vmx
Oct 14 21:12:20: vmx| UUID: location-UUID is 56 4d 1e a3 1d 1c 20 7b-df 4c 9a ed 59 96 2d ab
Oct 14 21:12:20: vmx| MM: Using partialmap, 262144 pages AC 0 CE 1 TM 0 DOHU 0
Oct 14 21:12:20: vmx| MStat: Creating Stat vm.cpuusage
Oct 14 21:12:20: vmx| MStat: Creating Stat vm.ram
Oct 14 21:12:20: vmx| MStat: Creating Stat vm.uptime
Oct 14 21:12:20: vmx| DISK: OPEN ide0:0 'd:\virtual machines\windows xp professional\Windows XP Professional.vmdk' persistent R[(null)]
Oct 14 21:12:20: vmx| DISKLIB-DSCPTR: Opened [0]: "Windows XP Professional-flat.vmdk" 0 (0xa)
Oct 14 21:12:20: vmx| DISKLIB-LINK : Opened 'd:\virtual machines\windows xp professional\Windows XP Professional.vmdk' (0xa): monolithicFlat, 16777216 sectors / 8192 Mb.
Oct 14 21:12:20: vmx| DISKLIB-LIB : Opened "d:\virtual machines\windows xp professional\Windows XP Professional.vmdk" (flags 0xa).
Oct 14 21:12:20: vmx| DISK: OPEN 'd:\virtual machines\windows xp professional\Windows XP Professional.vmdk' Geo (16383/16/63) BIOS Geo (1044/255/63) freeSpace=43645Mb
Oct 14 21:12:20: vmx| TimeTracker host to guest rate conversion 38389452878786 @ 2400000000Hz -> 38389452878786 @ 2400000000Hz
Oct 14 21:12:20: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0
Oct 14 21:12:20: vmx| MStat: Creating Stat ide0:0.bytesread
Oct 14 21:12:20: vmx| MStat: Creating Stat ide0:0.byteswritten
Oct 14 21:12:20: vmx| MStat: Creating Stat ide1:0.bytesread
Oct 14 21:12:20: vmx| MStat: Creating Stat ide1:0.byteswritten
Oct 14 21:12:20: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags.
Oct 14 21:12:20: vmx| MStat: Creating Stat vm.heartbeat
Oct 14 21:12:20: vmx| DISKUTIL: ide0:0 : toolsVersion = 0
Oct 14 21:12:20: vmx| DISKUTIL: Offline toolsVersion = 0
Oct 14 21:12:20: vmx| TOOLS INSTALL initializing state to IDLE on power on.
Oct 14 21:12:20: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks
Oct 14 21:12:20: vmx| MStat: Creating Stat ethernet0.bytesread
Oct 14 21:12:20: vmx| MStat: Creating Stat ethernet0.byteswritten
Oct 14 21:12:20: vmx| Ethernet0 MAC Address: 00:0c:29:96:2d:ab
Oct 14 21:12:20: vmx| VMXNET: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks, dontClusterSize is 128
Oct 14 21:12:20: vmx| E1000: checksum cycles/kB: C=1381 asm=947
Oct 14 21:12:20: vmx| VirtualProtect MapProtectMem(0xe20000,0x1000) returns 0x1e7
Oct 14 21:12:20: vmx| Can't read-only monitor pages from 0x00E20000 to 0x00E21000
Oct 14 21:12:20: vmx| VirtualProtect MapProtectMem(0xe22000,0x0) returns 0x57
Oct 14 21:12:20: vmx| Can't read-only monitor pages from 0x00E22000 to 0x00E22000
Oct 14 21:12:20: vmx| CPT: Restoring checkpoint d:\virtual machines\windows xp professional\windows xp professional.vmss
Oct 14 21:12:20: vmx| DUMPER: restoring checkpoint version 8
Oct 14 21:12:20: vmx| checkpointCPUID: cpt vendor GenuntelineI host vendor GenuntelineI
Oct 14 21:12:20: vmx| checkpointCPUID: cpt family 06 model 0f7 host family 06 model 0f7
Oct 14 21:12:20: vmx| checkpointCPUID: cpt id1.ecx a215 id1.edx febfbff id81.ecx 1 id81.edx 20100000
Oct 14 21:12:20: vmx| checkpointCPUID: host id1.ecx a215 id1.edx febfbff id81.ecx 1 id81.edx 20100000
Oct 14 21:12:20: vmx| DUMPER: item eip [0,-1] in group cpu not used
Oct 14 21:12:20: vmx| restoring Snapshot
Oct 14 21:12:20: vmx| DUMPER: item cfgFile [-1,-1] in group Snapshot not used
Oct 14 21:12:20: vmx| DUMPER: item nvramFile [-1,-1] in group Snapshot not used
Oct 14 21:12:20: vmx| restoring memory
Oct 14 21:12:20: vmx| Mapped mainmem as pageable
Oct 14 21:12:20: vmx| Msg_Reset:
Oct 14 21:12:20: vmx| ----------------------------------------
Oct 14 21:12:20: vmx| Opened paging file d:\virtual machines\windows xp professional\windows xp professional.vmem
Oct 14 21:12:20: vmx| Lazy Restore with prefetch of 204 MB
Oct 14 21:12:20: vmx| Msg_Hint: msg.mainmem.lazyResumeHint (not shown)
Oct 14 21:12:20: MMPageWalker| Entering MM LazySave Loop
Oct 14 21:12:20: vmx| Create Memory BIO succeeded.
Oct 14 21:12:20: vmx| Create Memory BIO succeeded.
Oct 14 21:12:20: vmx| Accepted new connection at 876 for thread servercontrol (0xe421d0)
Oct 14 21:12:20: vmx| VUINewControlConnection: before slow ACL gunk (bug 63252).
Oct 14 21:12:20: vmx| ACL: Thread from (SYSTEM) gets full perms
Oct 14 21:12:20: vmx| VUINewControlConnection: after slow ACL gunk (bug 63252).
Oct 14 21:12:20: vmx| VUI: A new VMControl client connected.
Oct 14 21:12:20: vmx| IPC version negotiation version: VMX returning 2.1 to servercontrol
Oct 14 21:12:20: vmx| IPC vmcontrol-temp version: VMX returning 11.4 to servercontrol that tried 11.4
Oct 14 21:12:24: vmx| restoring MStats
Oct 14 21:12:24: vmx| restoring pic
Oct 14 21:12:24: vmx| restoring TimeTracker
Oct 14 21:12:24: vmx| TimeTracker host to guest rate conversion 38389452878786 @ 2400000000Hz -> 10162881924263 @ 2400000000Hz
Oct 14 21:12:24: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + -28226570954523
Oct 14 21:12:24: vmx| restoring Floppy
Oct 14 21:12:24: vmx| restoring GuestMsg
Oct 14 21:12:24: vmx| restoring GuestRpc
Oct 14 21:12:24: vmx| restoring PCI
Oct 14 21:12:24: vmx| restoring Cs440bx
Oct 14 21:12:24: vmx| DUMPER: item drb [1,-1] in group Cs440bx not used
Oct 14 21:12:24: vmx| DUMPER: item drb [0,-1] in group Cs440bx not used
Oct 14 21:12:24: vmx| restoring ide1:0
Oct 14 21:12:24: vmx| restoring ide0:0
Oct 14 21:12:24: vmx| restoring vide
Oct 14 21:12:24: vmx| DUMPER: BlockItem monbuf [0, -1] not found
Oct 14 21:12:24: vmx| DUMPER: BlockItem monbuf [1, -1] not found
Oct 14 21:12:24: vmx| DUMPER: item setMultiple [0,-1] in group vide not used
Oct 14 21:12:24: vmx| restoring SCSI0
Oct 14 21:12:24: vmx| restoring Timer
Oct 14 21:12:24: vmx| restoring Tools
Oct 14 21:12:24: vmx| restoring Tools Install
Oct 14 21:12:24: vmx| TOOLS INSTALL setting state to 0 on restore.
Oct 14 21:12:24: vmx| restoring MKSVMX
Oct 14 21:12:24: vmx| DUMPER: item imageData [-1,-1] in group MKSVMX not used
Oct 14 21:12:24: vmx| restoring VGA
Oct 14 21:12:24: vmx| restoring DMA
Oct 14 21:12:24: vmx| restoring BackdoorAPM
Oct 14 21:12:24: vmx| restoring CMOS
Oct 14 21:12:24: vmx| restoring FlashRam
Oct 14 21:12:24: vmx| restoring A20
Oct 14 21:12:24: vmx| restoring Keyboard
Oct 14 21:12:24: vmx| restoring backdoorAbsMouse
Oct 14 21:12:24: vmx| restoring SIO
Oct 14 21:12:24: vmx| restoring serial0
Oct 14 21:12:24: vmx| restoring serial1
Oct 14 21:12:24: vmx| restoring serial2
Oct 14 21:12:24: vmx| restoring serial3
Oct 14 21:12:24: vmx| restoring parallel0
Oct 14 21:12:24: vmx| restoring parallel1
Oct 14 21:12:24: vmx| restoring parallel2
Oct 14 21:12:24: vmx| restoring SVGA
Oct 14 21:12:24: vmx| SVGA phys sizes: 2360x1770x32 offset 0 fb 0x01000000
Oct 14 21:12:24: vmx| SVGA compatible geometry on checkpoint restore
Oct 14 21:12:24: vmx| SVGA old geometry 2360x1770, max size = 16777216
Oct 14 21:12:24: vmx| SVGA new geometry 2360x1770, max size = 16777216
Oct 14 21:12:24: vmx| DUMPER: Item CursorType [-1, -1] not found
Oct 14 21:12:24: vmx| restoring Ethernet0
Oct 14 21:12:24: vmx| restoring monitorLate
Oct 14 21:12:24: vmx| restoring devices
Oct 14 21:12:24: vmx| DUMPER: Dumper_EndRestore: update hdr magic
Oct 14 21:12:24: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1
Oct 14 21:12:24: vmx| VMX setting maximum IPC write buffers to 0 packets, 0 bytes
Oct 14 21:12:24: mks| Async MKS thread is alive
Oct 14 21:12:24: vcpu-0| APIC: version = 0x14, max LVT = 5
Oct 14 21:12:24: vcpu-0| APIC: LDR = 0x4000000, DFR = 0xffffffff
Oct 14 21:12:24: vcpu-0| PShare: enabled 1, scanRate 32, checkRate 16
Oct 14 21:12:24: vcpu-0| guestCpuFeatures = 0x9871ff33
Oct 14 21:12:24: vcpu-0| Init modules.
Oct 14 21:12:24: vcpu-0| DISKUTIL: ide0:0 : capacity=16777216
Oct 14 21:12:24: vcpu-0| Cpt monModules(3).
Oct 14 21:12:24: vcpu-0| Done Cpt monModules(3).
Oct 14 21:12:24: vmx| VNET: Notification enabled for Ethernet0
Oct 14 21:12:24: vcpu-0| sz=3104736
Oct 14 21:12:24: vcpu-0| vmm32 initialized: Releasebuild-56528. cflags: 0x00000002.01803000.00000054
Oct 14 21:12:24: vcpu-0| Restoring VM
Oct 14 21:12:24: vcpu-0| Sync monModules(4).
Oct 14 21:12:24: vcpu-0| Done Sync monModules(4).
Oct 14 21:12:24: vcpu-0| SVGA: Registering IOSpace at 0x1400 (0x0)
Oct 14 21:12:24: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:53: mks| SOCKET 1 new update req with non-empty pending: logical error on server/client?
Oct 14 21:12:58: vcpu-0| CPU reset: soft
Oct 14 21:12:59: vcpu-0| SVGA: Unregistering IOSpace at 0x1400 (0x1400)
Oct 14 21:12:59: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: vcpu-0| SVGA: Registering IOSpace at 0x1400 (0x0)
Oct 14 21:12:59: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:12:59: mks| HostOps hideCursor before defineCursor!
Oct 14 21:12:59: mks| HostOps hideCursor before defineCursor!
Oct 14 21:12:59: mks| VNCENCODE 1 encoding mode change: (640x480x24depth,32bpp)
Oct 14 21:12:59: mks| SOCKET 1 new update req with non-empty pending: logical error on server/client?
Oct 14 21:13:00: vcpu-0| VIDE: Curr CHS info cyls: 17475 heads: 15 sects: 63 lba_cap: 16777216
Oct 14 21:13:00: vcpu-0| BIOS-UUID is 56 4d 1e a3 1d 1c 20 7b-df 4c 9a ed 59 96 2d ab
Oct 14 21:13:01: vcpu-0| DISKUTIL: ide0:0 : toolsVersion = 0
Oct 14 21:13:01: vcpu-0| DISKUTIL: Offline toolsVersion = 0
Oct 14 21:13:01: mks| VNCENCODE 1 encoding mode change: (720x400x24depth,32bpp)
Oct 14 21:13:01: vcpu-0| Unknown int 10h func 0x2000
Oct 14 21:13:02: mks| VNCENCODE 1 encoding mode change: (640x480x24depth,32bpp)
Oct 14 21:13:03: mks| VNCENCODE 1 encoding mode change: (720x400x24depth,32bpp)
Oct 14 21:13:05: mks| VNCENCODE 1 encoding mode change: (640x480x24depth,32bpp)
Oct 14 21:13:05: vcpu-0| SVGA: Unregistering IOSpace at 0x1400 (0x1400)
Oct 14 21:13:05: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:13:05: vcpu-0| SVGA: Registering IOSpace at 0x1400 (0x0)
Oct 14 21:13:05: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Oct 14 21:13:06: vcpu-0| VIDE: Curr CHS info cyls: 17475 heads: 15 sects: 63 lba_cap: 16777216
Oct 14 21:13:06: vcpu-0| CDROM: Mode Sense for Unsupported Page 0x1B
Oct 14 21:13:15: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Oct 14 21:13:15: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Oct 14 21:13:15: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Oct 14 21:13:15: mks| SOCKET 1 new update req with non-empty pending: logical error on server/client?
Oct 14 21:13:18: mks| VNCENCODE 1 encoding mode change: (800x600x24depth,32bpp)
Oct 14 21:13:20: mks| SOCKET 1 new update req with non-empty pending: logical error on server/client?
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 30
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 31
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 32
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 33
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 35
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 36
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 38
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 45
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 46
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 47
Oct 14 21:13:23: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 259
Oct 14 21:13:25: mks| SOCKET 1 new update req with non-empty pending: logical error on server/client?
Oct 14 21:13:44: MMPageWalker| Exit MM Lazy Loop
Oct 14 21:15:05: vcpu-0| Image_CDROM: Ignoring a Unit Start or Stop
Oct 14 21:15:05: vcpu-0| PIIX4: PM Soft Off. Good-bye.
Oct 14 21:15:05: vmx| Stopping VCPU threads...
Oct 14 21:15:05: mks| Async MKS thread is exiting
Oct 14 21:15:05: vmx| DnD rpc already set to 0
Oct 14 21:15:05: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0'
Oct 14 21:15:05: vmx| Finished pending checkpoint op
Oct 14 21:15:05: vmx| Done flushing pending lazy op
Oct 14 21:15:05: vmx| SOCKET 1 close VNC socket on VNCBackendDestroy
Oct 14 21:15:05: vmx| MKS local poweroff
Oct 14 21:15:05: vmx| Lock before MKS lock created. Early poweroff?
Oct 14 21:15:05: vmx| Unlock before MKS lock created. Early poweroff?
Oct 14 21:15:05: vmx| ide0:0: numIOs = 6672 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)
Oct 14 21:15:05: vmx| AIOWIN32: asyncOps=6492 syncOps=0 bufSize=56Kb delayed=0 fixed=22 sgOp=6177 sgOn=1
Oct 14 21:15:05: vmx| DUMPER: Deleted checkpoint file d:\virtual machines\windows xp professional\windows xp professional.vmss
Oct 14 21:15:05: vmx| VMX idle exit
Oct 14 21:15:05: vmx| VMX IPC closed the connection with thread servercontrol (00E421D0)
Oct 14 21:15:05: vmx| VMX: Remote VMControl client servercontrol disconnected.
Oct 14 21:15:05: vmx| Flushing VMX VMDB connections
Oct 14 21:15:05: vmx| IPC_exit: disconnecting all threads
Oct 14 21:15:05: vmx| VMX exit.
Oct 14 21:15:05: vmx| AIOMGR-S : stat o=3 r=4 w=0 i=0 br=1742 bw=0