Oct 26 08:51:50.724: vmx| Log for VMware Player pid=3824 version=3.1.2 build=build-301548 option=Release Oct 26 08:51:50.724: vmx| The process is 64-bit. Oct 26 08:51:50.724: vmx| Host codepage=windows-1252 encoding=windows-1252 Oct 26 08:51:50.724: vmx| Hostname=PCG-PC-08.PCG.lan Oct 26 08:51:50.727: vmx| IP=(Unknown) Oct 26 08:51:50.727: vmx| IP=(Unknown) Oct 26 08:51:50.727: vmx| IP=(Unknown) Oct 26 08:51:50.727: vmx| IP=169.254.184.177 Oct 26 08:51:50.727: vmx| IP=192.168.101.115 Oct 26 08:51:50.727: vmx| IP=192.168.131.1 Oct 26 08:51:50.727: vmx| Command line: "C:\Program Files (x86)\VMware\VMware Player\x64\vmware-vmx.exe" "-T" "querytoken" "-ssnapshot.numRollingTiers=0" "-sRemoteDisplay.vnc.enabled=FALSE" "-s" "vmx.stdio.keep=TRUE" "-#" "product=8;name=VMware Player;version=3.1.2;buildnumber=301548;licensename=VMware Player;licenseversion=6.0;" "-@" "pipe=\\.\pipe\vmxd5e68e77db0ca029;" "D:\VMFS\xubu1004\xubu1004.vmx" Oct 26 08:51:50.727: vmx| Msg_SetLocale: HostLocale=windows-1252 UserLocale=NULL Oct 26 08:51:50.765: vmx| UI Connecting to pipe '\\.\pipe\vmxd5e68e77db0ca029' with user '(null)' Oct 26 08:51:50.765: vmx| VMXVmdb: Local connection timeout: 60000 ms. Oct 26 08:51:50.784: vmx| Vix: [3840 mainDispatch.c:374]: VMAutomation: Initializing VMAutomation. Oct 26 08:51:50.784: vmx| Vix: [3840 mainDispatch.c:397]: VMAutomation: Detected the VM is not managed Oct 26 08:51:50.785: vmx| Vix: [3840 mainDispatch.c:658]: VMAutomationOpenListenerSocket() listening Oct 26 08:51:50.786: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 Oct 26 08:51:50.786: vmx| Transitioned vmx/execState/val to poweredOff Oct 26 08:51:50.786: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 Oct 26 08:51:50.786: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=2, newAppState=1877, success=1 Oct 26 08:51:50.786: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1881, success=1 Oct 26 08:51:50.786: vmx| HOSTINFO 1879801564 @ 2630156Hz -> 0 @ 1000000Hz Oct 26 08:51:50.786: vmx| HOSTINFO ((x * 3265941104) >> 33) + -714711052 Oct 26 08:51:50.787: vmx| HD: host version is 6.1.7600 Oct 26 08:51:50.787: vmx| HD: addr fffff80002aa0ee0 Oct 26 08:51:50.787: vmx| HD: fffff80002c0bc00, 0 Oct 26 08:51:50.787: vmx| Can't set WSS, error 1314 Oct 26 08:51:50.787: vmx| VerificationOfHostParameters status 1 Oct 26 08:51:50.787: vmx| Failed to verify host parameters Oct 26 08:51:50.787: vmx| VMMon_GetkHzEstimate: Calculated 2693280 kHz Oct 26 08:51:50.787: vmx| VMMon_RememberkHzEstimate: Calculated 2693309 kHz Oct 26 08:51:50.787: vmx| TSC kHz estimates: vmmon 2693280, remembered 2693309, osReported 2700000. Using 2693309 kHz. Oct 26 08:51:50.787: vmx| CPU # 0 TSC = 1924920355770 Oct 26 08:51:50.787: vmx| CPU # 1 TSC = 1924920355734 Oct 26 08:51:50.787: vmx| TSC delta 36 Oct 26 08:51:50.787: vmx| CPU # 0 TSC = 1924920457871 Oct 26 08:51:50.787: vmx| CPU # 1 TSC = 1924920457780 Oct 26 08:51:50.787: vmx| TSC delta 91 Oct 26 08:51:50.787: vmx| CPU # 0 TSC = 1924920532242 Oct 26 08:51:50.787: vmx| CPU # 1 TSC = 1924920532165 Oct 26 08:51:50.787: vmx| TSC delta 77 Oct 26 08:51:50.787: vmx| CPU # 0 TSC = 1924920606033 Oct 26 08:51:50.787: vmx| CPU # 1 TSC = 1924920605956 Oct 26 08:51:50.787: vmx| TSC delta 77 Oct 26 08:51:50.787: vmx| TSC min delta 77 Oct 26 08:51:50.787: vmx| PTSC: RefClockToTSC 2630156Hz -> 2693309000Hz Oct 26 08:51:50.787: vmx| PTSC: RefClockToTSC ((x * 2147506975) >> 21) Oct 26 08:51:50.787: vmx| PTSC: using TSC Oct 26 08:51:50.788: vmx| CPUID[0] vendor: GenuineIntel Oct 26 08:51:50.788: vmx| CPUID[0] name: Pentium(R) Dual-Core CPU E5400 @ 2.70GHz Oct 26 08:51:50.788: vmx| CPUID[0] level 00000000, 0: 0x0000000d 0x756e6547 0x6c65746e 0x49656e69 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000001, 0: 0x0001067a 0x00020800 0x0c00e3bd 0xbfebfbff Oct 26 08:51:50.788: vmx| CPUID[0] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb4307d Oct 26 08:51:50.788: vmx| CPUID[0] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000006, 0: 0x00000001 0x00000002 0x00000003 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503 Oct 26 08:51:50.788: vmx| CPUID[0] level 0000000b, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 0000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 0000000d, 0: 0x00000003 0x00000240 0x00000240 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000002, 0: 0x746e6550 0x286d7569 0x44202952 0x2d6c6175 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000003, 0: 0x65726f43 0x50432020 0x20202055 0x45202020 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000004, 0: 0x30303435 0x20402020 0x30372e32 0x007a4847 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000006, 0: 0x00000000 0x00000000 0x08006040 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[0] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] vendor: GenuineIntel Oct 26 08:51:50.788: vmx| CPUID[1] name: Pentium(R) Dual-Core CPU E5400 @ 2.70GHz Oct 26 08:51:50.788: vmx| CPUID[1] level 00000000, 0: 0x0000000d 0x756e6547 0x6c65746e 0x49656e69 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000001, 0: 0x0001067a 0x01020800 0x0c00e3bd 0xbfebfbff Oct 26 08:51:50.788: vmx| CPUID[1] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb4307d Oct 26 08:51:50.788: vmx| CPUID[1] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000006, 0: 0x00000001 0x00000002 0x00000003 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503 Oct 26 08:51:50.788: vmx| CPUID[1] level 0000000b, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 0000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 0000000d, 0: 0x00000003 0x00000240 0x00000240 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000002, 0: 0x746e6550 0x286d7569 0x44202952 0x2d6c6175 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000003, 0: 0x65726f43 0x50432020 0x20202055 0x45202020 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000004, 0: 0x30303435 0x20402020 0x30372e32 0x007a4847 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000006, 0: 0x00000000 0x00000000 0x08006040 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID[1] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID vendor: GenuineIntel Oct 26 08:51:50.788: vmx| hostCPUID name: Pentium(R) Dual-Core CPU E5400 @ 2.70GHz Oct 26 08:51:50.788: vmx| hostCPUID level 00000000, 0: 0x0000000d 0x756e6547 0x6c65746e 0x49656e69 Oct 26 08:51:50.788: vmx| hostCPUID level 00000001, 0: 0x0001067a 0x00020800 0x0c00e3bd 0xbfebfbff Oct 26 08:51:50.788: vmx| hostCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb4307d Oct 26 08:51:50.788: vmx| hostCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001 Oct 26 08:51:50.788: vmx| hostCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220 Oct 26 08:51:50.788: vmx| hostCPUID level 00000006, 0: 0x00000001 0x00000002 0x00000003 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503 Oct 26 08:51:50.788: vmx| hostCPUID level 0000000b, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 0000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 0000000d, 0: 0x00000003 0x00000240 0x00000240 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800 Oct 26 08:51:50.788: vmx| hostCPUID level 80000002, 0: 0x746e6550 0x286d7569 0x44202952 0x2d6c6175 Oct 26 08:51:50.788: vmx| hostCPUID level 80000003, 0: 0x65726f43 0x50432020 0x20202055 0x45202020 Oct 26 08:51:50.788: vmx| hostCPUID level 80000004, 0: 0x30303435 0x20402020 0x30372e32 0x007a4847 Oct 26 08:51:50.788: vmx| hostCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 80000006, 0: 0x00000000 0x00000000 0x08006040 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| hostCPUID level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000 Oct 26 08:51:50.788: vmx| CPUID Maximum Physical Address Bits supported across all CPUs: 36 Oct 26 08:51:50.788: vmx| CPU[0]: MSR 0x3a = 0xd Oct 26 08:51:50.788: vmx| CPU[1]: MSR 0x3a = 0xd Oct 26 08:51:50.788: vmx| Common: MSR 0x3a = 0x5 Oct 26 08:51:50.788: vmx| CPU[0]: MSR 0x480 = 0x5a08000000000d Oct 26 08:51:50.788: vmx| CPU[1]: MSR 0x480 = 0x5a08000000000d Oct 26 08:51:50.788: vmx| Common: MSR 0x480 = 0x5a08000000000d Oct 26 08:51:50.788: vmx| CPU[0]: MSR 0x481 = 0x3f00000016 Oct 26 08:51:50.788: vmx| CPU[1]: MSR 0x481 = 0x3f00000016 Oct 26 08:51:50.788: vmx| Common: MSR 0x481 = 0x3f00000016 Oct 26 08:51:50.788: vmx| CPU[0]: MSR 0x482 = 0xf7f9fffe0401e172 Oct 26 08:51:50.788: vmx| CPU[1]: MSR 0x482 = 0xf7f9fffe0401e172 Oct 26 08:51:50.788: vmx| Common: MSR 0x482 = 0xf7f9fffe0401e172 Oct 26 08:51:50.788: vmx| CPU[0]: MSR 0x483 = 0x3ffff00036dff Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x483 = 0x3ffff00036dff Oct 26 08:51:50.789: vmx| Common: MSR 0x483 = 0x3ffff00036dff Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x484 = 0x3fff000011ff Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x484 = 0x3fff000011ff Oct 26 08:51:50.789: vmx| Common: MSR 0x484 = 0x3fff000011ff Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x485 = 0x403c0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x485 = 0x403c0 Oct 26 08:51:50.789: vmx| Common: MSR 0x485 = 0x403c0 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x486 = 0x80000021 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x486 = 0x80000021 Oct 26 08:51:50.789: vmx| Common: MSR 0x486 = 0x80000021 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x487 = 0xffffffff Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x487 = 0xffffffff Oct 26 08:51:50.789: vmx| Common: MSR 0x487 = 0xffffffff Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x488 = 0x2000 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x488 = 0x2000 Oct 26 08:51:50.789: vmx| Common: MSR 0x488 = 0x2000 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x489 = 0x427ff Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x489 = 0x427ff Oct 26 08:51:50.789: vmx| Common: MSR 0x489 = 0x427ff Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48a = 0x2c Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48a = 0x2c Oct 26 08:51:50.789: vmx| Common: MSR 0x48a = 0x2c Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48b = 0x4100000000 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48b = 0x4100000000 Oct 26 08:51:50.789: vmx| Common: MSR 0x48b = 0x4100000000 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48c = 0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48c = 0 Oct 26 08:51:50.789: vmx| Common: MSR 0x48c = 0 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48d = 0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48d = 0 Oct 26 08:51:50.789: vmx| Common: MSR 0x48d = 0 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48e = 0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48e = 0 Oct 26 08:51:50.789: vmx| Common: MSR 0x48e = 0 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x48f = 0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x48f = 0 Oct 26 08:51:50.789: vmx| Common: MSR 0x48f = 0 Oct 26 08:51:50.789: vmx| CPU[0]: MSR 0x490 = 0 Oct 26 08:51:50.789: vmx| CPU[1]: MSR 0x490 = 0 Oct 26 08:51:50.789: vmx| Common: MSR 0x490 = 0 Oct 26 08:51:50.807: vmx| Host ACPI: can't find SRAT Oct 26 08:51:50.807: vmx| Host: SRAT tables not found in memory Oct 26 08:51:50.807: vmx| Setting thread 36 stack size to 1048576. Oct 26 08:51:50.808: WinNotifyThread| WinNotify thread is alive Oct 26 08:51:51.033: vmx| ConfigCheck: No rules file found. Checks are disabled. Oct 26 08:51:51.033: vmx| changing directory to D:\VMFS\xubu1004\. Oct 26 08:51:51.033: vmx| Config file: D:\VMFS\xubu1004\xubu1004.vmx Oct 26 08:51:51.034: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 Oct 26 08:51:51.034: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=2, newAppState=1878, success=1 Oct 26 08:51:51.075: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:51:51.124: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOn without reset, soft, softOptionTimeout: 0. Oct 26 08:51:51.124: vmx| TOOLS delaying state change request to state 3 (callback 0, clientData 0) Oct 26 08:51:51.125: vmx| PowerOn Oct 26 08:51:51.125: vmx| VMX_PowerOn: VMX build 301548, UI build 301548 Oct 26 08:51:51.125: vmx| Host: WIN32 highest NUMA node 0 Oct 26 08:51:51.125: vmx| Host: WIN32 NUMA node 0, CPU mask 0x0000000000000003 Oct 26 08:51:51.130: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:51:51.134: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1871, success=1 Oct 26 08:51:51.134: vmx| HOST Windows version 6.1, build 7600, platform 2, "", SMP Oct 26 08:51:51.134: vmx| DICT --- USER PREFERENCES C:\Users\clive.darracott\AppData\Roaming\VMware\preferences.ini Oct 26 08:51:51.134: vmx| DICT pref.eula.0.appName = VMware Player Oct 26 08:51:51.134: vmx| DICT pref.eula.0.buildNumber = 282343 Oct 26 08:51:51.134: vmx| DICT pref.trayicon.enabled = true Oct 26 08:51:51.134: vmx| DICT pref.usbDev.maxDevs = 0 Oct 26 08:51:51.134: vmx| DICT pref.keyboardAndMouse.maxProfiles = 0 Oct 26 08:51:51.134: vmx| DICT pref.mruVM0.filename = D:\VMFS\xubu1004\xubu1004.vmx Oct 26 08:51:51.134: vmx| DICT pref.mruVM0.displayname = xubu1004 Oct 26 08:51:51.134: vmx| DICT hint.vmui.showAllUSBDevs = FALSE Oct 26 08:51:51.134: vmx| DICT pref.eula.1.appName = VMware Player Oct 26 08:51:51.134: vmx| DICT pref.eula.1.buildNumber = 301548 Oct 26 08:51:51.134: vmx| DICT pref.vmplayer.componentDownloadPermission = deny Oct 26 08:51:51.134: vmx| DICT pref.vmplayer.returnToLibraryAfterClose = TRUE Oct 26 08:51:51.134: vmx| DICT pref.vmplayer.exit.vmAction = poweroff Oct 26 08:51:51.134: vmx| DICT pref.vmplayer.confirmOnExit = TRUE Oct 26 08:51:51.134: vmx| DICT pref.autoFitFullScreen = fitHostToGuest Oct 26 08:51:51.134: vmx| DICT pref.view.navBar.type = favorites Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.items.count = 4 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item0.id = POWER_OFF Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item1.id = SUSPEND Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item2.id = POWER_ON Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item3.id = RESET Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item4.id = _SEP_ Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item5.id = PREVIEW_PLAYER Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.item6.id = PREVIEW_WS Oct 26 08:51:51.134: vmx| DICT webUpdate.checkPeriod = manual Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.proj.items.count = 4 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.proj.item0.id = ADD_VM Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.proj.item1.id = POLICIES Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.proj.item2.id = PKG_NEW Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.proj.item3.id = EDIT_SETTINGS Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.items.count = 3 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.item0.id = SNAPSHOT Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.item1.id = REVERT Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.item2.id = SNAPSHOT_MANAGER Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.items.count = 6 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item0.id = FAVORITES Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item1.id = FULL_SCREEN Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item2.id = QUICK_SWITCH Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item3.id = _SEP_ Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item4.id = SUMMARY Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.item5.id = CONSOLE Oct 26 08:51:51.134: vmx| DICT webUpdate.checkLast = 1287138821 Oct 26 08:51:51.134: vmx| DICT pref.autoFit = FALSE Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.menu.position.ix = 0 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.menu.position.newLine = TRUE Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.position.ix = 3 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.power.position.length = 1010 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot = FALSE Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.position.ix = 1 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.snapshot.position.length = 87 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.position.ix = 2 Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.position.newLine = TRUE Oct 26 08:51:51.134: vmx| DICT pref.view.toolbars.view.position.length = 166 Oct 26 08:51:51.134: vmx| DICT pref.saveOpenedObjs = TRUE Oct 26 08:51:51.134: vmx| DICT pref.cnxType = remote Oct 26 08:51:51.134: vmx| DICT pref.placement.left = 528 Oct 26 08:51:51.134: vmx| DICT pref.placement.top = 320 Oct 26 08:51:51.134: vmx| DICT pref.placement.right = 1557 Oct 26 08:51:51.134: vmx| DICT pref.placement.bottom = 1032 Oct 26 08:51:51.134: vmx| DICT pref.view.navBar.width = 155 Oct 26 08:51:51.134: vmx| DICT pref.mruDest0.present = TRUE Oct 26 08:51:51.134: vmx| DICT pref.mruDest0.destString = server02 Oct 26 08:51:51.134: vmx| DICT pref.mruDest0.user = vmware Oct 26 08:51:51.134: vmx| DICT pref.mruDest1.present = TRUE Oct 26 08:51:51.134: vmx| DICT pref.mruDest1.destString = pcg-3.pcg.org.uk Oct 26 08:51:51.134: vmx| DICT pref.mruDest1.user = vmware Oct 26 08:51:51.134: vmx| DICT pref.console.openedObj0.present = TRUE Oct 26 08:51:51.134: vmx| DICT pref.console.openedObj0.name = Home Oct 26 08:51:51.134: vmx| DICT pref.console.openedObj.maxNum = 2 Oct 26 08:51:51.134: vmx| DICT pref.view.homepage = FALSE Oct 26 08:51:51.134: vmx| DICT pref.console.openedObj1.present = TRUE Oct 26 08:51:51.134: vmx| DICT pref.console.openedObj1.name = Home Oct 26 08:51:51.134: vmx| DICT pref.console.currentObj.path = /vm/#0bb69cb105aa43a8/ Oct 26 08:51:51.134: vmx| DICT pref.console.currentObj.type = home Oct 26 08:51:51.134: vmx| DICT --- USER DEFAULTS C:\Users\clive.darracott\AppData\Roaming\VMware\config.ini Oct 26 08:51:51.134: vmx| DICT --- HOST DEFAULTS C:\ProgramData\VMware\VMware Player\config.ini Oct 26 08:51:51.134: vmx| DICT installerDefaults.autoSoftwareUpdateEnabled = no Oct 26 08:51:51.134: vmx| DICT installerDefaults.componentDownloadEnabled = yes Oct 26 08:51:51.134: vmx| DICT installerDefaults.dataCollectionEnabled = yes Oct 26 08:51:51.134: vmx| DICT --- SITE DEFAULTS C:\ProgramData\VMware\VMware Player\config.ini Oct 26 08:51:51.134: vmx| DICT installerDefaults.autoSoftwareUpdateEnabled = no Oct 26 08:51:51.134: vmx| DICT installerDefaults.componentDownloadEnabled = yes Oct 26 08:51:51.134: vmx| DICT installerDefaults.dataCollectionEnabled = yes Oct 26 08:51:51.134: vmx| DICT --- COMMAND LINE Oct 26 08:51:51.134: vmx| DICT snapshot.numRollingTiers = 0 Oct 26 08:51:51.134: vmx| DICT RemoteDisplay.vnc.enabled = FALSE Oct 26 08:51:51.134: vmx| DICT vmx.stdio.keep = TRUE Oct 26 08:51:51.134: vmx| DICT gui.available = TRUE Oct 26 08:51:51.134: vmx| DICT --- CONFIGURATION D:\VMFS\xubu1004\xubu1004.vmx Oct 26 08:51:51.134: vmx| DICT config.version = 8 Oct 26 08:51:51.134: vmx| DICT virtualHW.version = 7 Oct 26 08:51:51.134: vmx| DICT scsi0.present = TRUE Oct 26 08:51:51.134: vmx| DICT scsi0.virtualDev = lsilogic Oct 26 08:51:51.134: vmx| DICT memsize = 1536 Oct 26 08:51:51.134: vmx| DICT scsi0:0.present = TRUE Oct 26 08:51:51.134: vmx| DICT scsi0:0.fileName = xubu1004.vmdk Oct 26 08:51:51.134: vmx| DICT ide1:0.present = TRUE Oct 26 08:51:51.134: vmx| DICT ide1:0.fileName = auto detect Oct 26 08:51:51.134: vmx| DICT ide1:0.deviceType = cdrom-raw Oct 26 08:51:51.134: vmx| DICT ethernet0.present = TRUE Oct 26 08:51:51.134: vmx| DICT ethernet0.wakeOnPcktRcv = FALSE Oct 26 08:51:51.134: vmx| DICT ethernet0.addressType = generated Oct 26 08:51:51.134: vmx| DICT usb.present = TRUE Oct 26 08:51:51.134: vmx| DICT usb.generic.autoconnect = FALSE Oct 26 08:51:51.134: vmx| DICT ehci.present = TRUE Oct 26 08:51:51.134: vmx| DICT sound.present = TRUE Oct 26 08:51:51.134: vmx| DICT sound.fileName = -1 Oct 26 08:51:51.134: vmx| DICT sound.autodetect = TRUE Oct 26 08:51:51.134: vmx| DICT pciBridge0.present = TRUE Oct 26 08:51:51.134: vmx| DICT pciBridge4.present = TRUE Oct 26 08:51:51.134: vmx| DICT pciBridge4.virtualDev = pcieRootPort Oct 26 08:51:51.134: vmx| DICT pciBridge4.functions = 8 Oct 26 08:51:51.134: vmx| DICT pciBridge5.present = TRUE Oct 26 08:51:51.134: vmx| DICT pciBridge5.virtualDev = pcieRootPort Oct 26 08:51:51.134: vmx| DICT pciBridge5.functions = 8 Oct 26 08:51:51.134: vmx| DICT pciBridge6.present = TRUE Oct 26 08:51:51.135: vmx| DICT pciBridge6.virtualDev = pcieRootPort Oct 26 08:51:51.135: vmx| DICT pciBridge6.functions = 8 Oct 26 08:51:51.135: vmx| DICT pciBridge7.present = TRUE Oct 26 08:51:51.135: vmx| DICT pciBridge7.virtualDev = pcieRootPort Oct 26 08:51:51.135: vmx| DICT pciBridge7.functions = 8 Oct 26 08:51:51.135: vmx| DICT vmci0.present = TRUE Oct 26 08:51:51.135: vmx| DICT roamingVM.exitBehavior = go Oct 26 08:51:51.135: vmx| DICT displayName = xubu1004 Oct 26 08:51:51.135: vmx| DICT guestOS = ubuntu Oct 26 08:51:51.135: vmx| DICT nvram = xubu1004.nvram Oct 26 08:51:51.135: vmx| DICT virtualHW.productCompatibility = hosted Oct 26 08:51:51.135: vmx| DICT gui.exitOnCLIHLT = FALSE Oct 26 08:51:51.135: vmx| DICT extendedConfigFile = xubu1004.vmxf Oct 26 08:51:51.135: vmx| DICT ide1:0.startConnected = FALSE Oct 26 08:51:51.135: vmx| DICT ethernet0.generatedAddress = 00:0c:29:f5:1a:eb Oct 26 08:51:51.135: vmx| DICT tools.syncTime = FALSE Oct 26 08:51:51.135: vmx| DICT uuid.location = 56 4d 8b be b1 b7 d1 89-6a 60 e6 9d b8 13 1b e3 Oct 26 08:51:51.135: vmx| DICT uuid.bios = 56 4d 72 1d 42 b1 57 8f-10 27 75 2b 37 f5 1a eb Oct 26 08:51:51.135: vmx| DICT cleanShutdown = TRUE Oct 26 08:51:51.135: vmx| DICT replay.supported = FALSE Oct 26 08:51:51.135: vmx| DICT unity.wasCapable = FALSE Oct 26 08:51:51.135: vmx| DICT replay.filename = Oct 26 08:51:51.135: vmx| DICT scsi0:0.redo = Oct 26 08:51:51.135: vmx| DICT pciBridge0.pciSlotNumber = 17 Oct 26 08:51:51.135: vmx| DICT pciBridge4.pciSlotNumber = 21 Oct 26 08:51:51.135: vmx| DICT pciBridge5.pciSlotNumber = 22 Oct 26 08:51:51.135: vmx| DICT pciBridge6.pciSlotNumber = 23 Oct 26 08:51:51.135: vmx| DICT pciBridge7.pciSlotNumber = 24 Oct 26 08:51:51.135: vmx| DICT scsi0.pciSlotNumber = 16 Oct 26 08:51:51.135: vmx| DICT usb.pciSlotNumber = 32 Oct 26 08:51:51.135: vmx| DICT ethernet0.pciSlotNumber = 33 Oct 26 08:51:51.135: vmx| DICT sound.pciSlotNumber = 34 Oct 26 08:51:51.135: vmx| DICT ehci.pciSlotNumber = 35 Oct 26 08:51:51.135: vmx| DICT vmci0.pciSlotNumber = 36 Oct 26 08:51:51.135: vmx| DICT vmotion.checkpointFBSize = 21561344 Oct 26 08:51:51.135: vmx| DICT ethernet0.generatedAddressOffset = 0 Oct 26 08:51:51.135: vmx| DICT vmci0.id = 938810091 Oct 26 08:51:51.135: vmx| DICT ide1:0.autodetect = TRUE Oct 26 08:51:51.135: vmx| DICT unity.showBorders = FALSE Oct 26 08:51:51.135: vmx| DICT unity.showBadges = FALSE Oct 26 08:51:51.135: vmx| DICT unity.enableLaunchMenu = FALSE Oct 26 08:51:51.135: vmx| DICT ethernet0.linkStatePropagation.enable = FALSE Oct 26 08:51:51.135: vmx| DICT floppy0.present = FALSE Oct 26 08:51:51.135: vmx| DICT --- USER DEFAULTS C:\Users\clive.darracott\AppData\Roaming\VMware\config.ini Oct 26 08:51:51.135: vmx| DICT --- HOST DEFAULTS C:\ProgramData\VMware\VMware Player\config.ini Oct 26 08:51:51.135: vmx| DICT installerDefaults.autoSoftwareUpdateEnabled = no Oct 26 08:51:51.135: vmx| DICT installerDefaults.componentDownloadEnabled = yes Oct 26 08:51:51.135: vmx| DICT installerDefaults.dataCollectionEnabled = yes Oct 26 08:51:51.135: vmx| DICT --- SITE DEFAULTS C:\ProgramData\VMware\VMware Player\config.ini Oct 26 08:51:51.135: vmx| DICT installerDefaults.autoSoftwareUpdateEnabled = no Oct 26 08:51:51.135: vmx| DICT installerDefaults.componentDownloadEnabled = yes Oct 26 08:51:51.135: vmx| DICT installerDefaults.dataCollectionEnabled = yes Oct 26 08:51:51.135: vmx| DICT --- GLOBAL SETTINGS C:\ProgramData\VMware\VMware Player\settings.ini Oct 26 08:51:51.137: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 Oct 26 08:51:51.142: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:51:51.146: vmx| hostCpuFeatures = 0x446001fc Oct 26 08:51:51.146: vmx| hostNumPerfCounters = 2 Oct 26 08:51:51.146: vmx| MONITOR MODE: allowed modes : BT32 HV Oct 26 08:51:51.146: vmx| MONITOR MODE: user requested modes : BT32 HV HWMMU Oct 26 08:51:51.146: vmx| MONITOR MODE: guestOS preferred modes: HWMMU HV BT32 Oct 26 08:51:51.146: vmx| MONITOR MODE: filtered list : HV BT32 Oct 26 08:51:51.146: vmx| HV Settings: virtual exec = 'hardware'; virtual mmu = 'software' Oct 26 08:51:51.146: vmx| Basic VMX Information (0x005a08000000000d) Oct 26 08:51:51.146: vmx| VMCS revision ID 13 Oct 26 08:51:51.146: vmx| VMCS region length 2048 Oct 26 08:51:51.146: vmx| VMX physical-address width natural Oct 26 08:51:51.146: vmx| SMM dual-monitor mode yes Oct 26 08:51:51.146: vmx| Advanced INS/OUTS info yes Oct 26 08:51:51.146: vmx| True VMX MSRs no Oct 26 08:51:51.146: vmx| VMCS memory type WB Oct 26 08:51:51.146: vmx| Pin-Based VM-Execution Controls (0x0000003f00000016) Oct 26 08:51:51.146: vmx| External-interrupt exiting {0,1} Oct 26 08:51:51.146: vmx| NMI exiting {0,1} Oct 26 08:51:51.146: vmx| Virtual NMIs {0,1} Oct 26 08:51:51.146: vmx| Activate VMX-preemption timer { 0 } Oct 26 08:51:51.146: vmx| Primary Processor-Based VM-Execution Controls (0xf7f9fffe0401e172) Oct 26 08:51:51.146: vmx| Interrupt-window exiting {0,1} Oct 26 08:51:51.146: vmx| Use TSC offsetting {0,1} Oct 26 08:51:51.146: vmx| HLT exiting {0,1} Oct 26 08:51:51.146: vmx| INVLPG exiting {0,1} Oct 26 08:51:51.146: vmx| MWAIT exiting {0,1} Oct 26 08:51:51.146: vmx| RDPMC exiting {0,1} Oct 26 08:51:51.146: vmx| RDTSC exiting {0,1} Oct 26 08:51:51.146: vmx| CR3-load exiting { 1 } Oct 26 08:51:51.146: vmx| CR3-store exiting { 1 } Oct 26 08:51:51.146: vmx| CR8-load exiting {0,1} Oct 26 08:51:51.146: vmx| CR8-store exiting {0,1} Oct 26 08:51:51.146: vmx| Use TPR shadow {0,1} Oct 26 08:51:51.146: vmx| NMI-window exiting {0,1} Oct 26 08:51:51.146: vmx| MOV-DR exiting {0,1} Oct 26 08:51:51.146: vmx| Unconditional I/O exiting {0,1} Oct 26 08:51:51.146: vmx| Use I/O bitmaps {0,1} Oct 26 08:51:51.146: vmx| Monitor trap flag { 0 } Oct 26 08:51:51.146: vmx| Use MSR bitmaps {0,1} Oct 26 08:51:51.146: vmx| MONITOR exiting {0,1} Oct 26 08:51:51.146: vmx| PAUSE exiting {0,1} Oct 26 08:51:51.146: vmx| Activate secondary controls {0,1} Oct 26 08:51:51.146: vmx| Secondary Processor-Based VM-Execution Controls (0x0000004100000000) Oct 26 08:51:51.146: vmx| Virtualize APIC accesses {0,1} Oct 26 08:51:51.146: vmx| Enable EPT { 0 } Oct 26 08:51:51.146: vmx| Descriptor-table exiting { 0 } Oct 26 08:51:51.146: vmx| Enable RDTSCP { 0 } Oct 26 08:51:51.146: vmx| Virtualize x2APIC mode { 0 } Oct 26 08:51:51.146: vmx| Enable VPID { 0 } Oct 26 08:51:51.146: vmx| WBINVD exiting {0,1} Oct 26 08:51:51.146: vmx| VM-Exit Controls (0x0003ffff00036dff) Oct 26 08:51:51.146: vmx| Save debug controls { 1 } Oct 26 08:51:51.146: vmx| Host address-space size {0,1} Oct 26 08:51:51.146: vmx| Load IA32_PERF_GLOBAL_CTRL {0,1} Oct 26 08:51:51.146: vmx| Acknowledge interrupt on exit {0,1} Oct 26 08:51:51.146: vmx| Save IA32_PAT { 0 } Oct 26 08:51:51.146: vmx| Load IA32_PAT { 0 } Oct 26 08:51:51.146: vmx| Save IA32_EFER { 0 } Oct 26 08:51:51.146: vmx| Load IA32_EFER { 0 } Oct 26 08:51:51.146: vmx| Save VMX-preemption timer { 0 } Oct 26 08:51:51.146: vmx| VM-Entry Controls (0x00003fff000011ff) Oct 26 08:51:51.146: vmx| Load debug controls { 1 } Oct 26 08:51:51.146: vmx| IA-32e mode guest {0,1} Oct 26 08:51:51.146: vmx| Entry to SMM {0,1} Oct 26 08:51:51.146: vmx| Deactivate dual-monitor mode {0,1} Oct 26 08:51:51.146: vmx| Load IA32_PERF_GLOBAL_CTRL {0,1} Oct 26 08:51:51.146: vmx| Load IA32_PAT { 0 } Oct 26 08:51:51.146: vmx| Load IA32_EFER { 0 } Oct 26 08:51:51.146: vmx| VPID and EPT Capabilities (0x0000000000000000) Oct 26 08:51:51.146: vmx| R=0/W=0/X=1 no Oct 26 08:51:51.146: vmx| Page-walk length 3 no Oct 26 08:51:51.146: vmx| EPT memory type WB no Oct 26 08:51:51.146: vmx| 2MB super-page no Oct 26 08:51:51.146: vmx| INVEPT support no Oct 26 08:51:51.146: vmx| Type 1 INVEPT no Oct 26 08:51:51.146: vmx| Type 2 INVEPT no Oct 26 08:51:51.146: vmx| INVVPID support no Oct 26 08:51:51.146: vmx| Type 0 INVVPID no Oct 26 08:51:51.146: vmx| Type 1 INVVPID no Oct 26 08:51:51.146: vmx| Type 2 INVVPID no Oct 26 08:51:51.146: vmx| Type 3 INVVPID no Oct 26 08:51:51.146: vmx| Miscellaneous VMX Data (0x00000000000403c0) Oct 26 08:51:51.146: vmx| TSC to preemption timer ratio 0 Oct 26 08:51:51.146: vmx| Activity State HLT yes Oct 26 08:51:51.146: vmx| Activity State shutdown yes Oct 26 08:51:51.146: vmx| Activity State wait-for-SIPI yes Oct 26 08:51:51.146: vmx| CR3 targets supported 4 Oct 26 08:51:51.146: vmx| Maximum MSR list size 512 Oct 26 08:51:51.146: vmx| MSEG revision ID 0 Oct 26 08:51:51.146: vmx| VMX-Fixed Bits in CR0 (0x0000000080000021/0x00000000ffffffff) Oct 26 08:51:51.146: vmx| Fixed to 0 0xffffffff00000000 Oct 26 08:51:51.146: vmx| Fixed to 1 0x0000000080000021 Oct 26 08:51:51.146: vmx| Variable 0x000000007fffffde Oct 26 08:51:51.146: vmx| VMX-Fixed Bits in CR4 (0x0000000000002000/0x00000000000427ff) Oct 26 08:51:51.146: vmx| Fixed to 0 0xfffffffffffbd800 Oct 26 08:51:51.146: vmx| Fixed to 1 0x0000000000002000 Oct 26 08:51:51.146: vmx| Variable 0x00000000000407ff Oct 26 08:51:51.146: vmx| VMCS Enumeration (0x000000000000002c) Oct 26 08:51:51.146: vmx| Highest index 0x16 Oct 26 08:51:51.154: vmx| Host display topology 3360x1050. Oct 26 08:51:51.154: vmx| SVGA: Max size 3360x1600 Oct 26 08:51:51.155: vmx| WSSCAN: reserved mem (in MB) min=32 max=3900 recommended=3900 Oct 26 08:51:51.155: vmx| WSSCAN: used rec mem (in MB) 3900 Oct 26 08:51:51.155: vmx| PShare: enabled 1 adaptive 1 local 0 scanRate [16, 400] Oct 26 08:51:51.155: vmx| WSSCAN: 427593 14845 393216 32768 Oct 26 08:51:51.173: vmx| WSSCAN 1 1 859809 947053 998400 868001 50 0 Oct 26 08:51:51.174: vmx| LICENSE: Running in restricted mode Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats32-1 -> stats\stats32-2: The system cannot find the path specified Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats32-0 -> stats\stats32-1: The system cannot find the path specified Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats32 -> stats\stats32-0: The system cannot find the path specified Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats64-1 -> stats\stats64-2: The system cannot find the path specified Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats64-0 -> stats\stats64-1: The system cannot find the path specified Oct 26 08:51:51.188: vmx| LOG failed to rename stats\stats64 -> stats\stats64-0: The system cannot find the path specified Oct 26 08:51:51.194: vmx| Host IPI vectors: 0x2f 0 Oct 26 08:51:51.194: vmx| Monitor_PowerOn: HostedVSMP skew tracking is disabled Oct 26 08:51:51.194: vmx| Monitor_PowerOn: HostedVSMP crosscall yielding is disabled Oct 26 08:51:51.194: vmx| vmm32-modules: [vmm.vmm32 .data:0x2b000-0x700 .sdata:0x2c000-0x4e4 .statvars:0x2d000-0x3a0 .peer:0x2e000-0x26200 .shared:0x5a000-0x143c0 .bss:0x6f000-0x5e08 .rodata:0x76000-0xb740 .text:0x82000-0x5c7fd .kstatvars:0x3000-0x0, mmu-nohv.vmm32 .rodata:0x81740-0x44 .data:0x2b700-0x10 .peer:0x54200-0x5640 .shared:0x6e3c0-0x340 .bss:0x74e20-0x51c .text:0xde800-0xa4e3 .comment:0x40000d5c-0x10e .statvars:0x2000-0x0 .kstatvars:0x2000-0x0 .scb:0x40003cc0-0x180 .shared_meta:0x400042f0-0x330 .peer_meta:0x40000f90-0x1e0 .patchtext:0x40000500-0xb0, pv-none.vmm32 .shared:0x6e700-0x180 .bss:0x75340-0x84 .text:0xe8ce4-0xe2 .comment:0x40000e6a-0x48 .shared_meta:0x40004620-0x90, vprobe-none.vmm32 .text:0xe8dc8-0x19 .comment:0x40000eb2-0x12, hv-vt.vmm32 .rodata:0x81784-0x4 .data:0x1000-0x0 .peer:0x1000-0x0 .shared:0x1000-0x0 .bss:0x1000-0x0 .text:0xe8df0-0x10f .comment:0x40000ec4-0x12 .statvars:0x1000-0x0 .kstatvars:0x1000-0x0 .patchtext:0x400005b0-0x10, gphys-sw.vmm32 .peer:0x59840-0x40 .shared:0x6e880-0x80 .bss:0x2000-0x0 .text:0xe8f00-0x7d1 .comment:0x40000ed6-0x12 .scb:0x40003e40-0x60 .shared_meta:0x400046b0-0x240 .peer_meta:0x40001170-0x30, vassert-none.vmm32 .text:0xe96d4-0x39 .comment:0x40000ee8-0x12, vmsafe-none.vmm32 .text:0xe9710-0x1b .comment:0x40000efa-0x12, .rodata:0x81788-0x3b1] Oct 26 08:51:51.197: vmx| KHZEstimate 2693309 Oct 26 08:51:51.197: vmx| MHZEstimate 2693 Oct 26 08:51:51.197: vmx| NumVCPUs 1 Oct 26 08:51:51.197: vmx| PShare: checkRate 16 Oct 26 08:51:51.198: vmx| UUID: location-UUID is 56 4d 06 92 69 14 96 17-a6 e6 c3 22 8a dd 33 4c Oct 26 08:51:51.198: vmx| UUID: location-UUID is 56 4d 8b be b1 b7 d1 89-6a 60 e6 9d b8 13 1b e3 Oct 26 08:51:51.198: vmx| UUID: location-UUID is 56 4d 8b be b1 b7 d1 89-6a 60 e6 9d b8 13 1b e3 Oct 26 08:51:51.198: vmx| AIOGNRC: numThreads=18 ide=0, scsi=1, passthru=1 Oct 26 08:51:51.198: vmx| WORKER: Creating new group with numThreads=18 (18) Oct 26 08:51:51.198: vmx| CPU0: PMC: Patch Level 0xa07, smmFrz (hw): (1) Oct 26 08:51:51.198: vmx| PMC: IA32, Penryn [c:0 f:1 e:0] Oct 26 08:51:51.198: vmx| CPU1: PMC: Patch Level 0xa07, smmFrz (hw): (1) Oct 26 08:51:51.198: vmx| PMC: IA32, Penryn [c:0 f:1 e:0] Oct 26 08:51:51.224: vmx| Replay State = 0 Oct 26 08:51:51.224: vmx| minDEThreshold: 76 Oct 26 08:51:51.287: vmx| MMC: Initialized PLS=1 PLR=0 PFS=0 TS=1 BS=1 WZ=0 BufM=0 LOR=96 SOR=1 BlkP=32 W=50 PF=1536 Oct 26 08:51:51.288: vmx| UUID: location-UUID is 56 4d 8b be b1 b7 d1 89-6a 60 e6 9d b8 13 1b e3 Oct 26 08:51:51.297: vmx| MM: Opened paging file, 'D:\VMFS\xubu1004\564d8bbe-b1b7-d189-6a60-e69db8131be3.vmem'. Oct 26 08:51:51.299: vmx| MStat: Creating Stat vm.uptime Oct 26 08:51:51.299: vmx| MStat: Creating Stat vm.suspendTime Oct 26 08:51:51.299: vmx| MStat: Creating Stat vm.powerOnTimeStamp Oct 26 08:51:51.299: vmx| Setting thread 37 stack size to 1048576. Oct 26 08:51:51.300: vmx| VMXAIOMGR: Using: simple=Generic unbuf=Compl Oct 26 08:51:51.309: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:51:51.313: vmx| DISK: OPEN scsi0:0 'D:\VMFS\xubu1004\xubu1004.vmdk' persistent R[] Oct 26 08:51:51.531: vmx| DISKLIB-DSCPTR: Opened [0]: "xubu1004-s001.vmdk" (0xa) Oct 26 08:51:51.614: vmx| DISKLIB-DSCPTR: Opened [1]: "xubu1004-s002.vmdk" (0xa) Oct 26 08:51:51.716: vmx| DISKLIB-DSCPTR: Opened [2]: "xubu1004-s003.vmdk" (0xa) Oct 26 08:51:51.793: vmx| DISKLIB-DSCPTR: Opened [3]: "xubu1004-s004.vmdk" (0xa) Oct 26 08:51:51.855: vmx| DISKLIB-DSCPTR: Opened [4]: "xubu1004-s005.vmdk" (0xa) Oct 26 08:51:51.896: vmx| DISKLIB-DSCPTR: Opened [5]: "xubu1004-s006.vmdk" (0xa) Oct 26 08:51:51.896: vmx| DISKLIB-LINK : Opened 'D:\VMFS\xubu1004\xubu1004.vmdk' (0xa): twoGbMaxExtentSparse, 20971520 sectors / 10 GB. Oct 26 08:51:51.897: vmx| DISKLIB-LIB : Opened "D:\VMFS\xubu1004\xubu1004.vmdk" (flags 0xa). Oct 26 08:51:51.897: vmx| DiskGetGeometry: Reading of disk partition table Oct 26 08:51:51.897: vmx| DISK: OPEN 'D:\VMFS\xubu1004\xubu1004.vmdk' Geo (1305/255/63) BIOS Geo (1305/255/63) Oct 26 08:51:51.924: vmx| TimeTracker host to guest rate conversion 1927981671988 @ 2693309000Hz -> 1927981671988 @ 2693309000Hz Oct 26 08:51:51.924: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0 Oct 26 08:51:51.925: vmx| USB: Initializing 'Generic' backend Oct 26 08:51:51.925: vmx| USBGW: Write arbitrator op:0 len:4 Oct 26 08:51:51.926: vmx| USBGW: Write arbitrator op:13 len:13 Oct 26 08:51:51.926: vmx| USB: Initializing 'Virtual Hub' backend Oct 26 08:51:51.926: vmx| USB: Initializing 'Virtual Mouse' backend Oct 26 08:51:51.926: vmx| USB: Initializing 'Virtual Keyboard' backend Oct 26 08:51:51.926: vmx| USB: Initializing 'Virtual Mass Storage' backend Oct 26 08:51:51.926: vmx| USB: Initializing 'Virtual CCID' backend Oct 26 08:51:51.932: vmx| Setting thread 38 stack size to 1048576. Oct 26 08:51:51.933: usbCCIDEnumCards| USB-CCID: Card enum thread created. Oct 26 08:51:51.934: vmx| WORKER: Creating new group with numThreads=1 (19) Oct 26 08:51:51.957: vmx| USBGW: Skipping disk backing for file (D:\VMFS\xubu1004\xubu1004.vmx). Oct 26 08:51:51.958: vmx| USBGW: Skipping disk backing for file (D:\VMFS\xubu1004\xubu1004.vmdk). Oct 26 08:51:51.958: vmx| USBGW: Skipping disk backing for file (D:\VMFS\xubu1004\xubu1004.vmsd). Oct 26 08:51:51.959: vmx| USBGW: Skipping disk backing for file (D:\VMFS\xubu1004\xubu1004.nvram). Oct 26 08:51:51.962: vmx| WORKER: Creating new group with numThreads=1 (20) Oct 26 08:51:51.962: vmx| MKS: Base polling period is 1000000us Oct 26 08:51:51.963: vmx| KHBKL: Unable to parse keystring at: '' Oct 26 08:51:51.963: vmx| MKS REMOTE Loading VNC Configuration from VM config file Oct 26 08:51:51.966: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks Oct 26 08:51:51.966: vmx| VMXNET: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks, dontClusterSize is 128 Oct 26 08:51:51.967: vmx| NetPkt: checksum cycles/kB: C=52 asm1=970 asm2=520 Oct 26 08:51:51.967: vmx| NetPkt: copy and sum cycles/kB: C=536 asm1=1008 asm2=481 Oct 26 08:51:51.971: vmx| Chipset version: 0x13 Oct 26 08:51:51.999: vmx| SCSI DEVICE (ide1:0): Computed value of ide1:0.useBounceBuffers: default Oct 26 08:51:52.000: vmx| DISKUTIL: ide1:0 : capacity=0 Oct 26 08:51:52.000: vmx| DISKUTIL: ide1:0 : geometry=0/0/0 Oct 26 08:51:52.000: vmx| LSI: vIC initialized 50/4/100/0 Oct 26 08:51:52.000: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags. Oct 26 08:51:52.000: vmx| SCSI DEVICE (scsi0:0): Computed value of scsi0:0.useBounceBuffers: default Oct 26 08:51:52.000: vmx| DISKUTIL: scsi0:0 : capacity=20971520 Oct 26 08:51:52.000: vmx| DISKUTIL: scsi0:0 : geometry=1305/255/63 Oct 26 08:51:52.001: vmx| SVGA: Device capabilities 0x001f83e2 Oct 26 08:51:52.001: vmx| Host display topology 3360x1050. Oct 26 08:51:52.001: vmx| SVGA: Max size 3360x1600 Oct 26 08:51:52.040: vmx| Host display topology 3360x1050 with 2 displays. Oct 26 08:51:52.040: vmx| SVGA: Max size 3360x1600 Oct 26 08:51:52.041: vmx| SVGA: FIFO capabilities 0x0000007f Oct 26 08:51:52.041: vmx| USB: Initializing 'UHCI' host controller Oct 26 08:51:52.041: vmx| Ethernet0 MAC Address: 00:0c:29:f5:1a:eb Oct 26 08:51:52.042: vmx| USB: Initializing 'EHCI' host controller Oct 26 08:51:52.057: vmx| MStat: Creating Stat vm.heartbeat Oct 26 08:51:52.058: vmx| TOOLS Generated SessionId 12536826493144541282 Oct 26 08:51:52.058: vmx| VMXVmdbGuest_GetToolsVersion did nothing; tools version has not yet been initialized Oct 26 08:51:52.058: vmx| DISKUTIL: scsi0:0 : toolsVersion = 8324 Oct 26 08:51:52.058: vmx| VMXVmdbGuest_GetToolsVersion did nothing; tools version has not yet been initialized Oct 26 08:51:52.058: vmx| TOOLS setting legacy tools version to '8324', manifest status is 5 Oct 26 08:51:52.058: vmx| VMXVmdb_SetToolsVersionState: status value set to 'ok' Oct 26 08:51:52.059: vmx| VMXVmdb_SetToolsVersionState: status value set to 'ok' Oct 26 08:51:52.059: vmx| TOOLS INSTALL initializing state to IDLE on power on. Oct 26 08:51:52.061: vmx| PTSC to VMI Wallclock (nsec) 1928351793766 @ 2693309000Hz -> 1288079512000000000 @ 1000000000Hz Oct 26 08:51:52.061: vmx| PTSC to VMI Wallclock (nsec) ((x * 3189360965) >> 33) + 1288078796021330785 Oct 26 08:51:52.061: vmx| PTSC to ParaTime RealCycles 0 @ 2693309000Hz -> 0 @ 2693309000Hz Oct 26 08:51:52.061: vmx| PTSC to ParaTime RealCycles ((x * 1) >> 0) + 0 Oct 26 08:51:52.061: vmx| ParaTime RealCycles to PTSC 0 @ 2693309000Hz -> 0 @ 2693309000Hz Oct 26 08:51:52.061: vmx| ParaTime RealCycles to PTSC ((x * 1) >> 0) + 0 Oct 26 08:51:52.062: vmx| memoryHotplug: Current size = 1536MB, Minimum size = 1536MB, Maximum size = 1536MB Oct 26 08:51:52.062: vmx| memoryHotplug: Entry[0]: 00000000000000A0-00000000000A0000 Oct 26 08:51:52.062: vmx| memoryHotplug: Entry[1]: 00000000001000A0-0000000060000000 Oct 26 08:51:52.064: vmx| guestCpuFeatures = 0x404001fc Oct 26 08:51:52.065: vmx| guestCPUID vendor: GenuineIntel Oct 26 08:51:52.065: vmx| guestCPUID name: Pentium(R) Dual-Core CPU E5400 @ 2.70GHz Oct 26 08:51:52.065: vmx| guestCPUID level 00000000, 0: 0x0000000d 0x756e6547 0x6c65746e 0x49656e69 Oct 26 08:51:52.065: vmx| guestCPUID level 00000001, 0: 0x0001067a 0x00010800 0x80002201 0x0febfbff Oct 26 08:51:52.065: vmx| guestCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb4307d Oct 26 08:51:52.065: vmx| guestCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001 Oct 26 08:51:52.065: vmx| guestCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220 Oct 26 08:51:52.065: vmx| guestCPUID level 00000006, 0: 0x00000001 0x00000002 0x00000003 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503 Oct 26 08:51:52.065: vmx| guestCPUID level 0000000b, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 0000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 0000000d, 0: 0x00000003 0x00000240 0x00000240 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 40000000, 0: 0x40000010 0x61774d56 0x4d566572 0x65726177 Oct 26 08:51:52.065: vmx| guestCPUID level 40000010, 0: 0x002918bd 0x000101d0 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800 Oct 26 08:51:52.065: vmx| guestCPUID level 80000002, 0: 0x746e6550 0x286d7569 0x44202952 0x2d6c6175 Oct 26 08:51:52.065: vmx| guestCPUID level 80000003, 0: 0x65726f43 0x50432020 0x20202055 0x45202020 Oct 26 08:51:52.065: vmx| guestCPUID level 80000004, 0: 0x30303435 0x20402020 0x30372e32 0x007a4847 Oct 26 08:51:52.065: vmx| guestCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 80000006, 0: 0x00000000 0x00000000 0x08006040 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.065: vmx| guestCPUID level 80000008, 0: 0x00003028 0x00000000 0x00000000 0x00000000 Oct 26 08:51:52.068: vmx| BusMemSample: initPercent 75 touched 294912 Oct 26 08:51:52.068: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '1' Oct 26 08:51:52.068: vmx| TOOLS received request in VMX to set option 'copypaste' -> '1' Oct 26 08:51:52.070: vmx| Vix: [3840 mainDispatch.c:844]: VMAutomation_PowerOn. Powering on. Oct 26 08:51:52.070: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1 Oct 26 08:51:52.070: vmx| Setting thread 1 stack size to 2097152. Oct 26 08:51:52.071: mks| Async MKS thread is alive Oct 26 08:51:52.071: vmx| Setting thread 4 stack size to 1048576. Oct 26 08:51:52.073: vcpu-0| APIC: version = 0x14, max LVT = 5 Oct 26 08:51:52.073: vcpu-0| APIC: LDR = 0x1000000, DFR = 0xffffffff Oct 26 08:51:52.076: vmx| DnDRegisterRpc: DnD rpc already set to 1 Oct 26 08:51:52.076: vmx| CopyPasteRegisterRpc: already set to 1 Oct 26 08:51:52.083: vcpu-0| CPU reset: hard (mode 2) Oct 26 08:51:52.083: vcpu-0| memoryHotplug: Entry[0]: 00000000000000A0-00000000000A0000 Oct 26 08:51:52.083: vcpu-0| memoryHotplug: Entry[1]: 00000000001000A0-0000000060000000 Oct 26 08:51:52.083: vcpu-0| PIIX4: PM Resuming from suspend type 0x0. Oct 26 08:51:52.140: vcpu-0| SOUND 001.354048 PCISoundWin32 mixerGetLineInfo error 1 Oct 26 08:51:52.141: vcpu-0| VNET: MACVNetConnectToNetwork: Ethernet0: notify available Oct 26 08:51:52.141: vcpu-0| Vix: [2844 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1872, success=1 Oct 26 08:51:52.145: vcpu-0| Vix: [2844 mainDispatch.c:3582]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=0, err=0). Oct 26 08:51:52.145: vcpu-0| Vix: [2844 mainDispatch.c:3582]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=2, err=0). Oct 26 08:51:52.145: vcpu-0| Transitioned vmx/execState/val to poweredOn Oct 26 08:51:52.184: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:51:52.282: vmx| HOSTINFO: Seeing Intel CPU, numCoresPerCPU 2 numThreadsPerCore 1. Oct 26 08:51:52.282: vmx| HOSTINFO: This machine has 1 physical CPUS, 2 total cores, and 2 logical CPUs. Oct 26 08:51:52.282: mks| Connecting to window system. Oct 26 08:51:52.282: mks| MKS: Base polling period is 10000us Oct 26 08:51:52.282: mks| Setting thread 39 stack size to 1048576. Oct 26 08:51:52.284: mks| GdiBackendConstruct: Using software emulation for overlays. Oct 26 08:51:52.287: mks| VMXAIOMGR: Disallowing USB connect. 1500670 us since last reopen Oct 26 08:51:52.298: mks| HostOps hideCursor before defineCursor! Oct 26 08:51:52.315: vcpu-0| sz=2957280 Oct 26 08:51:52.318: vcpu-0| vmm32 initialized: Releasebuild-301548. cflags: 0x00000008.01001000.20602100.00680003 Oct 26 08:51:52.320: vcpu-0| MonitorInitNumaUnmapVMM32 Oct 26 08:51:52.342: vcpu-0| Monitor64_PowerOn() Oct 26 08:51:52.354: vcpu-0| vmm64-modules: [vmm.vmm64 .data:0xfffffffffc051000-0xb80 .sdata:0xfffffffffc052000-0x9b8 .statvars:0xfffffffffc053000-0x1f8 .peer:0xfffffffffc054000-0x26200 .shared:0xfffffffffc080000-0x143c0 .bss:0xfffffffffc095000-0xb980 .rodata:0xfffffffffc200000-0x14ee0 .text:0xfffffffffc216000-0x6e2de .kstatvars:0x3000-0x0 .eh_frame:0xfffffffffc29f000-0x13a90, mmu-scratchas.vmm64 .rodata:0xfffffffffc214ee0-0xd2 .data:0xfffffffffc051b80-0x14 .peer:0xfffffffffc07a200-0x5640 .shared:0xfffffffffc0943c0-0x340 .bss:0xfffffffffc0a0980-0x950 .text:0xfffffffffc2842e0-0xb0f1 .statvars:0x2000-0x0 .kstatvars:0x2000-0x0 .scb:0x3cc0-0x180 .shared_meta:0x42f0-0x330 .peer_meta:0xf90-0x1e0 .eh_frame:0xfffffffffc2b2a90-0x1c70 .comment:0xe34-0x10e .patchtext:0x3e0-0xa0, pv-none.vmm64 .shared:0xfffffffffc094700-0x180 .bss:0x1000-0x0 .text:0xfffffffffc28f3d4-0x4 .shared_meta:0x4620-0x90 .eh_frame:0xfffffffffc2b4700-0x48 .comment:0xf42-0x48, vprobe-none.vmm64 .text:0xfffffffffc28f3d8-0x1a .eh_frame:0xfffffffffc2b4748-0xf0 .comment:0xf8a-0x12, hv-vt.vmm64 .rodata:0xfffffffffc214fc0-0x7bc .data:0xfffffffffc051ba0-0x30 .peer:0x2000-0x0 .shared:0x2000-0x0 .bss:0xfffffffffc0a12e0-0x12b70 .text:0xfffffffffc28f400-0xddc1 .statvars:0x2000-0x0 .kstatvars:0x2000-0x0 .eh_frame:0xfffffffffc2b4838-0x26c0 .comment:0xf9c-0x5a .patchtext:0x480-0x10, gphys-sw.vmm64 .rodata:0xfffffffffc215780-0x29 .data:0x1000-0x0 .peer:0xfffffffffc07f840-0x40 .shared:0xfffffffffc094880-0x80 .bss:0xfffffffffc0b3e50-0x10 .text:0xfffffffffc29d1d0-0x158a .statvars:0x1000-0x0 .kstatvars:0x1000-0x0 .scb:0x3e40-0x60 .shared_meta:0x46b0-0x240 .peer_meta:0x1170-0x30 .eh_frame:0xfffffffffc2b6ef8-0x460 .comment:0xff6-0x12, vassert-none.vmm64 .text:0xfffffffffc29e75c-0x3b .eh_frame:0xfffffffffc2b7358-0xc0 .comment:0x1008-0x12, vmsafe-none.vmm64 .text:0xfffffffffc29e798-0x13 .eh_frame:0xfffffffffc2b7418-0xd8 .comment:0x101a-0x12, .rodata:0xfffffffffc2157a9-0x3eb| 0x5a000] Oct 26 08:51:52.358: vcpu-0| APIC: version = 0x14, max LVT = 5 Oct 26 08:51:52.358: vcpu-0| APIC: LDR = 0x1000000, DFR = 0xffffffff Oct 26 08:51:52.359: vcpu-0| Intel VT: FlexPriority enabled. Oct 26 08:51:52.359: vcpu-0| HV enabled Oct 26 08:51:52.364: vcpu-0| VMM64 initialized Oct 26 08:51:52.369: vcpu-0| MonitorInitNumaUnmapVMM64 Oct 26 08:51:52.717: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0x0) and 0xd8000000(0x0) Oct 26 08:51:52.722: vcpu-0| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000) Oct 26 08:51:52.863: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000) Oct 26 08:51:52.869: vcpu-0| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000) Oct 26 08:51:52.873: vcpu-0| SVGA: Registering IOSpace at 0x10d0 Oct 26 08:51:52.873: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000) Oct 26 08:51:52.879: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.880: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.881: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.882: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.884: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.885: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.886: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.887: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.888: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.889: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.891: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.892: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.893: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.894: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.895: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.896: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.898: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.899: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.900: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.901: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.902: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.903: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.905: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.906: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.907: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.908: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.909: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.910: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.911: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.913: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.914: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:52.915: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.112: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.113: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.115: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.116: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.117: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.118: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.119: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.120: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.122: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.123: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.124: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.125: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.126: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.127: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.128: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.130: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.131: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.132: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.133: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.134: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.135: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.137: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.138: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.139: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.140: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.141: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.142: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.144: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.145: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.146: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.147: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.149: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:53.156: vcpu-0| DISKUTIL: scsi0:0 : geometry=1305/255/63 Oct 26 08:51:53.156: vcpu-0| DISKUTIL: scsi0:0 : capacity=20971520 Oct 26 08:51:53.156: vcpu-0| SCSI0: RESET BUS Oct 26 08:51:53.214: vcpu-0| BIOS-UUID is 56 4d 72 1d 42 b1 57 8f-10 27 75 2b 37 f5 1a eb Oct 26 08:51:53.529: mks| HostOps hideCursor before defineCursor! Oct 26 08:51:54.029: mks| HostOps hideCursor before defineCursor! Oct 26 08:51:55.508: mks| HostOps hideCursor before defineCursor! Oct 26 08:51:55.595: vcpu-0| MMUValidateWork: FlexPriority enabled for APIC, mpn: 0 Oct 26 08:51:56.194: vcpu-0| SVGA: Unregistering IOSpace at 0x10d0 Oct 26 08:51:56.194: vcpu-0| SVGA: Registering IOSpace at 0xfffffff0 Oct 26 08:51:56.194: vcpu-0| SVGA: Unregistering IOSpace at 0xfffffff0 Oct 26 08:51:56.194: vcpu-0| SVGA: Registering IOSpace at 0x10d0 Oct 26 08:51:56.223: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.223: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.223: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.224: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.224: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.224: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.224: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.225: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.225: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.225: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.225: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.225: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.226: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.226: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.226: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.226: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.226: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.227: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.227: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.227: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.227: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.228: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.228: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.228: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.228: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.229: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.229: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.229: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.229: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.229: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.230: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.230: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.230: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.230: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.230: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.231: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.231: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.231: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.231: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.232: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.232: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.232: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.232: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.233: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.233: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.233: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.233: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.234: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.234: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.234: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.234: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.235: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.235: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.235: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.235: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.236: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.237: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.237: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.237: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.237: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.238: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.239: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.548: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.548: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.549: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.550: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.551: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.552: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.552: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.552: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004) Oct 26 08:51:56.562: vcpu-0| UHCI: HCReset Oct 26 08:51:56.928: vcpu-0| UHCI: HCReset Oct 26 08:51:57.358: mks| SVGA: display status changed, using optimizations for local consoles. Oct 26 08:51:58.343: vcpu-0| VNET: MACVNetConnectToNetwork: Ethernet0: notify available Oct 26 08:51:58.831: vcpu-0| SCSI0: RESET BUS Oct 26 08:51:59.309: vcpu-0| SCSI0: RESET BUS Oct 26 08:51:59.329: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x8 Oct 26 08:51:59.329: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x8 Oct 26 08:51:59.346: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x8 Oct 26 08:52:10.369: vcpu-0| DISKLIB-DDB : "longContentID" = "db62abaffdceec552006e5a471bb420c" (was "f4f404409c43a7d01e6802b5861b7717") Oct 26 08:52:11.295: vcpu-0| CDROM: Accepting Event Status Notification 0x10 Oct 26 08:52:11.297: vcpu-0| VIDE: Truncating 0x46 from 65530 bytes to 32768 Oct 26 08:52:11.297: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0 Oct 26 08:52:11.787: vcpu-0| Keyboard: invalid mouse sample rate 102 Hz, using 100 instead Oct 26 08:52:12.450: vcpu-0| VMMouse: CMD Read ID Oct 26 08:52:12.450: vcpu-0| VMMouse: CMD Disable Oct 26 08:52:12.450: vcpu-0| VMMouse: Disabling VMMouse mode Oct 26 08:52:12.460: vcpu-0| VMMouse: CMD Read ID Oct 26 08:52:12.460: vcpu-0| VMMouse: CMD Disable Oct 26 08:52:12.460: vcpu-0| VMMouse: Disabling VMMouse mode Oct 26 08:52:12.815: vcpu-0| SCSI DEVICE (scsi0:0): No transfer information for *UNKNOWN (0x85)* (0x85) Oct 26 08:52:12.815: vcpu-0| SCSI scsi0:0: Unsupported command *UNKNOWN (0x85)* issued. --ok Oct 26 08:52:12.815: vcpu-0| SCSI DEVICE (scsi0:0): No transfer information for *UNKNOWN (0x85)* (0x85) Oct 26 08:52:12.815: vcpu-0| SCSI scsi0:0: Unsupported command *UNKNOWN (0x85)* issued. --ok Oct 26 08:52:12.815: vcpu-0| SCSI DEVICE (scsi0:0): No transfer information for *UNKNOWN (0x85)* (0x85) Oct 26 08:52:12.815: vcpu-0| SCSI scsi0:0: Unsupported command *UNKNOWN (0x85)* issued. --ok Oct 26 08:52:13.002: mks| HostOps hideCursor before defineCursor! Oct 26 08:52:13.655: vcpu-0| SOUND 022.864067 PCISoundWin32 mixerGetLineInfo error 1024 Oct 26 08:52:22.220: vcpu-0| GuestRpc: application toolbox already registered, id: -1 Oct 26 08:52:22.223: vcpu-0| GuestRpc: Channel 0, guest application toolbox. Oct 26 08:52:22.223: vcpu-0| Vix: [2844 mainDispatch.c:3582]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=2, err=0). Oct 26 08:52:22.393: vcpu-0| TOOLS ToolsCapabilityGuestTempDirectory received 1 /tmp/vmware-root Oct 26 08:52:22.395: vcpu-0| TOOLS autoupgrade protocol version 2 Oct 26 08:52:22.395: vcpu-0| TOOLS ToolsCapabilityGuestConfDirectory received /etc/vmware-tools Oct 26 08:52:22.395: vcpu-0| ToolsSetVersionWork did nothing; new tools version (8324) matches old Tools version Oct 26 08:52:22.395: vcpu-0| Starting copy guest manifest to local C:\Users\CLIVE~1.DAR\AppData\Local\Temp\vmware-clive.darracott\manifest.txt.1 path. Oct 26 08:52:22.463: vcpu-0| Compared tools manifest from host and from the guest. Status = 2. Oct 26 08:52:22.463: vcpu-0| VMXVmdb_SetToolsVersionState: status value set to 'ok' Oct 26 08:52:22.463: vcpu-0| TOOLS installed legacy version 8324, available legacy version 8324 Oct 26 08:52:22.463: vcpu-0| TOOLS manifest update status is 2 (1-out of date, 2-ok, 3-no tools, 4-unmanaged, 5-unknown) Oct 26 08:52:22.463: vcpu-0| TOOLS will not be autoupgraded. Oct 26 08:52:22.463: vcpu-0| TOOLS Setting autoupgrade-checked TRUE. Oct 26 08:52:22.463: vcpu-0| TOOLS unified loop capability requested by 'toolbox'; now sending options via TCLO Oct 26 08:52:22.463: vcpu-0| TOOLS sending 'OS_PowerOn' (state=3 callback=0 clientData=0) state change request Oct 26 08:52:22.463: vcpu-0| Guest: toolbox: Version: build-301548 Oct 26 08:52:22.498: vcpu-0| TOOLS state change 3 returned status 1 Oct 26 08:52:24.888: mks| SVGA: Sync FIFO with SVGA disabled Oct 26 08:52:24.903: mks| HostOps hideCursor before defineCursor! Oct 26 08:52:24.903: vcpu-0| Guest OS = 0x5008 Oct 26 08:52:24.903: mks| Guest display topology changed: numDisplays 1 Oct 26 08:52:24.936: mks| HostOps hideCursor before defineCursor! Oct 26 08:52:25.016: vcpu-0| VMMouse: CMD Read ID Oct 26 08:52:25.016: vcpu-0| VMMouse: CMD Disable Oct 26 08:52:25.016: vcpu-0| VMMouse: Disabling VMMouse mode Oct 26 08:52:25.016: vcpu-0| VMMouse: CMD Read ID Oct 26 08:52:26.908: vcpu-0| VMMouse: CMD Read ID Oct 26 08:52:26.908: vcpu-0| VMMouse: CMD Disable Oct 26 08:52:26.908: vcpu-0| VMMouse: Disabling VMMouse mode Oct 26 08:52:52.288: vmx| GuestRpcSendTimedOut: message to toolbox-dnd timed out. Oct 26 08:54:13.791: mks| Setting thread 40 stack size to 1048576. Oct 26 08:54:13.794: vcpu-0| VMMouse: CMD Read ID Oct 26 08:54:13.874: mks| MKS switching absolute mouse on Oct 26 08:54:13.874: mks| Setting thread 40 stack size to 1048576. Oct 26 08:54:20.724: mks| Guest display topology changed: numDisplays 1 Oct 26 08:54:21.317: vcpu-0| Setting thread 41 stack size to 1048576. Oct 26 08:54:21.406: vcpu-0| Msg_Post: Warning Oct 26 08:54:21.406: vcpu-0| [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\dndlogs\dndlog.conf": The system cannot find the path specified. Oct 26 08:54:21.406: vcpu-0| [msg.sound.defaultbadwaveopen] The default sound device cannot be opened: Oct 26 08:54:21.406: vcpu-0| A device ID has been used that is out of range for your system. Oct 26 08:54:21.406: vcpu-0| [msg.pciSound.HostOpenDspChannelFailed] Sound will be disconnected. Oct 26 08:54:21.406: vcpu-0| ---------------------------------------- Oct 26 08:54:21.528: vcpu-0| Setting thread 42 stack size to 1048576. Oct 26 08:54:22.792: vcpu-0| GuestRpc: Channel 2, guest application toolbox-ui. Oct 26 08:54:24.125: vmx| DnDRegisterRpc: DnD rpc already set to 1 Oct 26 08:54:24.125: vmx| CopyPasteRegisterRpc: already set to 1 Oct 26 08:54:24.132: vcpu-0| GuestRpc: application toolbox-dnd already registered, id: -1 Oct 26 08:54:24.132: vcpu-0| GuestRpc: Channel 4, guest application toolbox-dnd. Oct 26 08:54:24.181: vcpu-0| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 08:54:41.840: mks| Setting thread 39 stack size to 1048576. Oct 26 08:54:41.868: mks| Setting thread 40 stack size to 1048576. Oct 26 08:54:48.544: mks| Setting thread 39 stack size to 1048576. Oct 26 08:54:48.550: mks| Setting thread 40 stack size to 1048576. Oct 26 08:55:08.457: mks| Setting thread 39 stack size to 1048576. Oct 26 08:55:08.473: mks| Setting thread 40 stack size to 1048576. Oct 26 08:55:15.940: mks| Setting thread 39 stack size to 1048576. Oct 26 08:55:16.567: mks| Setting thread 40 stack size to 1048576. Oct 26 08:55:45.817: mks| Setting thread 40 stack size to 1048576. Oct 26 08:57:18.358: vmx| scsi0:0: Command WRITE(10) took 1.011 seconds (ok) Oct 26 08:57:18.362: vmx| scsi0:0: Command WRITE(10) took 1.017 seconds (ok) Oct 26 08:57:18.383: vmx| scsi0:0: Command WRITE(10) took 1.038 seconds (ok) Oct 26 08:57:21.125: mks| Setting thread 40 stack size to 1048576. Oct 26 09:01:06.856: mks| Setting thread 39 stack size to 1048576. Oct 26 09:01:06.870: mks| Setting thread 40 stack size to 1048576. Oct 26 09:02:41.519: mks| Setting thread 39 stack size to 1048576. Oct 26 09:02:41.542: mks| Setting thread 40 stack size to 1048576. Oct 26 09:03:14.365: mks| Setting thread 39 stack size to 1048576. Oct 26 09:08:23.779: mks| Setting thread 39 stack size to 1048576. Oct 26 09:08:23.781: mks| Setting thread 40 stack size to 1048576. Oct 26 09:10:13.262: mks| Setting thread 39 stack size to 1048576. Oct 26 09:10:13.288: mks| Setting thread 40 stack size to 1048576. Oct 26 09:10:39.676: mks| Setting thread 39 stack size to 1048576. Oct 26 09:10:39.677: mks| Setting thread 40 stack size to 1048576. Oct 26 09:11:32.879: mks| Setting thread 39 stack size to 1048576. Oct 26 09:11:32.894: mks| Setting thread 40 stack size to 1048576. Oct 26 09:12:53.030: mks| Setting thread 39 stack size to 1048576. Oct 26 09:12:53.032: mks| Setting thread 40 stack size to 1048576. Oct 26 09:13:48.679: mks| Setting thread 39 stack size to 1048576. Oct 26 09:13:48.681: mks| Setting thread 40 stack size to 1048576. Oct 26 09:15:22.892: mks| Setting thread 39 stack size to 1048576. Oct 26 09:15:22.912: mks| Setting thread 40 stack size to 1048576. Oct 26 09:17:34.522: mks| Setting thread 39 stack size to 1048576. Oct 26 09:18:14.416: mks| Setting thread 39 stack size to 1048576. Oct 26 09:18:19.823: mks| Setting thread 39 stack size to 1048576. Oct 26 09:19:50.156: mks| Setting thread 39 stack size to 1048576. Oct 26 09:19:50.174: mks| Setting thread 40 stack size to 1048576. Oct 26 09:22:11.625: mks| Setting thread 39 stack size to 1048576. Oct 26 09:22:11.635: mks| Setting thread 40 stack size to 1048576. Oct 26 09:22:29.476: mks| Setting thread 39 stack size to 1048576. Oct 26 09:22:30.191: mks| Setting thread 40 stack size to 1048576. Oct 26 09:25:15.730: mks| Setting thread 39 stack size to 1048576. Oct 26 09:25:15.745: mks| Setting thread 40 stack size to 1048576. Oct 26 09:25:42.546: mks| Setting thread 39 stack size to 1048576. Oct 26 09:25:42.571: mks| Setting thread 40 stack size to 1048576. Oct 26 09:28:55.820: mks| Setting thread 39 stack size to 1048576. Oct 26 09:28:55.833: mks| Setting thread 40 stack size to 1048576. Oct 26 09:29:35.672: mks| Setting thread 39 stack size to 1048576. Oct 26 09:29:50.650: mks| Setting thread 39 stack size to 1048576. Oct 26 09:31:54.359: mks| Setting thread 39 stack size to 1048576. Oct 26 09:32:12.601: mks| Setting thread 39 stack size to 1048576. Oct 26 09:40:32.697: mks| Setting thread 39 stack size to 1048576. Oct 26 09:40:33.894: mks| Setting thread 40 stack size to 1048576. Oct 26 09:41:50.465: mks| Setting thread 39 stack size to 1048576. Oct 26 09:41:50.478: mks| Setting thread 40 stack size to 1048576. Oct 26 09:42:53.341: mks| Setting thread 39 stack size to 1048576. Oct 26 09:42:53.351: mks| Setting thread 40 stack size to 1048576. Oct 26 09:43:24.242: mks| Setting thread 39 stack size to 1048576. Oct 26 09:43:24.580: mks| Setting thread 40 stack size to 1048576. Oct 26 09:43:29.860: mks| Setting thread 39 stack size to 1048576. Oct 26 09:43:29.860: mks| Setting thread 40 stack size to 1048576. Oct 26 09:44:11.683: mks| Setting thread 39 stack size to 1048576. Oct 26 09:44:11.685: mks| Setting thread 40 stack size to 1048576. Oct 26 09:46:35.526: mks| Setting thread 39 stack size to 1048576. Oct 26 09:46:35.540: mks| Setting thread 40 stack size to 1048576. Oct 26 09:51:05.575: mks| Setting thread 39 stack size to 1048576. Oct 26 09:51:05.577: mks| Setting thread 40 stack size to 1048576. Oct 26 09:52:28.402: mks| Setting thread 39 stack size to 1048576. Oct 26 09:52:28.782: mks| Setting thread 40 stack size to 1048576. Oct 26 09:54:56.929: mks| Setting thread 39 stack size to 1048576. Oct 26 09:54:56.934: mks| Setting thread 40 stack size to 1048576. Oct 26 09:55:06.258: mks| Setting thread 39 stack size to 1048576. Oct 26 09:55:06.259: mks| Setting thread 40 stack size to 1048576. Oct 26 09:56:23.617: mks| Setting thread 39 stack size to 1048576. Oct 26 09:58:00.445: mks| Setting thread 39 stack size to 1048576. Oct 26 09:58:00.454: mks| Setting thread 40 stack size to 1048576. Oct 26 10:00:07.076: mks| Setting thread 39 stack size to 1048576. Oct 26 10:01:40.503: mks| Setting thread 39 stack size to 1048576. Oct 26 10:01:40.524: mks| Setting thread 40 stack size to 1048576. Oct 26 10:02:45.835: mks| Setting thread 39 stack size to 1048576. Oct 26 10:04:10.113: mks| Setting thread 39 stack size to 1048576. Oct 26 10:04:10.133: mks| Setting thread 40 stack size to 1048576. Oct 26 10:05:38.844: mks| Setting thread 39 stack size to 1048576. Oct 26 10:05:38.857: mks| Setting thread 40 stack size to 1048576. Oct 26 10:15:15.394: mks| Setting thread 39 stack size to 1048576. Oct 26 10:15:16.547: mks| Setting thread 40 stack size to 1048576. Oct 26 10:15:21.042: mks| Setting thread 40 stack size to 1048576. Oct 26 10:16:40.230: mks| Setting thread 39 stack size to 1048576. Oct 26 10:16:40.249: mks| Setting thread 40 stack size to 1048576. Oct 26 10:23:16.907: mks| Setting thread 39 stack size to 1048576. Oct 26 10:23:16.925: mks| Setting thread 40 stack size to 1048576. Oct 26 10:24:21.767: mks| Setting thread 39 stack size to 1048576. Oct 26 10:24:21.785: mks| Setting thread 40 stack size to 1048576. Oct 26 10:26:51.360: mks| Setting thread 39 stack size to 1048576. Oct 26 10:26:51.372: mks| Setting thread 40 stack size to 1048576. Oct 26 10:29:42.925: mks| Setting thread 39 stack size to 1048576. Oct 26 10:29:42.946: mks| Setting thread 40 stack size to 1048576. Oct 26 10:30:41.099: mks| Setting thread 39 stack size to 1048576. Oct 26 10:32:24.705: mks| Setting thread 39 stack size to 1048576. Oct 26 10:32:24.715: mks| Setting thread 40 stack size to 1048576. Oct 26 10:33:30.416: mks| Setting thread 39 stack size to 1048576. Oct 26 10:33:30.425: mks| Setting thread 40 stack size to 1048576. Oct 26 10:33:34.002: mks| Setting thread 39 stack size to 1048576. Oct 26 10:33:34.018: mks| Setting thread 40 stack size to 1048576. Oct 26 10:35:09.566: mks| Setting thread 39 stack size to 1048576. Oct 26 10:35:09.580: mks| Setting thread 40 stack size to 1048576. Oct 26 10:37:15.560: mks| Setting thread 39 stack size to 1048576. Oct 26 10:38:18.974: mks| Setting thread 39 stack size to 1048576. Oct 26 10:38:19.839: mks| Setting thread 39 stack size to 1048576. Oct 26 11:00:47.533: mks| Setting thread 39 stack size to 1048576. Oct 26 11:00:47.555: mks| Setting thread 40 stack size to 1048576. Oct 26 11:07:07.748: mks| Setting thread 39 stack size to 1048576. Oct 26 11:17:55.609: mks| Setting thread 39 stack size to 1048576. Oct 26 11:17:55.629: mks| Setting thread 40 stack size to 1048576. Oct 26 11:18:48.014: mks| Setting thread 39 stack size to 1048576. Oct 26 11:18:48.399: mks| Setting thread 39 stack size to 1048576. Oct 26 11:19:54.006: mks| Setting thread 39 stack size to 1048576. Oct 26 11:20:22.356: mks| Setting thread 39 stack size to 1048576. Oct 26 11:24:46.098: mks| Setting thread 39 stack size to 1048576. Oct 26 11:24:46.125: mks| Setting thread 40 stack size to 1048576. Oct 26 11:27:20.345: mks| Setting thread 39 stack size to 1048576. Oct 26 11:27:20.358: mks| Setting thread 40 stack size to 1048576. Oct 26 11:27:46.093: mks| Setting thread 39 stack size to 1048576. Oct 26 11:31:30.250: mks| Setting thread 39 stack size to 1048576. Oct 26 11:31:30.253: mks| Setting thread 40 stack size to 1048576. Oct 26 11:49:16.530: mks| Setting thread 39 stack size to 1048576. Oct 26 11:49:16.830: mks| Setting thread 39 stack size to 1048576. Oct 26 11:49:17.120: mks| Setting thread 39 stack size to 1048576. Oct 26 11:49:17.400: mks| Setting thread 39 stack size to 1048576. Oct 26 11:49:18.880: mks| Setting thread 39 stack size to 1048576. Oct 26 11:49:19.924: mks| Setting thread 39 stack size to 1048576. Oct 26 11:53:27.651: mks| Setting thread 39 stack size to 1048576. Oct 26 11:53:27.664: mks| Setting thread 40 stack size to 1048576. Oct 26 12:00:16.568: mks| Setting thread 39 stack size to 1048576. Oct 26 12:02:53.131: mks| Setting thread 39 stack size to 1048576. Oct 26 12:02:53.156: mks| Setting thread 40 stack size to 1048576. Oct 26 12:04:49.880: mks| Setting thread 39 stack size to 1048576. Oct 26 12:04:49.902: mks| Setting thread 40 stack size to 1048576. Oct 26 12:07:34.781: mks| Setting thread 39 stack size to 1048576. Oct 26 12:07:34.799: mks| Setting thread 40 stack size to 1048576. Oct 26 12:14:14.645: mks| Setting thread 39 stack size to 1048576. Oct 26 12:14:14.653: mks| Setting thread 40 stack size to 1048576. Oct 26 12:17:12.320: mks| Setting thread 39 stack size to 1048576. Oct 26 12:18:06.605: mks| Setting thread 39 stack size to 1048576. Oct 26 12:18:06.628: mks| Setting thread 40 stack size to 1048576. Oct 26 12:22:24.683: mks| Setting thread 39 stack size to 1048576. Oct 26 12:22:24.692: mks| Setting thread 40 stack size to 1048576. Oct 26 12:23:03.891: mks| Setting thread 39 stack size to 1048576. Oct 26 12:23:03.913: mks| Setting thread 40 stack size to 1048576. Oct 26 13:39:53.939: mks| Setting thread 39 stack size to 1048576. Oct 26 13:39:54.298: mks| Setting thread 40 stack size to 1048576. Oct 26 13:39:56.236: mks| Setting thread 40 stack size to 1048576. Oct 26 13:39:56.716: mks| Setting thread 40 stack size to 1048576. Oct 26 13:40:09.177: mks| Setting thread 39 stack size to 1048576. Oct 26 13:40:09.195: mks| Setting thread 40 stack size to 1048576. Oct 26 13:41:07.559: vmx| DISKLIB-LIB : numIOs = 50000 numMergedIOs = 1621 numSplitIOs = 159 Oct 26 13:43:20.155: mks| Setting thread 39 stack size to 1048576. Oct 26 13:43:20.177: mks| Setting thread 40 stack size to 1048576. Oct 26 13:45:09.218: mks| Setting thread 39 stack size to 1048576. Oct 26 13:45:09.236: mks| Setting thread 40 stack size to 1048576. Oct 26 13:45:35.578: mks| Setting thread 39 stack size to 1048576. Oct 26 13:45:38.633: mks| Setting thread 39 stack size to 1048576. Oct 26 13:46:44.594: mks| Setting thread 39 stack size to 1048576. Oct 26 13:47:21.689: mks| Setting thread 39 stack size to 1048576. Oct 26 13:50:49.791: mks| Setting thread 39 stack size to 1048576. Oct 26 13:51:06.400: mks| Setting thread 39 stack size to 1048576. Oct 26 13:52:32.749: mks| Setting thread 39 stack size to 1048576. Oct 26 13:52:32.769: mks| Setting thread 40 stack size to 1048576. Oct 26 13:52:53.968: mks| Setting thread 39 stack size to 1048576. Oct 26 13:53:58.205: mks| Setting thread 39 stack size to 1048576. Oct 26 13:53:58.220: mks| Setting thread 40 stack size to 1048576. Oct 26 13:57:55.449: mks| Setting thread 39 stack size to 1048576. Oct 26 13:57:55.451: mks| Setting thread 40 stack size to 1048576. Oct 26 14:10:57.737: mks| Setting thread 39 stack size to 1048576. Oct 26 14:10:57.757: mks| Setting thread 40 stack size to 1048576. Oct 26 14:12:50.452: mks| Setting thread 39 stack size to 1048576. Oct 26 14:28:59.974: mks| Setting thread 39 stack size to 1048576. Oct 26 14:28:59.994: mks| Setting thread 40 stack size to 1048576. Oct 26 14:29:37.407: mks| Setting thread 39 stack size to 1048576. Oct 26 14:32:30.749: mks| Setting thread 39 stack size to 1048576. Oct 26 14:42:08.074: mks| Setting thread 39 stack size to 1048576. Oct 26 14:42:08.088: mks| Setting thread 40 stack size to 1048576. Oct 26 14:48:08.676: mks| Setting thread 39 stack size to 1048576. Oct 26 14:48:08.691: mks| Setting thread 40 stack size to 1048576. Oct 26 15:02:00.997: mks| Setting thread 39 stack size to 1048576. Oct 26 15:02:01.023: mks| Setting thread 40 stack size to 1048576. Oct 26 15:36:57.611: mks| Setting thread 39 stack size to 1048576. Oct 26 15:36:57.614: mks| Setting thread 40 stack size to 1048576. Oct 26 15:37:02.156: mks| Setting thread 39 stack size to 1048576. Oct 26 15:38:55.935: mks| Setting thread 39 stack size to 1048576. Oct 26 15:38:55.952: mks| Setting thread 40 stack size to 1048576. Oct 26 15:41:34.030: mks| Setting thread 39 stack size to 1048576. Oct 26 15:41:34.063: mks| Setting thread 40 stack size to 1048576. Oct 26 15:42:09.496: mks| Setting thread 39 stack size to 1048576. Oct 26 15:42:09.499: mks| Setting thread 40 stack size to 1048576. Oct 26 15:42:55.570: mks| Setting thread 39 stack size to 1048576. Oct 26 15:42:55.573: mks| Setting thread 40 stack size to 1048576. Oct 26 15:43:44.540: mks| Setting thread 39 stack size to 1048576. Oct 26 15:43:44.547: mks| Setting thread 40 stack size to 1048576. Oct 26 15:46:22.574: mks| Setting thread 39 stack size to 1048576. Oct 26 15:46:22.594: mks| Setting thread 40 stack size to 1048576. Oct 26 15:46:56.741: mks| Setting thread 39 stack size to 1048576. Oct 26 15:47:50.267: mks| Setting thread 39 stack size to 1048576. Oct 26 15:47:50.288: mks| Setting thread 40 stack size to 1048576. Oct 26 15:48:40.008: mks| Setting thread 39 stack size to 1048576. Oct 26 15:48:40.583: mks| Setting thread 40 stack size to 1048576. Oct 26 15:49:58.668: mks| Setting thread 40 stack size to 1048576. Oct 26 15:50:04.945: mks| Setting thread 39 stack size to 1048576. Oct 26 15:50:05.739: mks| Setting thread 40 stack size to 1048576. Oct 26 15:52:48.643: mks| Setting thread 39 stack size to 1048576. Oct 26 15:52:48.654: mks| Setting thread 40 stack size to 1048576. Oct 26 15:53:19.353: mks| Setting thread 39 stack size to 1048576. Oct 26 16:01:02.545: mks| Setting thread 39 stack size to 1048576. Oct 26 16:01:02.562: mks| Setting thread 40 stack size to 1048576. Oct 26 16:03:45.214: mks| Setting thread 39 stack size to 1048576. Oct 26 16:03:45.229: mks| Setting thread 40 stack size to 1048576. Oct 26 16:04:18.248: mks| Setting thread 39 stack size to 1048576. Oct 26 16:04:18.267: mks| Setting thread 40 stack size to 1048576. Oct 26 16:04:30.310: mks| Setting thread 39 stack size to 1048576. Oct 26 16:04:51.873: mks| Setting thread 39 stack size to 1048576. Oct 26 16:04:51.903: mks| Setting thread 40 stack size to 1048576. Oct 26 16:05:18.514: mks| Setting thread 39 stack size to 1048576. Oct 26 16:19:01.405: mks| Setting thread 39 stack size to 1048576. Oct 26 16:19:57.705: mks| Setting thread 39 stack size to 1048576. Oct 26 16:19:57.707: mks| Setting thread 40 stack size to 1048576. Oct 26 16:20:11.201: mks| Setting thread 39 stack size to 1048576. Oct 26 16:20:11.576: mks| Setting thread 40 stack size to 1048576. Oct 26 16:23:07.015: mks| Setting thread 40 stack size to 1048576. Oct 26 16:23:11.640: mks| Setting thread 40 stack size to 1048576. Oct 26 16:23:14.957: mks| Setting thread 39 stack size to 1048576. Oct 26 16:23:16.424: mks| Setting thread 40 stack size to 1048576. Oct 26 16:23:42.217: mks| Setting thread 40 stack size to 1048576. Oct 26 16:24:11.074: mks| Setting thread 39 stack size to 1048576. Oct 26 16:24:12.074: mks| Setting thread 40 stack size to 1048576. Oct 26 16:25:05.026: mks| Setting thread 39 stack size to 1048576. Oct 26 16:25:05.027: mks| Setting thread 40 stack size to 1048576. Oct 26 16:29:53.005: mks| Setting thread 39 stack size to 1048576. Oct 26 16:29:53.031: mks| Setting thread 40 stack size to 1048576. Oct 26 16:32:11.716: mks| Setting thread 39 stack size to 1048576. Oct 26 16:32:11.751: mks| Setting thread 40 stack size to 1048576. Oct 26 16:32:48.153: mks| Setting thread 39 stack size to 1048576. Oct 26 16:32:48.164: mks| Setting thread 40 stack size to 1048576. Oct 26 16:35:27.121: mks| Setting thread 39 stack size to 1048576. Oct 26 16:35:27.138: mks| Setting thread 40 stack size to 1048576. Oct 26 16:41:19.464: mks| Setting thread 39 stack size to 1048576. Oct 26 16:41:19.474: mks| Setting thread 40 stack size to 1048576. Oct 26 16:42:20.594: mks| Setting thread 39 stack size to 1048576. Oct 26 16:42:28.075: mks| Setting thread 39 stack size to 1048576. Oct 26 16:42:28.088: mks| Setting thread 40 stack size to 1048576. Oct 26 16:44:00.610: mks| Setting thread 39 stack size to 1048576. Oct 26 16:44:00.637: mks| Setting thread 40 stack size to 1048576. Oct 26 16:44:06.380: mks| Setting thread 39 stack size to 1048576. Oct 26 16:44:06.395: mks| Setting thread 40 stack size to 1048576. Oct 26 16:46:18.928: mks| Setting thread 39 stack size to 1048576. Oct 26 16:46:18.938: mks| Setting thread 40 stack size to 1048576. Oct 26 16:46:26.267: mks| Setting thread 39 stack size to 1048576. Oct 26 16:46:36.589: mks| Setting thread 39 stack size to 1048576. Oct 26 16:48:19.756: mks| Setting thread 39 stack size to 1048576. Oct 26 16:48:19.786: mks| Setting thread 40 stack size to 1048576. Oct 26 16:49:55.277: mks| Setting thread 39 stack size to 1048576. Oct 26 16:49:55.277: mks| Setting thread 40 stack size to 1048576. Oct 26 16:51:12.757: mks| Setting thread 39 stack size to 1048576. Oct 26 16:51:12.795: mks| Setting thread 40 stack size to 1048576. Oct 26 16:51:45.450: mks| Setting thread 39 stack size to 1048576. Oct 26 16:51:45.478: mks| Setting thread 40 stack size to 1048576. Oct 26 17:12:43.331: mks| Setting thread 39 stack size to 1048576. Oct 26 17:12:43.336: mks| Setting thread 40 stack size to 1048576. Oct 26 17:13:36.410: mks| Setting thread 39 stack size to 1048576. Oct 26 17:13:40.603: mks| Setting thread 39 stack size to 1048576. Oct 26 17:13:43.756: mks| Setting thread 39 stack size to 1048576. Oct 26 17:13:45.126: mks| Setting thread 39 stack size to 1048576. Oct 26 17:13:45.579: mks| Setting thread 40 stack size to 1048576. Oct 26 17:13:47.947: mks| Setting thread 40 stack size to 1048576. Oct 26 17:14:29.457: mks| Setting thread 40 stack size to 1048576. Oct 26 17:15:00.789: mks| Setting thread 39 stack size to 1048576. Oct 26 17:15:00.796: mks| Setting thread 40 stack size to 1048576. Oct 26 17:15:29.632: mks| Setting thread 39 stack size to 1048576. Oct 26 17:15:29.657: mks| Setting thread 40 stack size to 1048576. Oct 26 17:22:53.281: mks| Setting thread 39 stack size to 1048576. Oct 26 17:22:53.294: mks| Setting thread 40 stack size to 1048576. Oct 26 17:25:56.314: mks| Setting thread 39 stack size to 1048576. Oct 26 17:25:56.329: mks| Setting thread 40 stack size to 1048576. Oct 26 17:27:48.365: mks| Setting thread 39 stack size to 1048576. Oct 26 17:27:48.380: mks| Setting thread 40 stack size to 1048576. Oct 26 17:27:49.923: mks| Setting thread 39 stack size to 1048576. Oct 26 17:29:54.033: mks| Setting thread 39 stack size to 1048576. Oct 26 17:34:01.385: mks| Setting thread 39 stack size to 1048576. Oct 26 17:34:01.925: mks| Setting thread 40 stack size to 1048576. Oct 26 17:35:23.036: mks| Setting thread 39 stack size to 1048576. Oct 26 17:35:23.047: mks| Setting thread 40 stack size to 1048576. Oct 26 17:36:44.985: mks| Setting thread 39 stack size to 1048576. Oct 26 17:36:44.987: mks| Setting thread 40 stack size to 1048576. Oct 26 17:41:22.161: mks| Setting thread 39 stack size to 1048576. Oct 26 17:41:22.163: mks| Setting thread 40 stack size to 1048576. Oct 26 17:41:26.428: mks| Setting thread 39 stack size to 1048576. Oct 26 17:41:29.576: vcpu-0| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 17:41:29.626: vcpu-0| VMMouse: CMD Disable Oct 26 17:41:29.626: vcpu-0| VMMouse: Disabling VMMouse mode Oct 26 17:41:29.635: mks| MKS switching absolute mouse off Oct 26 17:41:29.992: vcpu-0| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 17:41:30.033: vcpu-0| GuestRpc: Channel 4, unable to send an rpc. Oct 26 17:41:30.033: vcpu-0| GuestRpc: Reinitializing Channel 4(toolbox-dnd) Oct 26 17:41:30.033: vcpu-0| GuestMsg: Channel 4, Cannot unpost because the previous post is already completed Oct 26 17:41:30.034: vcpu-0| TOOLS unity.show.taskbar failed: failure of the transport layer Oct 26 17:41:30.034: vcpu-0| GuestRpc: Channel 4 reinitialized. Oct 26 17:41:30.034: vcpu-0| GuestRpc: Channel 4 reinitialized. Oct 26 17:41:30.034: vcpu-0| GuestRpc: Channel 4 reinitialized. Oct 26 17:41:32.593: vcpu-0| TOOLS autoupgrade protocol version 0 Oct 26 17:41:32.594: vcpu-0| TOOLS ToolsCapabilityGuestTempDirectory received 0 Oct 26 17:41:32.594: vcpu-0| GuestRpc: Reinitializing Channel 0(toolbox) Oct 26 17:41:32.594: vcpu-0| GuestRpc: Channel 0 reinitialized. Oct 26 17:41:36.641: vcpu-0| UHCI: HCReset Oct 26 17:41:36.649: vcpu-0| PIIX4: PM Soft Off. Good-bye. Oct 26 17:41:36.652: vmx| Stopping VCPU threads... Oct 26 17:41:36.666: mks| Ending MKSRole pseudocalls, state was 1 Oct 26 17:41:36.666: mks| Detaching from window system. Oct 26 17:41:36.666: mks| MKS: Base polling period is 1000000us Oct 26 17:41:36.667: mks| Async MKS thread is exiting Oct 26 17:41:36.667: vmx| Vix: [3840 mainDispatch.c:1015]: VMAutomation_PowerOff: Powering off. Oct 26 17:41:36.667: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0' Oct 26 17:41:36.667: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0' Oct 26 17:41:36.667: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0' Oct 26 17:41:36.669: vmx| VMXVmdb_SetToolsVersionState: status value set to 'ok' Oct 26 17:41:36.680: vmx| MKS local poweroff Oct 26 17:41:36.680: usbCCIDEnumCards| USB-CCID: Card enum thread exiting. Oct 26 17:41:36.681: vmx| scsi0:0: numIOs = 60836 numMergedIOs = 1846 numSplitIOs = 163 ( 8.1%) Oct 26 17:41:37.033: vmx| AIOWIN32C: asyncOps=62361 syncOps=92 bufSize=0Kb fixedOps=0 sgOps=62240 sgOn=1 Oct 26 17:41:37.033: aioCompletion| AIO thread processed 62361 completions Oct 26 17:41:37.033: vmx| AIOWIN32: asyncOps=0 syncOps=0 bufSize=0Kb delayed=0 fixed=0 sgOp=0 sgOn=1 Oct 26 17:41:37.203: vmx| WORKER: asyncOps=0 maxActiveOps=0 maxPending=0 maxCompleted=0 Oct 26 17:41:37.385: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 Oct 26 17:41:37.385: vmx| Vix: [3840 mainDispatch.c:3667]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down. Oct 26 17:41:37.426: vmx| VMXVmdb_LoadRawConfig: Loading raw config Oct 26 17:41:37.445: vmx| Vix: [3840 mainDispatch.c:3661]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 Oct 26 17:41:37.445: vmx| Vix: [3840 mainDispatch.c:3667]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down. Oct 26 17:41:37.445: vmx| Transitioned vmx/execState/val to poweredOff Oct 26 17:41:37.445: vmx| VMX idle exit Oct 26 17:41:37.445: WinNotifyThread| WinNotify thread exiting Oct 26 17:41:37.446: vmx| Vix: [3840 mainDispatch.c:747]: VMAutomation_LateShutdown() Oct 26 17:41:37.447: vmx| Vix: [3840 mainDispatch.c:697]: VMAutomationCloseListenerSocket. Closing listener socket. Oct 26 17:41:37.447: vmx| Flushing VMX VMDB connections Oct 26 17:41:37.453: vmx| VMX exit (0). Oct 26 17:41:37.453: vmx| AIOMGR-S : stat o=2 r=6 w=0 i=0 br=98304 bw=0 Oct 26 17:41:37.453: vmx| FileTrack_Exit: done