I have just updated my VMWare Workstation to 6.0 and when i ran my rebuild and restart script i received an error saying 'Stale data' upon restart of one of the VMs.
The rebuild/restart script basically stops all my VMs rolls them back to a baseline snapshot and starts them up again.
The VM causing the problem is a windows server 2003 machine with nothing else on it just a fresh install which is updated and patched.
Any suggestions why this error is coming up for this VM? and any solutions would be handy thanks.
Host OS? What's the script? What are the contents of the UI and VMX logs?
windows XP, script is just a batch file that runs from windows scheduler stops, reverts an d starts VMs. here's the vmx log
Jun 25 11:15:19.147: vmx| Log for VMware Workstation pid=2644 version=6.0.0 build=build-45731 option=Release
Jun 25 11:15:19.147: vmx| Hostname=fileserver.kwinana.ksc.net.au
Jun 25 11:15:19.147: vmx| Command line: "C:\Program Files\VMware\VMware Workstation\bin\vmware-vmx.exe" "-#" "name=VMware Workstation;version=6.0.0;licensename=VMware Workstation for Win32;licenseversion=6.0 build-45731;" "-@" "pipe=
.\pipe\vmxd812bc6118c9d2ae;" "E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx"
Jun 25 11:15:19.178: vmx| UI Connecting to pipe '
.\pipe\vmxd812bc6118c9d2ae' with user '(null)'
Jun 25 11:15:19.256: vmx| HD: host version is 5.2.3790
Jun 25 11:15:19.256: vmx| HD: addr 8083f526
Jun 25 11:15:19.272: vmx| HD: 808ab8e8, 8089c400
Jun 25 11:15:19.272: vmx| CPU #0 TSC = 17307095080716
Jun 25 11:15:19.272: vmx| CPU #1 TSC = 17307095079778
Jun 25 11:15:19.272: vmx| TSC delta 938
Jun 25 11:15:19.272: vmx| VMMon_GetkHzEstimate: Calculated 2793030 kHz
Jun 25 11:15:19.272: vmx| CPUID[0] vendor: GenuntelineI
Jun 25 11:15:19.272: vmx| CPUID[0] level 00000000, 0: 0x00000003 0x756e6547 0x6c65746e 0x49656e69
Jun 25 11:15:19.272: vmx| CPUID[0] level 00000001, 0: 0x00000f41 0x00020800 0x0000441d 0xbfebfbff
Jun 25 11:15:19.272: vmx| CPUID[0] level 00000002, 0: 0x605b5001 0x00000000 0x00000000 0x007c7040
Jun 25 11:15:19.272: vmx| CPUID[0] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000002, 0: 0x20202020 0x20202020 0x20202020 0x6e492020
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000003, 0: 0x286c6574 0x50202952 0x69746e65 0x52286d75
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000004, 0: 0x20342029 0x20555043 0x30382e32 0x007a4847
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000006, 0: 0x00000000 0x00000000 0x04006040 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[0] level 80000008, 0: 0x00002024 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] vendor: GenuntelineI
Jun 25 11:15:19.272: vmx| CPUID[1] level 00000000, 0: 0x00000003 0x756e6547 0x6c65746e 0x49656e69
Jun 25 11:15:19.272: vmx| CPUID[1] level 00000001, 0: 0x00000f41 0x01020800 0x0000441d 0xbfebfbff
Jun 25 11:15:19.272: vmx| CPUID[1] level 00000002, 0: 0x605b5001 0x00000000 0x00000000 0x007c7040
Jun 25 11:15:19.272: vmx| CPUID[1] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000002, 0: 0x20202020 0x20202020 0x20202020 0x6e492020
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000003, 0: 0x286c6574 0x50202952 0x69746e65 0x52286d75
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000004, 0: 0x20342029 0x20555043 0x30382e32 0x007a4847
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000006, 0: 0x00000000 0x00000000 0x04006040 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID[1] level 80000008, 0: 0x00002024 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID vendor: GenuntelineI
Jun 25 11:15:19.272: vmx| hostCPUID level 00000000, 0: 0x00000003 0x756e6547 0x6c65746e 0x49656e69
Jun 25 11:15:19.272: vmx| hostCPUID level 00000001, 0: 0x00000f41 0x00020800 0x0000441d 0xbfebfbff
Jun 25 11:15:19.272: vmx| hostCPUID level 00000002, 0: 0x605b5001 0x00000000 0x00000000 0x007c7040
Jun 25 11:15:19.272: vmx| hostCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000002, 0: 0x20202020 0x20202020 0x20202020 0x6e492020
Jun 25 11:15:19.272: vmx| hostCPUID level 80000003, 0: 0x286c6574 0x50202952 0x69746e65 0x52286d75
Jun 25 11:15:19.272: vmx| hostCPUID level 80000004, 0: 0x20342029 0x20555043 0x30382e32 0x007a4847
Jun 25 11:15:19.272: vmx| hostCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000006, 0: 0x00000000 0x00000000 0x04006040 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| hostCPUID level 80000008, 0: 0x00002024 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.272: vmx| CPUID Maximum Physical Address Bits supported across all CPUs : 36
Jun 25 11:15:19.319: vmx| Host ACPI: can't find SRAT
Jun 25 11:15:19.319: vmx| Host: SRAT tables not found in memory
Jun 25 11:15:19.490: vmx| ACL_InitCapabilities: current IPC thread
Jun 25 11:15:19.490: vmx| ACL_InitCapabilities: done
Jun 25 11:15:19.490: vmx| changing directory to E:\Virtual Machines\WebStage\.
Jun 25 11:15:19.490: vmx| Config file: E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx
Jun 25 11:15:19.537: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Jun 25 11:15:19.615: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOn without reset
Jun 25 11:15:19.615: vmx| PowerOn
Jun 25 11:15:19.615: vmx| Host: WIN32 highest NUMA node 0
Jun 25 11:15:19.615: vmx| Host: WIN32 NUMA node 0, CPU mask 0x0000000000000003
Jun 25 11:15:19.631: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Jun 25 11:15:19.647: vmx| HOST Windows version 5.2, build 3790, platform 2, "Service Pack 1", SMP
Jun 25 11:15:19.647: vmx| DICT --- USER PREFERENCES
Jun 25 11:15:19.647: vmx| DICT pref.eula.0.appName = VMware Workstation
Jun 25 11:15:19.647: vmx| DICT pref.eula.0.buildNumber = 29772
Jun 25 11:15:19.647: vmx| DICT pref.eula.size = 2
Jun 25 11:15:19.647: vmx| DICT pref.autoFitFullScreen = fitHostToGuest
Jun 25 11:15:19.647: vmx| DICT pref.view.navBar.type = favorites
Jun 25 11:15:19.647: vmx| DICT pref.mruDest0.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest0.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest0.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest1.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest1.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest1.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest2.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest2.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest2.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest3.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest3.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest3.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest4.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest4.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest4.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest5.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest5.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest5.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest6.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest6.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest6.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest7.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruDest7.destString =
Jun 25 11:15:19.647: vmx| DICT pref.mruDest7.user =
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.items.count = 7
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item0.id = POWER_OFF
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item1.id = SUSPEND
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item2.id = POWER_ON
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item3.id = RESET
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item4.id = \_SEP_
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item5.id = PREVIEW_PLAYER
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.item6.id = PREVIEW_WS
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.proj.items.count = 4
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.proj.item0.id = ADD_VM
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.proj.item1.id = POLICIES
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.proj.item2.id = PKG_NEW
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.proj.item3.id = EDIT_SETTINGS
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.items.count = 6
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item0.id = FAVORITES
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item1.id = FULL_SCREEN
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item2.id = QUICK_SWITCH
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item3.id = \_SEP_
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item4.id = SUMMARY
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.item5.id = CONSOLE
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.items.count = 3
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.item0.id = SNAPSHOT
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.item1.id = REVERT
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.item2.id = SNAPSHOT_MANAGER
Jun 25 11:15:19.647: vmx| DICT hint.guestos.xp = FALSE
Jun 25 11:15:19.647: vmx| DICT hint.mainmem.lazySnapshotHint = FALSE
Jun 25 11:15:19.647: vmx| DICT hint.keyboardHook.hookTimeout = FALSE
Jun 25 11:15:19.647: vmx| DICT webUpdate.checkLast = 1182699222
Jun 25 11:15:19.647: vmx| DICT hint.mks.hostAlphaCursor = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.menu.position.ix = 0
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.menu.position.newLine = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.position.ix = 1
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.position.newLine = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.power.position.length = 118
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.position.ix = 2
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.snapshot.position.length = 87
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.position.ix = 3
Jun 25 11:15:19.647: vmx| DICT pref.view.toolbars.view.position.length = 153
Jun 25 11:15:19.647: vmx| DICT pref.placement.left = 197
Jun 25 11:15:19.647: vmx| DICT pref.placement.top = 20
Jun 25 11:15:19.647: vmx| DICT pref.placement.right = 1361
Jun 25 11:15:19.647: vmx| DICT pref.placement.bottom = 1014
Jun 25 11:15:19.647: vmx| DICT pref.tip.startup = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.tip.index = 1
Jun 25 11:15:19.647: vmx| DICT pref.ws.currentObj.path = /vm/#c456e2ea72eb6bd8/
Jun 25 11:15:19.647: vmx| DICT pref.ws.currentObj.type = home
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj0.present = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj0.name = Home
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj1.present = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj1.type = vm
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj1.path = /vm/#c456e2ea72eb6bd8/
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj1.file = E:\Virtual Machines\Win2000Server\Windows 2000 Server.vmx
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj1.name = Windows 2000 Server
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj.maxNum = 0
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj2.present = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj2.name = Oracle 10g Staging
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj3.present = TRUE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj3.type = vm
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj3.path = /vm/#85be1f5aef7a28ae/
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj3.file = C:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj3.name = WebStage
Jun 25 11:15:19.647: vmx| DICT hint.mainmem.lazyResumeHint = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj2.type = vm
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj2.path = /vm/#0e0890b9653170dc/
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj2.file = C:\Virtual Machines\Windows Server 2003 Standard Edition\Windows Server 2003 Standard Edition.vmx
Jun 25 11:15:19.647: vmx| DICT pref.view.navBar = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.snapshotManager.left = 343
Jun 25 11:15:19.647: vmx| DICT pref.snapshotManager.top = 189
Jun 25 11:15:19.647: vmx| DICT pref.snapshotManager.right = 893
Jun 25 11:15:19.647: vmx| DICT pref.snapshotManager.bottom = 669
Jun 25 11:15:19.647: vmx| DICT webUpdate.lastCheck.status = done_updates
Jun 25 11:15:19.647: vmx| DICT pref.eula.1.appName = VMware Workstation
Jun 25 11:15:19.647: vmx| DICT pref.eula.1.buildNumber = 34685
Jun 25 11:15:19.647: vmx| DICT hint.disk.fragmented.low = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj0.type = home
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj0.path =
Jun 25 11:15:19.647: vmx| DICT pref.ws.openedObj0.file =
Jun 25 11:15:19.647: vmx| DICT pref.eula.2.appName = VMware Workstation
Jun 25 11:15:19.647: vmx| DICT pref.eula.2.buildNumber = 45731
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS0.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS1.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS2.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS3.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS4.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS5.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS6.port = 0
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.present = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.atsString =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.domain =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.user =
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.secure = FALSE
Jun 25 11:15:19.647: vmx| DICT pref.mruATS7.port = 0
Jun 25 11:15:19.647: 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
Jun 25 11:15:19.647: vmx| DICT --- USER DEFAULTS
Jun 25 11:15:19.647: vmx| DICT --- HOST DEFAULTS
Jun 25 11:15:19.647: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Jun 25 11:15:19.647: vmx| DICT --- SITE DEFAULTS
Jun 25 11:15:19.647: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Jun 25 11:15:19.647: vmx| DICT --- COMMAND LINE
Jun 25 11:15:19.647: vmx| DICT gui.available = TRUE
Jun 25 11:15:19.647: vmx| DICT --- CONFIGURATION
Jun 25 11:15:19.647: vmx| DICT config.version = 8
Jun 25 11:15:19.647: vmx| DICT virtualHW.version = 4
Jun 25 11:15:19.647: vmx| DICT scsi0.present = TRUE
Jun 25 11:15:19.647: vmx| DICT scsi0.virtualDev = lsilogic
Jun 25 11:15:19.647: vmx| DICT memsize = 384
Jun 25 11:15:19.647: vmx| DICT MemAllowAutoScaleDown = FALSE
Jun 25 11:15:19.647: vmx| DICT scsi0:0.present = TRUE
Jun 25 11:15:19.647: vmx| DICT scsi0:0.fileName = Windows Server 2003 Standard Edition-000007.vmdk
Jun 25 11:15:19.647: vmx| DICT ide1:0.present = TRUE
Jun 25 11:15:19.647: vmx| DICT ide1:0.fileName = auto detect
Jun 25 11:15:19.647: vmx| DICT ide1:0.deviceType = cdrom-raw
Jun 25 11:15:19.647: vmx| DICT floppy0.fileName = A:
Jun 25 11:15:19.647: vmx| DICT ethernet0.present = TRUE
Jun 25 11:15:19.647: vmx| DICT usb.present = TRUE
Jun 25 11:15:19.647: vmx| DICT sound.present = TRUE
Jun 25 11:15:19.647: vmx| DICT sound.virtualDev = es1371
Jun 25 11:15:19.647: vmx| DICT sound.fileName = -1
Jun 25 11:15:19.647: vmx| DICT sound.autodetect = TRUE
Jun 25 11:15:19.647: vmx| DICT displayName = WebStage
Jun 25 11:15:19.647: vmx| DICT guestOS = winnetstandard
Jun 25 11:15:19.647: vmx| DICT nvram = Windows Server 2003 Standard Edition.nvram
Jun 25 11:15:19.647: vmx| DICT scsi0:0.redo =
Jun 25 11:15:19.647: vmx| DICT ide1:0.startConnected = TRUE
Jun 25 11:15:19.647: vmx| DICT ethernet0.addressType = generated
Jun 25 11:15:19.647: vmx| DICT uuid.location = 56 4d ca bd 63 3d 10 21-3c 6d 62 73 42 9a 28 7c
Jun 25 11:15:19.647: vmx| DICT uuid.bios = 56 4d ca bd 63 3d 10 21-3c 6d 62 73 42 9a 28 7c
Jun 25 11:15:19.647: vmx| DICT ide1:0.autodetect = TRUE
Jun 25 11:15:19.647: vmx| DICT ethernet0.generatedAddress = 00:0c:29:9a:28:7c
Jun 25 11:15:19.647: vmx| DICT ethernet0.generatedAddressOffset = 0
Jun 25 11:15:19.647: vmx| DICT tools.syncTime = FALSE
Jun 25 11:15:19.647: vmx| DICT workingDir =
Jun 25 11:15:19.647: vmx| DICT checkpoint.vmState.readOnly = FALSE
Jun 25 11:15:19.647: vmx| DICT checkpoint.vmState =
Jun 25 11:15:19.647: vmx| DICT extendedConfigFile = Windows Server 2003 Standard Edition.vmxf
Jun 25 11:15:19.647: vmx| DICT ethernet0.txbw.limit = 10000
Jun 25 11:15:19.647: vmx| DICT ethernet0.rxbw.limit = 10000
Jun 25 11:15:19.647: vmx| DICT ethernet0.connectionType = bridged
Jun 25 11:15:19.647: vmx| DICT gui.powerOnAtStartup = TRUE
Jun 25 11:15:19.647: vmx| DICT fileSearchPath = .;E:\Virtual Machines\WebStage
Jun 25 11:15:19.647: vmx| DICT sound.startConnected = FALSE
Jun 25 11:15:19.647: vmx| DICT gui.exitAtPowerOff = TRUE
Jun 25 11:15:19.647: vmx| DICT isolation.tools.hgfs.disable = TRUE
Jun 25 11:15:19.647: vmx| DICT virtualHW.productCompatibility = hosted
Jun 25 11:15:19.647: vmx| DICT tools.upgrade.policy = manual
Jun 25 11:15:19.647: vmx| DICT --- USER DEFAULTS
Jun 25 11:15:19.647: vmx| DICT --- HOST DEFAULTS
Jun 25 11:15:19.647: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Jun 25 11:15:19.647: vmx| DICT --- SITE DEFAULTS
Jun 25 11:15:19.647: vmx| DICT prefvmx.useRecommendedLockedMemSize = TRUE
Jun 25 11:15:19.647: vmx| DICT --- GLOBAL SETTINGS
Jun 25 11:15:19.678: vmx| hostCpuFeatures = 0x800001f0
Jun 25 11:15:19.678: vmx| hostNumPerfCounters = 26
Jun 25 11:15:19.694: vmx| WSSCAN: reserved mem (in MB) min=32 max=2936 recommended=2936
Jun 25 11:15:19.694: vmx| hostMem=3064 maxAllowedAll=-1 maxAllowedVM=8192
Jun 25 11:15:19.694: vmx| totOverhead=16
Jun 25 11:15:19.694: vmx| WSSCAN: used rec mem (in MB) 2936
Jun 25 11:15:19.694: vmx| WSSCAN: Overhead 106301 paged 6263 nonpaged 4096 maxFBSize
Jun 25 11:15:19.725: vmx| WSSCAN 4 74760 700163 700163 751616 733149 50 197398
Jun 25 11:15:19.725: vmx| LICENSE using: 'HKEY_LOCAL_MACHINE\SOFTWARE\VMware, Inc.\VMware Workstation\License.ws.6.0.200610'
Jun 25 11:15:19.756: vmx| LOG failed to remove stats32-2 failed: The system cannot find the file specified
Jun 25 11:15:19.756: vmx| LOG failed to remove stats64-2 failed: The system cannot find the file specified
Jun 25 11:15:19.756: vmx| guestCpuFeatures = 0x800001f0
Jun 25 11:15:19.756: vmx| APIC: Host Local APIC at 0xfee00000
Jun 25 11:15:19.772: vmx| vmm32-modules: \[vmm.vmm32 .data:0x2b000 .sdata:0x2c000 .statvars:0x2d000 .peer:0x2e000 .shared:0x54000 .bss:0x65000 .rodata:0x6c000 .text:0x77000 .kstatvars:0x3000 ,mmu-pae.vmm32 .rodata:0x75d6c .data:0x2bdb0 .peer:0x52928 .shared:0x639f0 .bss:0x6abc0 .text:0xc996c .comment:0x40000cf0 .statvars:0x2000 .kstatvars:0x2000 .scb:0x400035a0 .shared_meta:0x400034b0 .peer_meta:0x40000ba0 ,sharedmmu-none.vmm32 .text:0xd3834 .comment:0x40000dec ,pv-none.vmm32 .data:0x2bdcc .peer:0x1000 .shared:0x64300 .bss:0x6b120 .text:0xd3850 .comment:0x40000dfe .statvars:0x1000 .kstatvars:0x1000 .shared_meta:0x40003720 ,hv-none.vmm32 .data:0x2bdd0 .peer:0x1000 .shared:0x1000 .bss:0x6b19c .text:0xd3950 .comment:0x40000e46 .statvars:0x1000 .kstatvars:0x1000 , .rodata:0x75d7c ]
Jun 25 11:15:19.787: vmx| KHZEstimate 2793030
Jun 25 11:15:19.787: vmx| MHZEstimate 2793
Jun 25 11:15:19.787: vmx| NumVCPUs 1
Jun 25 11:15:19.787: vmx| guestCPUID vendor: GenuntelineI
Jun 25 11:15:19.787: vmx| guestCPUID level 00000000, 0: 0x00000003 0x756e6547 0x6c65746e 0x49656e69
Jun 25 11:15:19.787: vmx| guestCPUID level 00000001, 0: 0x00000f48 0x00010800 0x00000011 0x0febbbff
Jun 25 11:15:19.787: vmx| guestCPUID level 00000002, 0: 0x605b5001 0x00000000 0x00000000 0x007c7040
Jun 25 11:15:19.787: vmx| guestCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.787: vmx| guestCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.787: vmx| guestCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100800
Jun 25 11:15:19.787: vmx| guestCPUID level 80000002, 0: 0x20202020 0x20202020 0x20202020 0x6e492020
Jun 25 11:15:19.787: vmx| guestCPUID level 80000003, 0: 0x286c6574 0x50202952 0x69746e65 0x52286d75
Jun 25 11:15:19.787: vmx| guestCPUID level 80000004, 0: 0x20342029 0x20555043 0x30382e32 0x007a4847
Jun 25 11:15:19.787: vmx| guestCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.787: vmx| guestCPUID level 80000006, 0: 0x00000000 0x00000000 0x04006040 0x00000000
Jun 25 11:15:19.787: vmx| guestCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.787: vmx| guestCPUID level 80000008, 0: 0x00002024 0x00000000 0x00000000 0x00000000
Jun 25 11:15:19.787: vmx| PShare: enabled 1, scanRate 32, checkRate 16
Jun 25 11:15:19.787: vmx| UUID: location-UUID is 56 4d c7 95 13 09 9a c3-a4 42 18 4b 71 25 9f f5
Jun 25 11:15:19.787: vmx| UUID: canonical path is e:\virtual machines\webstage\windows server 2003 standard edition.vmx
Jun 25 11:15:19.787: vmx| UUID: location-UUID is 56 4d ca bd 63 3d 10 21-3c 6d 62 73 42 9a 28 7c
Jun 25 11:15:19.787: vmx| MM: Using partialmap, 98304 pages AC 0 CE 1 TM 0 DOHU 0
Jun 25 11:15:19.787: vmx| UUID: canonical path is e:\virtual machines\webstage\windows server 2003 standard edition.vmx
Jun 25 11:15:19.787: vmx| UUID: location-UUID is 56 4d ca bd 63 3d 10 21-3c 6d 62 73 42 9a 28 7c
Jun 25 11:15:19.818: vmx| MM: using 'E:\Virtual Machines\WebStage\564dcabd-633d-1021-3c6d-6273429a287c.vmem' as a paging file
Jun 25 11:15:19.818: vmx| Msg_Reset:
Jun 25 11:15:19.818: vmx| \----
Jun 25 11:15:19.818: vmx| Opened paging file E:\Virtual Machines\WebStage\564dcabd-633d-1021-3c6d-6273429a287c.vmem
Jun 25 11:15:19.818: vmx| Mapped mainmem as pageable
Jun 25 11:15:19.818: vmx| MStat: Creating Stat vm.uptime
Jun 25 11:15:19.818: vmx| MStat: Creating Stat vm.suspendTime
Jun 25 11:15:19.818: vmx| MStat: Creating Stat vm.powerOnTimeStamp
Jun 25 11:15:19.834: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Jun 25 11:15:19.850: vmx| DISK: OPEN scsi0:0 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000007.vmdk' persistent R\[(null)]
Jun 25 11:15:20.022: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000007.vmdk" (0xa)
Jun 25 11:15:20.022: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000007.vmdk' (0xa): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.037: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000009.vmdk" (0xe)
Jun 25 11:15:20.037: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000009.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.068: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000008.vmdk" (0xe)
Jun 25 11:15:20.068: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000008.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.115: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000005.vmdk" (0xe)
Jun 25 11:15:20.115: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000005.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.162: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000006.vmdk" (0xe)
Jun 25 11:15:20.162: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000006.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.178: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000004.vmdk" (0xe)
Jun 25 11:15:20.178: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000004.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.193: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition-000001.vmdk" (0xe)
Jun 25 11:15:20.193: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000001.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.225: vmx| DISKLIB-DSCPTR: Opened : "Windows Server 2003 Standard Edition.vmdk" (0xe)
Jun 25 11:15:20.225: vmx| DISKLIB-LINK : Opened 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmdk' (0xe): monolithicSparse, 41943040 sectors / 20480 Mb.
Jun 25 11:15:20.225: vmx| DISKLIB-LIB : Opened "E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000007.vmdk" (flags 0xa). 17D1014
Jun 25 11:15:20.225: vmx| DiskGetGeometry: Reading of disk partition table
Jun 25 11:15:20.256: vmx| DISK: OPEN 'E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition-000007.vmdk' Geo (2610/255/63) BIOS Geo (2610/255/63) freeSpace=104046Mb, lsilogic
Jun 25 11:15:20.256: vmx| Msg_Reset:
Jun 25 11:15:20.256: vmx| \----
Jun 25 11:15:20.256: vmx| TimeTracker host to guest rate conversion 17309849019505 @ 2793030000Hz -> 17309849019505 @ 2793030000Hz
Jun 25 11:15:20.256: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0
Jun 25 11:15:20.256: vmx| USB: Initializing 'Generic' backend
Jun 25 11:15:20.256: vmx| USBGW: Connected to HCMON version 2.3
Jun 25 11:15:20.256: vmx| USB: Initializing 'Virtual Hub' backend
Jun 25 11:15:20.256: vmx| USB: Initializing 'Virtual Mouse' backend
Jun 25 11:15:20.256: vmx| MKS REMOTE Loading VNC Configuration from VM config file
Jun 25 11:15:20.256: vmx| DISKUTIL: scsi0:0 : capacity=41943040
Jun 25 11:15:20.256: vmx| DISKUTIL: scsi0:0 : geometry=2610/255/63
Jun 25 11:15:20.272: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags.
Jun 25 11:15:20.272: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks
Jun 25 11:15:20.272: vmx| Ethernet0 MAC Address: 00:0c:29:9a:28:7c
Jun 25 11:15:20.272: vmx| MACBW: Setting TX bandwidth to 10000 Kbps
Jun 25 11:15:20.272: vmx| MACBW: Setting RX bandwidth to 10000 Kbps
Jun 25 11:15:20.272: vmx| VMXNET: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks, dontClusterSize is 128
Jun 25 11:15:20.272: vmx| E1000: checksum cycles/kB: C=1183 asm=2901
Jun 25 11:15:20.272: vmx| USB: Initializing 'UHCI' host controller
Jun 25 11:15:20.272: vmx| MStat: Creating Stat vm.heartbeat
Jun 25 11:15:20.272: vmx| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:15:20.272: vmx| TOOLS INSTALL initializing state to IDLE on power on.
Jun 25 11:15:20.272: vmx| PTSC to VMI Wallclock (nsec) 17309898914217 @ 2793030000Hz -> 1182741320000000000 @ 1000000000Hz
Jun 25 11:15:20.272: vmx| PTSC to VMI Wallclock (nsec) ((x * 3075489555) >> 33) + 1182735122465811747
Jun 25 11:15:20.272: vmx| VirtualProtect MapProtectMem(0x1cc0000,0x1000) returns 0x1e7
Jun 25 11:15:20.272: vmx| VirtualProtect MapProtectMem(0x1cc2000,0x0) returns 0x57
Jun 25 11:15:20.303: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '1'
Jun 25 11:15:20.303: vmx| TOOLS received request in VMX to set option 'copypaste' -> '1'
Jun 25 11:15:20.350: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1
Jun 25 11:15:20.350: vmx| VMX setting maximum IPC write buffers to 0 packets, 0 bytes
Jun 25 11:15:20.350: mks| Async MKS thread is alive
Jun 25 11:15:20.365: vmx| DnD rpc already set to 1
Jun 25 11:15:20.365: vmx| DnD CopyPasteRegisterRpc already set to 1
Jun 25 11:15:20.365: vcpu-0| APIC: version = 0x14, max LVT = 5
Jun 25 11:15:20.365: vcpu-0| APIC: LDR = 0x2000000, DFR = 0xffffffff
Jun 25 11:15:20.397: vcpu-0| guestCpuFeatures = 0x800001f0
Jun 25 11:15:20.397: vcpu-0| Init modules.
Jun 25 11:15:20.412: vcpu-0| CPU reset: hard
Jun 25 11:15:20.412: vmx| VNET: Notification enabled for Ethernet0
Jun 25 11:15:21.428: vmx| FLOPPYLIB-LIB : Sync: syserror Incorrect function.
Jun 25 11:15:21.428: vmx| CDROM: Using autodetect backend 😧 for ide1:0.
Jun 25 11:15:21.428: vmx| CDROM: Connecting ide1:0 to 'D:'. img=0 raw=1 excl=0 remote=0
Jun 25 11:15:21.522: mks| Connecting to window system.
Jun 25 11:15:21.522: mks| KHBKL: Unable to parse keystring at: ''
Jun 25 11:15:21.522: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:21.522: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:21.568: vcpu-0| sz=3055584
Jun 25 11:15:21.584: vcpu-0| vmm32 initialized: Releasebuild-45731. cflags: 0x20000002.18000000.54000600.00000002
Jun 25 11:15:21.584: vcpu-0| MonitorInitNumaUnmapVMM32
Jun 25 11:15:22.037: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0x0) and 0xe8000000(0x0)
Jun 25 11:15:22.053: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:22.084: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:22.100: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:22.100: vcpu-0| SVGA: Registering IOSpace at 0x14c0
Jun 25 11:15:22.100: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:22.240: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:22.240: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:22.271: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:22.271: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:22.287: vmx| USB: Found device \[name:Hewlett-Packard\ Printer vid:03f0 pid:4f11 path:1/3/1 speed:full family:vendor,printer]
Jun 25 11:15:22.287: vmx| USB: Found device \[name:Cypress\ Removable\ Disk vid:04b4 pid:6830 path:1/4/6 speed:high family:storage]
Jun 25 11:15:22.287: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Jun 25 11:15:22.975: vcpu-0| CDROM-WIN: 'D:' Length 24 MaxTransferLength 131072 MaxPhysPages 32
Jun 25 11:15:22.975: vcpu-0| CDROM-WIN: AlignMask 0x1 !AsyncEvent !TaggedQ ScanUp PIO
Jun 25 11:15:23.693: vcpu-0| DISKUTIL: scsi0:0 : geometry=2610/255/63
Jun 25 11:15:25.162: vcpu-0| BIOS-UUID is 56 4d ca bd 63 3d 10 21-3c 6d 62 73 42 9a 28 7c
Jun 25 11:15:25.615: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:15:25.615: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:15:25.631: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:25.631: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:26.693: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.693: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.771: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.787: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.802: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.865: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.881: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.896: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.959: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.974: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:26.990: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:27.052: vcpu-0| FLOPPYLIB-LIB : Win32Ioctl: syserror The device is not ready.
Jun 25 11:15:27.427: vcpu-0| Unknown int 10h func 0x2000
Jun 25 11:15:34.692: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:34.692: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:34.724: mks| Ignoring update request in VGA_Expose (mode change pending).
Jun 25 11:15:35.786: vcpu-0| UHCI: Global Reset
Jun 25 11:15:36.130: vcpu-0| SVGA: Unregistering IOSpace at 0x14c0
Jun 25 11:15:36.130: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:36.130: vcpu-0| SVGA: Registering IOSpace at 0x14c0
Jun 25 11:15:36.130: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:37.333: vcpu-0| SCSI-DEV0:0: Unsupported command READ BUFFER issued. --ok
Jun 25 11:15:37.333: vcpu-0| SCSI-DEV0:0: Unsupported command READ BUFFER issued. --ok
Jun 25 11:15:37.348: vcpu-0| SCSI DEVICE (scsi0:0): INQUIRY request with EVPD set
Jun 25 11:15:37.411: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x1c
Jun 25 11:15:45.973: vmx| VIDE: ATAPI DMA 0xad Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:15:45.988: vcpu-0| VNET: Notification enabled for Ethernet0
Jun 25 11:15:46.004: vcpu-0| Guest: VMXNET: Initialization completed successfully. Version 2.0
Jun 25 11:15:46.223: vcpu-0| SVGA: Unregistering IOSpace at 0x14c0
Jun 25 11:15:46.223: vcpu-0| SVGA: Unregistering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:46.238: vcpu-0| SVGA: Registering IOSpace at 0x14c0
Jun 25 11:15:46.238: vcpu-0| SVGA: Registering MemSpace at 0xf0000000(0xf0000000) and 0xe8000000(0xe8000000)
Jun 25 11:15:46.410: vcpu-0| Guest OS = 0x5008
Jun 25 11:15:46.457: vcpu-0| UHCI: Global Reset
Jun 25 11:15:47.785: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:15:47.785: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:15:47.801: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:15:47.816: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.342 seconds (ok)
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.343 seconds (ok)
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.343 seconds (ok)
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.338 seconds (ok)
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.339 seconds (ok)
Jun 25 11:15:49.348: vmx| SCSI0:0: Command READ(10) took 1.338 seconds (ok)
Jun 25 11:15:49.363: vmx| SCSI0:0: Command READ(10) took 1.068 seconds (ok)
Jun 25 11:15:49.363: vmx| SCSI0:0: Command READ(10) took 1.065 seconds (ok)
Jun 25 11:15:49.363: vmx| SCSI0:0: Command READ(10) took 1.064 seconds (ok)
Jun 25 11:15:49.363: vmx| SCSI0:0: Command READ(10) took 1.032 seconds (ok)
Jun 25 11:15:52.175: vmx| SCSI0:0: Command READ(10) took 1.312 seconds (ok)
Jun 25 11:15:52.488: vmx| SCSI0:0: Command READ(10) took 1.708 seconds (ok)
Jun 25 11:15:52.488: vmx| SCSI0:0: Command READ(10) took 1.709 seconds (ok)
Jun 25 11:15:52.550: vmx| SCSI0:0: Command READ(10) took 1.766 seconds (ok)
Jun 25 11:15:52.566: vmx| SCSI0:0: Command READ(10) took 1.738 seconds (ok)
Jun 25 11:15:52.613: vmx| SCSI0:0: Command READ(10) took 1.802 seconds (ok)
Jun 25 11:15:52.629: vmx| SCSI0:0: Command READ(10) took 1.822 seconds (ok)
Jun 25 11:15:52.629: vmx| SCSI0:0: Command READ(10) took 1.748 seconds (ok)
Jun 25 11:15:52.644: vmx| SCSI0:0: Command READ(10) took 1.745 seconds (ok)
Jun 25 11:15:52.644: vmx| SCSI0:0: Command READ(10) took 1.746 seconds (ok)
Jun 25 11:15:52.644: vmx| SCSI0:0: Command READ(10) took 1.798 seconds (ok)
Jun 25 11:15:52.644: vmx| SCSI0:0: Command READ(10) took 1.808 seconds (ok)
Jun 25 11:15:53.535: vmx| SCSI0:0: Command READ(10) took 1.263 seconds (ok)
Jun 25 11:15:53.535: vmx| SCSI0:0: Command READ(10) took 1.247 seconds (ok)
Jun 25 11:15:53.628: vmx| SCSI0:0: Command READ(10) took 2.851 seconds (ok)
Jun 25 11:15:53.675: vmx| SCSI0:0: Command READ(10) took 1.721 seconds (ok)
Jun 25 11:15:53.753: vmx| SCSI0:0: Command READ(10) took 1.195 seconds (ok)
Jun 25 11:15:54.050: vmx| SCSI0:0: Command READ(10) took 1.170 seconds (ok)
Jun 25 11:15:54.050: vmx| SCSI0:0: Command READ(10) took 1.169 seconds (ok)
Jun 25 11:15:54.207: vmx| SCSI0:0: Command READ(10) took 1.399 seconds (ok)
Jun 25 11:15:54.207: vmx| SCSI0:0: Command READ(10) took 1.398 seconds (ok)
Jun 25 11:15:54.269: vmx| SCSI0:0: Command READ(10) took 1.624 seconds (ok)
Jun 25 11:15:54.441: vmx| SCSI0:0: Command READ(10) took 2.184 seconds (ok)
Jun 25 11:15:54.441: vmx| SCSI0:0: Command READ(10) took 2.179 seconds (ok)
Jun 25 11:15:54.457: vmx| SCSI0:0: Command READ(10) took 1.997 seconds (ok)
Jun 25 11:15:54.457: vmx| SCSI0:0: Command READ(10) took 1.972 seconds (ok)
Jun 25 11:15:54.457: vmx| SCSI0:0: Command READ(10) took 1.972 seconds (ok)
Jun 25 11:15:54.457: vmx| SCSI0:0: Command READ(10) took 1.952 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.878 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.878 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.867 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.873 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.873 seconds (ok)
Jun 25 11:15:54.472: vmx| SCSI0:0: Command READ(10) took 1.873 seconds (ok)
Jun 25 11:15:54.519: vmx| SCSI0:0: Command READ(10) took 1.047 seconds (ok)
Jun 25 11:15:54.566: vmx| SCSI0:0: Command READ(10) took 1.065 seconds (ok)
Jun 25 11:15:54.597: vmx| SCSI0:0: Command READ(10) took 1.117 seconds (ok)
Jun 25 11:15:54.660: vmx| SCSI0:0: Command READ(10) took 2.006 seconds (ok)
Jun 25 11:15:54.660: vmx| SCSI0:0: Command READ(10) took 2.003 seconds (ok)
Jun 25 11:15:54.660: vmx| SCSI0:0: Command READ(10) took 2.003 seconds (ok)
Jun 25 11:15:54.660: vmx| SCSI0:0: Command READ(10) took 1.850 seconds (ok)
Jun 25 11:15:54.691: vmx| SCSI0:0: Command READ(10) took 1.416 seconds (ok)
Jun 25 11:15:54.691: vmx| SCSI0:0: Command READ(10) took 1.081 seconds (ok)
Jun 25 11:15:54.691: vmx| SCSI0:0: Command READ(10) took 1.067 seconds (ok)
Jun 25 11:15:57.831: mks| MKS remote display status changed, enabling remote optimizations
Jun 25 11:16:00.034: mks| HostOps hideCursor before defineCursor!
Jun 25 11:16:05.721: vcpu-0| GuestRpc: Channel 0, registration number 1, guest application tools-hgfs.
Jun 25 11:16:05.721: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:16:17.674: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:16:17.674: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:16:17.767: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:16:17.767: vmx| VIDE: ATAPI DMA 0x25 Failed: key 0x2, asc 0x3a, ascq 0x0
Jun 25 11:16:24.126: vcpu-0| GuestRpc: Channel 1, registration number 1, guest application toolbox.
Jun 25 11:16:24.126: vcpu-0| TOOLS Reducing idleLoopSpinUS to 500us
Jun 25 11:16:24.126: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:16:24.126: vmx| SOCKET 1 client closed connection
Jun 25 11:16:24.126: vmx| SOCKET 2 client closed connection
Jun 25 11:16:24.142: vcpu-0| TOOLS autoupgrade protocol version 2
Jun 25 11:16:24.142: vcpu-0| TOOLS ToolsCapabilityGuestTempDirectory received 1 C:\WINDOWS\TEMP
Jun 25 11:16:24.142: vcpu-0| TOOLS setting the tools version to '7238'
Jun 25 11:16:24.236: vcpu-0| VMXVmdbGuest_GetGuestUptime failed. ret = Type mismatch
Jun 25 11:16:24.236: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:16:24.236: vcpu-0| TOOLS installed version 7238, available version 7238
Jun 25 11:16:24.236: vcpu-0| TOOLS don't need to be upgraded.
Jun 25 11:16:24.282: vcpu-0| Guest: toolbox: Version: build-45731
Jun 25 11:16:24.282: vcpu-0| TOOLS unified loop capability requested by 'toolbox'; now sending options via TCLO
Jun 25 11:17:07.451: vcpu-0| VMMouse: CMD Read ID
Jun 25 11:17:07.451: vcpu-0| MKS switching absolute mouse on
Jun 25 11:17:33.855: vmx| SOCKET 3 client closed connection
Jun 25 11:17:38.558: vmx| SOCKET 4 client closed connection
Jun 25 11:17:44.292: vcpu-0| MKS Backdoor get pointer: first time, notify tools are running
Jun 25 11:17:44.948: vcpu-0| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO
Jun 25 11:17:44.948: vcpu-0| GuestRpc: Channel 2, registration number 1, guest application toolbox-dnd.
Jun 25 11:17:44.948: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7238
Jun 25 11:17:44.979: vmx| DnD rpc already set to 1
Jun 25 11:17:44.979: vmx| DnD CopyPasteRegisterRpc already set to 1
Jun 25 11:17:44.979: vmx| DnD rpc already set to 1
Jun 25 11:17:44.979: vmx| DnD CopyPasteRegisterRpc already set to 1
Jun 25 11:17:45.339: vmx| DnD rpc already set to 1
Jun 25 11:17:45.339: vmx| DnD CopyPasteRegisterRpc already set to 1
Jun 25 11:17:58.026: vmx| SOCKET 6 client closed connection
Jun 25 11:17:58.682: vmx| SOCKET 7 client closed connection
Jun 25 11:18:09.713: vmx| SOCKET 8 client closed connection
Jun 25 11:18:09.900: vmx| SOCKET 9 client closed connection
Jun 25 11:18:20.947: vmx| Stopping VCPU threads...
Jun 25 11:18:20.963: mks| Detaching from window system.
Jun 25 11:18:20.963: mks| Async MKS thread is exiting
Jun 25 11:18:20.963: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0'
Jun 25 11:18:20.963: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Jun 25 11:18:20.963: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Jun 25 11:18:20.963: vmx| MKS local poweroff
Jun 25 11:18:20.978: vmx| scsi0:0: numIOs = 9738 numMergedIOs = 1005 numSplitIOs = 375 (27.2%)
Jun 25 11:18:20.994: vmx| AIOWIN32: asyncOps=11086 syncOps=72 bufSize=280Kb delayed=2672 fixed=483 sgOp=9158 sgOn=1
Jun 25 11:18:21.072: vmx| WORKER: asyncOps=346 maxActiveOps=1 maxPending=0 maxCompleted=0
Jun 25 11:18:21.541: vmx| vmdbPipe_Streams: Couldn't read
Jun 25 11:18:21.541: vmx| VMX idle exit
Jun 25 11:18:21.541: vmx| Flushing VMX VMDB connections
Jun 25 11:18:21.541: vmx| IPC_exit: disconnecting all threads
Jun 25 11:18:21.541: vmx| VMX exit (0).
Jun 25 11:18:21.541: vmx| AIOMGR-S : stat o=8 r=24 w=0 i=0 br=102400 bw=0
What the exact contents of your script, and can you post a copy of the UI log (typically located in %TEMP%\vmware-yourUserName\vmware-yourUserName-processID; you'll have to copy it before you quit, because it's normally deleted when Workstation closes).
Script:
echo %date% %time% >> E:\NightlyBuild\VMRollback.log started
REM change the directory back to where the VM files are located
REM the next three remarks are the same for each VM to be reloaded
REM we need to stop the VM because it won't start from command line otherwise
REM then revert the VM to it's base snapshot, sleep function pauses the batch file for n seconds (10 in this case)
REM then start power on the VM
cd C:\Program Files\VMware\VMware Workstation
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Stopping VMs
vmrun stop "E:\Virtual Machines\XP Pro SP2\Windows XP Professional.vmx"
sleep 10
vmrun stop "E:\Virtual Machines\Windows Server 2003 Standard Edition\Windows Server 2003 Standard Edition.vmx"
sleep 10
vmrun stop "E:\Virtual Machines\SQL Server 2005\Windows Server 2003 Standard Edition.vmx"
sleep 10
vmrun stop "E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx"
sleep 10
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Completed Stopping VMs
sleep 10
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Reverting VMs To Baseline
vmrun revertToSnapshot "E:\Virtual Machines\XP Pro SP2\Windows XP Professional.vmx" XPProBaseline
vmrun revertToSnapshot "E:\Virtual Machines\Windows Server 2003 Standard Edition\Windows Server 2003 Standard Edition.vmx" OracleBaseline
vmrun revertToSnapshot "E:\Virtual Machines\SQL Server 2005\Windows Server 2003 Standard Edition.vmx" SQLBaseline
vmrun revertToSnapshot "E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx" WebStageBaseline
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Completed Reverting
sleep 30
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Starting Up VMs
vmrun start "E:\Virtual Machines\XP Pro SP2\Windows XP Professional.vmx"
sleep 30
vmrun start "E:\Virtual Machines\Windows Server 2003 Standard Edition\Windows Server 2003 Standard Edition.vmx"
sleep 30
vmrun start "E:\Virtual Machines\SQL Server 2005\Windows Server 2003 Standard Edition.vmx"
sleep 30
vmrun start "E:\Virtual Machines\WebStage\Windows Server 2003 Standard Edition.vmx"
echo %date% %time% >> E:\NightlyBuild\VMRollback.log --- Completed Starting Up of VMs
sleep 10
REM Change directory to where the log file is located
REM Send the current date and time of completion to the log file
echo %date% %time% >> E:\NightlyBuild\VMRollback.log completed
can't find the UI log does it hava a particular name i could search?
You'll have to reproduce the problem and then, as I said, copy the UI log before closing Workstation. It doesn't have a fixed name; it changes every time you run Workstation.
The file should be in a location like:
C:\Documents and Settings\yourUserName\Local Settings\Temp\vmware-yourUserName\vmware-yourUserName-pid.log[/code]
I replicated the error but no UI log file was created in the path specified. It was empty.
Do you have the TEMP environment variable set to something else? Have you edited Workstation's config.ini file to tell it to store the UI log somewhere else?
nope the path u specified looks like the right place it would be. dunno... thanks for tryin to help me... might just to re-create the VM...