Hello,
We have recently deployed a P2V machine into a ESXi host but randomly the VM will suspend with no user interaction.
The log only shows "Virtual Machines is Suspended"
Is there anyway to stop this auto Suspend?
Hi,
Is there any "rules/settings" in the VM that will switch it in stand by mode ? You may confirm it under "Power Options" in Windows (I do not have any Windows Machine near me to check the exact section where it can be found).
With VMware Tools installed, Stand by mode may place the VM in suspend from ESXi point of view.
Hope it helps.
check if there is enough space in the datastore where VM is running.
Hello,
The Datastore has 232.58GB of free space.
The only settings in the VM are under "Guest Power Management" but that is set to.
"Put the guest OS into standby mode and leave the virtual machine powered on"
It could be related to a KB that I where a VM gets suspended
under heavy I/O. But This is only running Server 2003 and nothing like exchange.
I meant under Windows for the "Power Management" point, not under VMware Settings
Ah, Sorry.
Screen Saver is set to off and the Power Scheme is set to "Always On"
Did you already take a look at the VM's vmware.log file to see whether this contains any related entries?
André
Not really sure what I am looking for the the log is full of:
GuestRpc: Channel 4, conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 2
2013-12-23T09:41:49.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T09:41:49.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T09:41:49.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T09:41:50.888Z| vcpu-2| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T09:41:50.889Z| vcpu-2| I120: GuestRpc: Channel 4, conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 2
2013-12-23T09:41:50.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T09:41:50.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T09:41:50.889Z| vcpu-2| I120: GuestRpc: Channel 4 reinitialized.
(It just happened again)
Here is the whole vmware.log
2013-12-23T11:45:44.826Z| vmx| I120: Log for VMware ESX pid=4505616 version=5.5.0 build=build-1331820 option=Release
2013-12-23T11:45:44.826Z| vmx| I120: The process is 64-bit.
2013-12-23T11:45:44.826Z| vmx| I120: Host codepage=UTF-8 encoding=UTF-8
2013-12-23T11:45:44.826Z| vmx| I120: Host is VMkernel 5.5.0
2013-12-23T11:45:44.823Z| vmx| I120: VTHREAD initialize main thread 0 "vmx" pid 4505616
2013-12-23T11:45:44.823Z| vmx| I120: Msg_SetLocaleEx: HostLocale=UTF-8 UserLocale=NULL
2013-12-23T11:45:44.824Z| vmx| I120: ConfigDB: Failed to load /usr/lib/vmware/config
2013-12-23T11:45:44.824Z| vmx| I120: ConfigDB: Failed to load ~/.vmware/config
2013-12-23T11:45:44.824Z| vmx| I120: OBJLIB-LIB: Objlib initialized.
2013-12-23T11:45:44.824Z| vmx| I120: PREF Optional preferences file not found at /usr/lib/vmware/config. Using default values.
2013-12-23T11:45:44.824Z| vmx| I120: PREF Optional preferences file not found at //.vmware/config. Using default values.
2013-12-23T11:45:44.824Z| vmx| I120: PREF Failed to load user preferences.
2013-12-23T11:45:44.826Z| vmx| I120: Hostname=Server1
2013-12-23T11:45:44.827Z| vmx| I120: IP=127.0.0.1 (lo0)
2013-12-23T11:45:44.827Z| vmx| I120: IP=10.10.10.250 (vmk0)
2013-12-23T11:45:44.827Z| vmx| I120: vmkernel build type: release
2013-12-23T11:45:44.827Z| vmx| I120: System uptime 1461954515678 us
2013-12-23T11:45:44.827Z| vmx| I120: Command line: "/bin/vmx" "-s" "sched.group=host/user" "-#" "product=2;name=VMware ESX;version=5.5.0;buildnumber=1331820;licensename=VMware ESX Server;licenseversion=5.0;" "-@" "duplex=3;msgs=ui" "/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmx"
2013-12-23T11:45:44.827Z| vmx| I120: Environment: "USER=root" "HOME=/" "SHELL=/bin/sh" "LANG=C"
2013-12-23T11:45:44.827Z| vmx| I120: Msg_SetLocaleEx: HostLocale=UTF-8 UserLocale=NULL
2013-12-23T11:45:44.827Z| vmx| I120: Duplex socket: 3
2013-12-23T11:45:44.827Z| vmx| W110: CnxNeedScrub: Time to scrub dir /var/run/vmware
2013-12-23T11:45:44.849Z| vmx| I120: Connecting 'ui' to fd '3' with user '(null)'
2013-12-23T11:45:44.849Z| vmx| I120: VmdbAddConnection: cnxPath=/db/connection/#1/, cnxIx=1
2013-12-23T11:45:44.849Z| vmx| I120: /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmx: Setup symlink /var/run/vmware/bb511644f3fc29f6f1cca3d8b89019c1 -> /var/run/vmware/root_0/1387799144827227_4505616
2013-12-23T11:45:44.849Z| vmx| I120: Vix: [4505616 mainDispatch.c:463]: VMAutomation: Initializing VMAutomation.
2013-12-23T11:45:44.849Z| vmx| I120: Vix: [4505616 mainDispatch.c:760]: VMAutomationOpenListenerSocket() listening
2013-12-23T11:45:44.852Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 additionalError=0
2013-12-23T11:45:44.852Z| vmx| I120: Transitioned vmx/execState/val to poweredOff
2013-12-23T11:45:44.852Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0
2013-12-23T11:45:44.852Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=2, newAppState=1877, success=1 additionalError=0
2013-12-23T11:45:44.852Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1881, success=1 additionalError=0
2013-12-23T11:45:44.853Z| vmx| I120: FeatureCompat: EVC masks:
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID vendor: GenuineIntel
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID family: 0x6 model: 0x3a stepping: 0x9
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID codename: Ivy Bridge E3
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID name: Intel(R) Xeon(R) CPU E3-1220 V2 @ 3.10GHz
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000000, 0: 0x0000000d 0x756e6547 0x6c65746e 0x49656e69
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000001, 0: 0x000306a9 0x00100800 0x77bae3ff 0xbfebfbff
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000002, 0: 0x76035a01 0x00f0b0ff 0x00000000 0x00ca0000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000004, 0: 0x1c004121 0x01c0003f 0x0000003f 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000004, 1: 0x1c004122 0x01c0003f 0x0000003f 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000004, 2: 0x1c004143 0x01c0003f 0x000001ff 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000004, 3: 0x1c03c163 0x03c0003f 0x00001fff 0x00000006
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000004, 4: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00001120
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000006, 0: 0x00000077 0x00000002 0x00000009 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000007, 0: 0x00000000 0x00000281 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000008, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000a, 0: 0x07300803 0x00000000 0x00000000 0x00000603
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000b, 0: 0x00000001 0x00000001 0x00000100 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000b, 1: 0x00000004 0x00000004 0x00000201 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000b, 2: 0x00000000 0x00000000 0x00000002 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 0: 0x00000007 0x00000240 0x00000340 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1: 0x00000001 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2: 0x00000100 0x00000240 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 4: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 5: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 6: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 7: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 8: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 9: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, a: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, b: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, c: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, d: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, e: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, f: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 10: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 11: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 12: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 13: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 14: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 15: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 16: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 17: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 18: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 19: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1a: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1b: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1c: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1d: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1e: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 1f: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 20: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 21: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 22: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 23: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 24: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 25: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 26: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 27: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 28: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 29: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2a: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2b: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2c: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2d: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2e: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 2f: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 30: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 31: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 32: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 33: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 34: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 35: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 36: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 37: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 38: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 39: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3a: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3b: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3c: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3d: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3e: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 0000000d, 3f: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x28100800
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000002, 0: 0x20202020 0x6e492020 0x286c6574 0x58202952
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000003, 0: 0x286e6f65 0x43202952 0x45205550 0x32312d33
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000004, 0: 0x56203032 0x20402032 0x30312e33 0x007a4847
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000006, 0: 0x00000000 0x00000000 0x01006040 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000100
2013-12-23T11:45:44.853Z| vmx| I120: hostCPUID level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:44.853Z| vmx| I120: CPUID differences from hostCPUID.
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[1] level 00000001, 0: 0x000306a9 0x02100800 0x77bae3ff 0xbfebfbff
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[1] level 0000000b, 0: 0x00000001 0x00000001 0x00000100 0x00000002
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[1] level 0000000b, 1: 0x00000004 0x00000004 0x00000201 0x00000002
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[1] level 0000000b, 2: 0x00000000 0x00000000 0x00000002 0x00000002
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[2] level 00000001, 0: 0x000306a9 0x04100800 0x77bae3ff 0xbfebfbff
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[2] level 0000000b, 0: 0x00000001 0x00000001 0x00000100 0x00000004
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[2] level 0000000b, 1: 0x00000004 0x00000004 0x00000201 0x00000004
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[2] level 0000000b, 2: 0x00000000 0x00000000 0x00000002 0x00000004
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[3] level 00000001, 0: 0x000306a9 0x06100800 0x77bae3ff 0xbfebfbff
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[3] level 0000000b, 0: 0x00000001 0x00000001 0x00000100 0x00000006
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[3] level 0000000b, 1: 0x00000004 0x00000004 0x00000201 0x00000006
2013-12-23T11:45:44.853Z| vmx| I120: CPUID[3] level 0000000b, 2: 0x00000000 0x00000000 0x00000002 0x00000006
2013-12-23T11:45:44.853Z| vmx| I120: CPUID Maximum Physical Address Bits supported across all CPUs: 36
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x3a = 0x5
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x480 = 0xda040000000010
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x481 = 0x7f00000016
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x482 = 0xfff9fffe0401e172
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x483 = 0x7fffff00036dff
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x484 = 0xffff000011ff
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x485 = 0x100401e5
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x486 = 0x80000021
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x487 = 0xffffffff
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x488 = 0x2000
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x489 = 0x1767ff
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48a = 0x2a
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48b = 0x8ff00000000
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48c = 0xf0106114141
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48d = 0x7f00000016
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48e = 0xfff9fffe04006172
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x48f = 0x7fffff00036dfb
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x490 = 0xffff000011fb
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0x491 = 0
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0xc0010114 = 0
2013-12-23T11:45:44.853Z| vmx| I120: Common: MSR 0xce = 0x81010e0011f00
2013-12-23T11:45:44.854Z| vmx| I120: UTIL: Change file descriptor limit from soft 2124,hard 2124 to soft 4096,hard 4096.
2013-12-23T11:45:44.854Z| vmx| I120: PTSC: using TSC + offset (-512878807492)
2013-12-23T11:45:44.854Z| vmx| I120: PTSC: hardware TSCs are synchronized.
2013-12-23T11:45:44.854Z| vmx| I120: PTSC: current PTSC=4521768541903552
2013-12-23T11:45:44.854Z| vmx| I120: VMIOP: Init started
2013-12-23T11:45:44.854Z| vmx| I120: MKSXlib: Initialized thread-safe Xlib
2013-12-23T11:45:44.854Z| vmx| W110: ObtainHardwareID unexpected failure: 22.
2013-12-23T11:45:44.854Z| vmx| W110: Hostinfo_MachineID ObtainHardwareID failure (Invalid argument); providing default.
2013-12-23T11:45:44.854Z| vmx| I120: [0xB284000-0xC1D6424): /bin/vmx
2013-12-23T11:45:45.018Z| vmx| I120: changing directory to /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/.
2013-12-23T11:45:45.018Z| vmx| I120: Config file: /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmx
2013-12-23T11:45:45.018Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1875, success=1 additionalError=0
2013-12-23T11:45:45.018Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=2, newAppState=1878, success=1 additionalError=0
2013-12-23T11:45:45.297Z| vmx| W110: PowerOn
2013-12-23T11:45:45.304Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1871, success=1 additionalError=0
2013-12-23T11:45:45.305Z| vmx| I120: UNAME VMkernel Server1 5.5.0 #1 SMP Release build-1331820 Sep 18 2013 23:08:31 x86_64 (uwglibc release: vmware, version: 2.12.2)
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- USER PREFERENCES //.vmware/preferences
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- USER DEFAULTS //.vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- HOST DEFAULTS /etc/vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT libdir = /usr/lib/vmware
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.nfc = vmware-hostd:ha-nfc
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.nfcssl = vmware-hostd:ha-nfcssl
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.vpxa-nfcssl = vmware-vpxa:vpxa-nfcssl
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.vpxa-nfc = vmware-vpxa:vpxa-nfc
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.fullpath = /sbin/authd
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- SITE DEFAULTS /usr/lib/vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- NONPERSISTENT
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.group = host/user
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- COMMAND LINE
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.group = host/user
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- RECORDING
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.group = host/user
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- CONFIGURATION /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmx
2013-12-23T11:45:45.305Z| vmx| I120: DICT config.version = 8
2013-12-23T11:45:45.305Z| vmx| I120: DICT virtualHW.version = 9
2013-12-23T11:45:45.305Z| vmx| I120: DICT nvram = Server1.nvram
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT svga.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge4.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge4.virtualDev = pcieRootPort
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge4.functions = 8
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge5.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge5.virtualDev = pcieRootPort
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge5.functions = 8
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge6.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge6.virtualDev = pcieRootPort
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge6.functions = 8
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge7.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge7.virtualDev = pcieRootPort
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge7.functions = 8
2013-12-23T11:45:45.305Z| vmx| I120: DICT vmci0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT hpet0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT displayName = Server1
2013-12-23T11:45:45.305Z| vmx| I120: DICT extendedConfigFile = Server1.vmxf
2013-12-23T11:45:45.305Z| vmx| I120: DICT virtualHW.productCompatibility = hosted
2013-12-23T11:45:45.305Z| vmx| I120: DICT floppy0.present = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT numvcpus = 4
2013-12-23T11:45:45.305Z| vmx| I120: DICT cpuid.coresPerSocket = 4
2013-12-23T11:45:45.305Z| vmx| I120: DICT memSize = 4096
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.cpu.affinity = all
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.mem.affinity = all
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT ehci.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0.virtualDev = lsilogic
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.networkName = VM Network
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.addressType = generated
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT ide0:0.deviceType = atapi-cdrom
2013-12-23T11:45:45.305Z| vmx| I120: DICT ide0:0.fileName = /vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0
2013-12-23T11:45:45.305Z| vmx| I120: DICT ide0:0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0:0.deviceType = scsi-hardDisk
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0:0.fileName = Server1.vmdk
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0:0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT guestOS = winnetstandard
2013-12-23T11:45:45.305Z| vmx| I120: DICT uuid.bios = 56 4d 51 2c da ac 08 3b-4c 1a db 90 2f 30 0e 0d
2013-12-23T11:45:45.305Z| vmx| I120: DICT uuid.location = 56 4d 51 2c da ac 08 3b-4c 1a db 90 2f 30 0e 0d
2013-12-23T11:45:45.305Z| vmx| I120: DICT vc.uuid = 52 50 c5 11 52 9b f9 ae-af 36 b8 4c f4 8b 6f 00
2013-12-23T11:45:45.305Z| vmx| I120: DICT sched.swap.derivedName = /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vswp
2013-12-23T11:45:45.305Z| vmx| I120: DICT replay.supported = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT replay.filename =
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0:0.redo =
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge0.pciSlotNumber = 17
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge4.pciSlotNumber = 21
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge5.pciSlotNumber = 22
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge6.pciSlotNumber = 23
2013-12-23T11:45:45.305Z| vmx| I120: DICT pciBridge7.pciSlotNumber = 24
2013-12-23T11:45:45.305Z| vmx| I120: DICT scsi0.pciSlotNumber = 16
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb.pciSlotNumber = 32
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.pciSlotNumber = 33
2013-12-23T11:45:45.305Z| vmx| I120: DICT ehci.pciSlotNumber = 34
2013-12-23T11:45:45.305Z| vmx| I120: DICT vmci0.pciSlotNumber = 35
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.generatedAddress = 00:0c:29:30:0e:0d
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet0.generatedAddressOffset = 0
2013-12-23T11:45:45.305Z| vmx| I120: DICT vmci0.id = 791678477
2013-12-23T11:45:45.305Z| vmx| I120: DICT vmotion.checkpointFBSize = 4194304
2013-12-23T11:45:45.305Z| vmx| I120: DICT cleanShutdown = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT softPowerOff = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:1.speed = 2
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:1.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:1.deviceType = hub
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:1.port = 1
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:1.parent = -1
2013-12-23T11:45:45.305Z| vmx| I120: DICT toolsInstallManager.lastInstallError = 0
2013-12-23T11:45:45.305Z| vmx| I120: DICT tools.syncTime = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT unity.wasCapable = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT tools.remindInstall = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT toolsInstallManager.updateCounter = 1
2013-12-23T11:45:45.305Z| vmx| I120: DICT ide0:0.allowGuestConnectionControl = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb.autoConnect.device0 = path:2/0/5 autoclean:1
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb.autoConnect.device1 = path:2/0/4 autoclean:1
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb.autoConnect.device2 =
2013-12-23T11:45:45.305Z| vmx| I120: DICT checkpoint.vmState = Server1-84d336b7.vmss
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.pciSlotNumber = 160
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.virtualDev = vmxnet3
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.networkName = VM Network
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.addressType = generated
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT migrate.hostlog = ./Server1-84d336b7.hlog
2013-12-23T11:45:45.305Z| vmx| I120: DICT config.readOnly = FALSE
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.generatedAddress = 00:0c:29:30:0e:17
2013-12-23T11:45:45.305Z| vmx| I120: DICT ethernet1.generatedAddressOffset = 10
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:0.present = TRUE
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:0.deviceType = hid
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:0.port = 0
2013-12-23T11:45:45.305Z| vmx| I120: DICT usb:0.parent = -1
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- USER DEFAULTS ~/.vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- HOST DEFAULTS /etc/vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT libdir = /usr/lib/vmware
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.nfc = vmware-hostd:ha-nfc
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.nfcssl = vmware-hostd:ha-nfcssl
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.vpxa-nfcssl = vmware-vpxa:vpxa-nfcssl
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.proxy.vpxa-nfc = vmware-vpxa:vpxa-nfc
2013-12-23T11:45:45.305Z| vmx| I120: DICT authd.fullpath = /sbin/authd
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- SITE DEFAULTS /usr/lib/vmware/config
2013-12-23T11:45:45.305Z| vmx| I120: DICT --- GLOBAL SETTINGS /usr/lib/vmware/settings
2013-12-23T11:45:45.347Z| vmx| I120: DUMPER: Restoring checkpoint version 8.
2013-12-23T11:45:45.366Z| vmx| I120: Checkpointed in VMware ESX, 5.5.0, build-1331820, Linux Host
2013-12-23T11:45:45.366Z| vmx| I120: Resuming virtual machine from /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vmss with 4096 MB of memory.
2013-12-23T11:45:45.366Z| vmx| I120: Vix: [4505616 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0
2013-12-23T11:45:45.371Z| vmx| I120: Basic VMX Information (0x00da040000000010)
2013-12-23T11:45:45.371Z| vmx| I120: VMCS revision ID 16
2013-12-23T11:45:45.371Z| vmx| I120: VMCS region length 1024
2013-12-23T11:45:45.371Z| vmx| I120: VMX physical-address width natural
2013-12-23T11:45:45.371Z| vmx| I120: SMM dual-monitor mode yes
2013-12-23T11:45:45.371Z| vmx| I120: Advanced INS/OUTS info yes
2013-12-23T11:45:45.371Z| vmx| I120: True VMX MSRs yes
2013-12-23T11:45:45.371Z| vmx| I120: VMCS memory type WB
2013-12-23T11:45:45.371Z| vmx| I120: True Pin-Based VM-Execution Controls (0x0000007f00000016)
2013-12-23T11:45:45.371Z| vmx| I120: External-interrupt exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: NMI exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Virtual NMIs {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Activate VMX-preemption timer {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Process posted interrupts { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: True Primary Processor-Based VM-Execution Controls (0xfff9fffe04006172)
2013-12-23T11:45:45.371Z| vmx| I120: Interrupt-window exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Use TSC offsetting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: HLT exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: INVLPG exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: MWAIT exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: RDPMC exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: RDTSC exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: CR3-load exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: CR3-store exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: CR8-load exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: CR8-store exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Use TPR shadow {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: NMI-window exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: MOV-DR exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Unconditional I/O exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Use I/O bitmaps {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Monitor trap flag {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Use MSR bitmaps {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: MONITOR exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: PAUSE exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Activate secondary controls {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Secondary Processor-Based VM-Execution Controls (0x000008ff00000000)
2013-12-23T11:45:45.371Z| vmx| I120: Virtualize APIC accesses {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Enable EPT {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Descriptor-table exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Enable RDTSCP {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Virtualize x2APIC mode {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Enable VPID {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: WBINVD exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Unrestricted guest {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: APIC-register virtualization { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: Virtual-interrupt delivery { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: PAUSE-loop exiting { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: RDRAND exiting {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Enable INVPCID { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: Enable VM Functions { 0 }
2013-12-23T11:45:45.371Z| vmx| I120: True VM-Exit Controls (0x007fffff00036dfb)
2013-12-23T11:45:45.371Z| vmx| I120: Save debug controls {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Host address-space size {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_PERF_GLOBAL_CTRL {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Acknowledge interrupt on exit {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Save IA32_PAT {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_PAT {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Save IA32_EFER {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_EFER {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Save VMX-preemption timer {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: True VM-Entry Controls (0x0000ffff000011fb)
2013-12-23T11:45:45.371Z| vmx| I120: Load debug controls {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: IA-32e mode guest {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Entry to SMM {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Deactivate dual-monitor mode {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_PERF_GLOBAL_CTRL {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_PAT {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: Load IA32_EFER {0,1}
2013-12-23T11:45:45.371Z| vmx| I120: VPID and EPT Capabilities (0x00000f0106114141)
2013-12-23T11:45:45.371Z| vmx| I120: R=0/W=0/X=1 yes
2013-12-23T11:45:45.371Z| vmx| I120: Page-walk length 3 yes
2013-12-23T11:45:45.371Z| vmx| I120: EPT memory type WB yes
2013-12-23T11:45:45.371Z| vmx| I120: 2MB super-page yes
2013-12-23T11:45:45.371Z| vmx| I120: INVEPT support yes
2013-12-23T11:45:45.371Z| vmx| I120: Access & Dirty Bits no
2013-12-23T11:45:45.371Z| vmx| I120: Type 1 INVEPT yes
2013-12-23T11:45:45.371Z| vmx| I120: Type 2 INVEPT yes
2013-12-23T11:45:45.371Z| vmx| I120: INVVPID support yes
2013-12-23T11:45:45.371Z| vmx| I120: Type 0 INVVPID yes
2013-12-23T11:45:45.371Z| vmx| I120: Type 1 INVVPID yes
2013-12-23T11:45:45.371Z| vmx| I120: Type 2 INVVPID yes
2013-12-23T11:45:45.371Z| vmx| I120: Type 3 INVVPID yes
2013-12-23T11:45:45.371Z| vmx| I120: Miscellaneous VMX Data (0x00000000100401e5)
2013-12-23T11:45:45.371Z| vmx| I120: TSC to preemption timer ratio 5
2013-12-23T11:45:45.371Z| vmx| I120: VM-Exit saves EFER.LMA yes
2013-12-23T11:45:45.371Z| vmx| I120: Activity State HLT yes
2013-12-23T11:45:45.371Z| vmx| I120: Activity State shutdown yes
2013-12-23T11:45:45.371Z| vmx| I120: Activity State wait-for-SIPI yes
2013-12-23T11:45:45.371Z| vmx| I120: CR3 targets supported 4
2013-12-23T11:45:45.371Z| vmx| I120: Maximum MSR list size 512
2013-12-23T11:45:45.371Z| vmx| I120: Allow all VMWRITEs no
2013-12-23T11:45:45.371Z| vmx| I120: MSEG revision ID 0
2013-12-23T11:45:45.371Z| vmx| I120: VMX-Fixed Bits in CR0 (0x0000000080000021/0x00000000ffffffff)
2013-12-23T11:45:45.371Z| vmx| I120: Fixed to 0 0xffffffff00000000
2013-12-23T11:45:45.371Z| vmx| I120: Fixed to 1 0x0000000080000021
2013-12-23T11:45:45.371Z| vmx| I120: Variable 0x000000007fffffde
2013-12-23T11:45:45.371Z| vmx| I120: VMX-Fixed Bits in CR4 (0x0000000000002000/0x00000000001767ff)
2013-12-23T11:45:45.371Z| vmx| I120: Fixed to 0 0xffffffffffe89800
2013-12-23T11:45:45.371Z| vmx| I120: Fixed to 1 0x0000000000002000
2013-12-23T11:45:45.371Z| vmx| I120: Variable 0x00000000001747ff
2013-12-23T11:45:45.371Z| vmx| I120: VMCS Enumeration (0x000000000000002a)
2013-12-23T11:45:45.371Z| vmx| I120: Highest index 0x15
2013-12-23T11:45:45.371Z| vmx| I120: VM Functions (0x0000000000000000)
2013-12-23T11:45:45.371Z| vmx| I120: hostCpuFeatures = 0xc4002fd
2013-12-23T11:45:45.371Z| vmx| I120: hostNumGenPerfCounters = 8
2013-12-23T11:45:45.371Z| vmx| I120: hostNumFixedPerfCounters = 3
2013-12-23T11:45:45.371Z| vmx| I120: hostPerfCtrArch = 3
2013-12-23T11:45:45.371Z| vmx| I120: CPU0: PMC: IA32, Nehalem-C or later PMC: Patch Level 0x19, smmFrz (hw): (1)
2013-12-23T11:45:45.371Z| vmx| I120: [c:0 f:1 e:0]
2013-12-23T11:45:45.371Z| vmx| I120: CPU1: PMC: IA32, Nehalem-C or later PMC: Patch Level 0x19, smmFrz (hw): (1)
2013-12-23T11:45:45.371Z| vmx| I120: [c:0 f:1 e:0]
2013-12-23T11:45:45.371Z| vmx| I120: CPU2: PMC: IA32, Nehalem-C or later PMC: Patch Level 0x19, smmFrz (hw): (1)
2013-12-23T11:45:45.371Z| vmx| I120: [c:0 f:1 e:0]
2013-12-23T11:45:45.371Z| vmx| I120: CPU3: PMC: IA32, Nehalem-C or later PMC: Patch Level 0x19, smmFrz (hw): (1)
2013-12-23T11:45:45.371Z| vmx| I120: [c:0 f:1 e:0]
2013-12-23T11:45:45.372Z| vmx| I120: MONITOR MODE: allowed modes : BT32 HV HWMMU
2013-12-23T11:45:45.372Z| vmx| I120: MONITOR MODE: user requested modes : BT32 HV HWMMU
2013-12-23T11:45:45.372Z| vmx| I120: MONITOR MODE: guestOS preferred modes: HWMMU HV BT32
2013-12-23T11:45:45.372Z| vmx| I120: MONITOR MODE: filtered list : HWMMU HV BT32
2013-12-23T11:45:45.372Z| vmx| I120: HV Settings: virtual exec = 'hardware'; virtual mmu = 'hardware'
2013-12-23T11:45:45.380Z| vmx| I120: OvhdMem_PowerOn: lib/overheadmem: paged 84191 nonpaged 13488 anonymous 39579
2013-12-23T11:45:45.380Z| vmx| I120: OvhdMem_PowerOn: initial admission: paged 28666 nonpaged 4015 anonymous 12086
2013-12-23T11:45:45.380Z| vmx| I120: VMMEM: Initial Reservation: 174MB (MainMem=4096MB)
2013-12-23T11:45:45.380Z| vmx| I120: MemSched_PowerOn: balloon minGuestSize 26214 (80% of min required size 32768)
2013-12-23T11:45:45.380Z| vmx| I120: MemSched: properties ovhd: 0 mainmem: 0 pinned: 0 fpt: 0 ls: 0 prealloc: 0
2013-12-23T11:45:45.381Z| vmx| I120: numa: VCPU 0: VPD 0 (PPD 0)
2013-12-23T11:45:45.381Z| vmx| I120: numa: VCPU 1: VPD 0 (PPD 0)
2013-12-23T11:45:45.381Z| vmx| I120: numa: VCPU 2: VPD 0 (PPD 0)
2013-12-23T11:45:45.381Z| vmx| I120: numa: VCPU 3: VPD 0 (PPD 0)
2013-12-23T11:45:45.381Z| vmx| I120: numaHost: 1 virtual nodes, 1 virtual sockets, 1 physical domains
2013-12-23T11:45:45.381Z| vmx| I120: CreateVM: Swap: generating normal swap file name.
2013-12-23T11:45:45.381Z| vmx| I120: Swap file path: '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vswp'
2013-12-23T11:45:45.381Z| vmx| I120: VMXVmdb_GetDigestDiskCount: numDigestDisks = 0
2013-12-23T11:45:45.569Z| vmx| I120: Monitor64_PowerOn()
2013-12-23T11:45:45.569Z| vmx| I120: vmm64-modules: [vmm.vmm64, mmu-hwmmu.vmm64, vprobe-none.vmm64, hv-vt.vmm64, gphys-ept.vmm64, vmsafe-none.vmm64, callstack-none.vmm64, vmce-none.vmm64, vvtd-none.vmm64, vmxnet3-vmxnet3.vmm64, videio-none.vmm64, {SharedAreaReservations} .shared_per_vm_vmx:0x700, {SharedInterVcpuVmxSection}, {SharedInterVcpuSection}, <MonSrcFile>, hvLoadedAsAddr=0x1, useNPTAsAddr=0x1, vcpusetFullAsAddr=0xf, numVCPUsAsAddr=0x4, busmemFrameMPNOffsetAsAddr=0xc, busmemFramesPerPgDivSh2AsAddr=0x8, busmemFramesPerPgDivSh1AsAddr=0x1, busmemFramesPerPgDivMulAsAddr=0x100000000, busmemFramesPerPageAsAddr=0x200, busmemFrameSizeAsAddr=0x8]
2013-12-23T11:45:45.569Z| vmx| I120: vmm64-vcpus: 4
2013-12-23T11:45:45.574Z| vmx| I120: KHZEstimate 3092974
2013-12-23T11:45:45.574Z| vmx| I120: MHZEstimate 3093
2013-12-23T11:45:45.574Z| vmx| I120: NumVCPUs 4
2013-12-23T11:45:45.574Z| vmx| I120: Guest OS (20490) not supported for replay debugging.
2013-12-23T11:45:45.574Z| vmx| I120: UUID: location-UUID is 56 4d 51 2c da ac 08 3b-4c 1a db 90 2f 30 0e 0d
2013-12-23T11:45:45.574Z| vthread-7| I120: VTHREAD start thread 7 "vthread-7" pid 4505624
2013-12-23T11:45:45.575Z| vmx| I120: AIOGNRC: numThreads=2 ide=0, scsi=0, passthru=1
2013-12-23T11:45:45.575Z| vmx| I120: WORKER: Creating new group with numThreads=2 (2)
2013-12-23T11:45:45.575Z| vmx| I120: StateLogger::Replay State = 0
2013-12-23T11:45:45.575Z| vmx| I120: StateLogger::minDEThreshold: 115
2013-12-23T11:45:45.576Z| vmx| I120: WORKER: Creating new group with numThreads=1 (3)
2013-12-23T11:45:45.576Z| vmx| I120: MainMem: CPT PLS=1 PLR=0 BS=0 BufM=0 BlkP=64 Mult=2 W=25
2013-12-23T11:45:45.577Z| vmx| I120: MStat: Creating Stat vm.uptime
2013-12-23T11:45:45.577Z| vmx| I120: MStat: Creating Stat vm.suspendTime
2013-12-23T11:45:45.577Z| vmx| I120: MStat: Creating Stat vm.powerOnTimeStamp
2013-12-23T11:45:45.577Z| vmx| I120: VMXAIOMGR: Using: simple=Generic unbuf=Generic
2013-12-23T11:45:45.577Z| vmx| I120: WORKER: Creating new group with numThreads=1 (4)
2013-12-23T11:45:45.578Z| vmx| I120: FTCpt: (0 unk) State transition 0 -> 1
2013-12-23T11:45:45.579Z| vmx| I120: WORKER: Creating new group with numThreads=1 (4)
2013-12-23T11:45:45.579Z| vmx| I120: VMXVmdb_SetMigrationHostLogState: hostlog state transits to success for migrate 'to' mid 1378784616
2013-12-23T11:45:45.587Z| vmx| I120: WORKER: Creating new group with numThreads=16 (4)
2013-12-23T11:45:45.587Z| Worker#0| I120: DISK: OPEN scsi0:0 '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk' persistent R[]
2013-12-23T11:45:45.587Z| Worker#0| I120: DISKLIB-VMFS : "/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-flat.vmdk" : open successful (10) size = 419727147008, hd = 71794973. Type 3
2013-12-23T11:45:45.587Z| Worker#0| I120: DISKLIB-DSCPTR: Opened [0]: "Server1-flat.vmdk" (0xa)
2013-12-23T11:45:45.588Z| Worker#0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk' (0xa): vmfs, 819779584 sectors / 390.9 GB.
2013-12-23T11:45:45.588Z| Worker#0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk" (flags 0xa, type vmfs).
2013-12-23T11:45:45.588Z| Worker#0| I120: DISK: Disk '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk' has UUID '60 00 c2 92 72 ee 16 8c-01 7a 6f 8b 90 01 74 37'
2013-12-23T11:45:45.588Z| Worker#0| I120: DISK: OPEN '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk' Geo (51028/255/63) BIOS Geo (51028/255/63)
2013-12-23T11:45:45.588Z| vmx| I120: DISK: Opening disks took 1 ms.
2013-12-23T11:45:45.589Z| vmx| I120: TimeTracker host to guest rate conversion 4521770816931658 @ 3092974000Hz -> 0 @ 3092974000Hz
2013-12-23T11:45:45.589Z| vmx| I120: TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + -4521770816931658
2013-12-23T11:45:45.589Z| vmx| I120: timeTracker.globalProgressMaxAllowanceMS: 2000
2013-12-23T11:45:45.589Z| vmx| I120: timeTracker.globalProgressToAllowanceNS: 1000
2013-12-23T11:45:45.589Z| vmx| I120: USB: Search for USB devices to connect [path:2/0/5 autoclean:1 virtPath:usb.autoConnect.device0 version:2]
2013-12-23T11:45:45.589Z| vmx| I120: USB: Search for USB devices to connect [path:2/0/4 autoclean:1 virtPath:usb.autoConnect.device1 version:2]
2013-12-23T11:45:45.590Z| vmx| I120: SOCKET creating new socket, connecting to /var/run/vmware/usbarbitrator-socket
2013-12-23T11:45:45.590Z| vmx| I120: USB: Initializing 'Virtual Hub' backend
2013-12-23T11:45:45.590Z| vmx| I120: USB: Initializing 'Generic' backend
2013-12-23T11:45:45.590Z| vmx| W110: USBGL: Connected to arbitrator socket: 96
2013-12-23T11:45:45.590Z| vmx| I120: USB: Initializing 'Virtual HID' backend
2013-12-23T11:45:45.590Z| vmx| I120: USB: Initializing 'Remote Device' backend
2013-12-23T11:45:45.590Z| vmx| I120: RemoteUSBVMX: Retrieved hostId [31 36 38 36 31 34 5a 43-31 33 33 39 30 31 31 55]
2013-12-23T11:45:45.590Z| vmx| I120: RemoteUSBVMX: Protocol version min:15 current:16
2013-12-23T11:45:45.590Z| vmx| I120: RemoteUSBVMX: no delay setting is TRUE.
2013-12-23T11:45:45.590Z| vmx| I120: USB: Initializing 'Virtual Mass Storage' backend
2013-12-23T11:45:45.592Z| vmx| I120: MKS PowerOn
2013-12-23T11:45:45.592Z| mks| I120: VTHREAD start thread 1 "mks" pid 4505625
2013-12-23T11:45:45.592Z| mks| I120: MKS thread is alive
2013-12-23T11:45:45.593Z| mks| I120: MKS-RenderMux: Collecting RenderOps caps...
2013-12-23T11:45:45.593Z| mks| I120: KHBKL: Unable to parse keystring at: ''
2013-12-23T11:45:45.593Z| mks| I120: MKS-RemoteMgr: Set default display name: Server1
2013-12-23T11:45:45.593Z| mks| I120: MKS-RemoteMgr: Loading VNC Configuration from VM config file
2013-12-23T11:45:45.594Z| vmx| I120: VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks
2013-12-23T11:45:45.594Z| vmx| I120: Chipset version: 0x13
2013-12-23T11:45:45.599Z| vmx| I120: SCSI DEVICE (ide0:0): Computed value of ide0:0.useBounceBuffers: default
2013-12-23T11:45:45.599Z| vmx| I120: DISKUTIL: ide0:0 : capacity=0
2013-12-23T11:45:45.599Z| vmx| I120: DISKUTIL: ide0:0 : geometry=0/0/0
2013-12-23T11:45:45.599Z| vmx| I120: SCSI: scsi0: intr coalescing: on period=50msec cifTh=4 iopsTh=2000 hlt=0
2013-12-23T11:45:45.599Z| vmx| I120: SCSI0: UNTAGGED commands will be converted to ORDER tags.
2013-12-23T11:45:45.599Z| vmx| I120: SCSI DEVICE (scsi0:0): Computed value of scsi0:0.useBounceBuffers: default
2013-12-23T11:45:45.599Z| vmx| I120: Creating virtual dev for scsi0:0
2013-12-23T11:45:45.599Z| vmx| I120: DumpDiskInfo: scsi0:0 createType=11, capacity = 819779584, numLinks = 1, allocationType = 1
2013-12-23T11:45:45.599Z| vmx| I120: StateLogger::VM has zeroedthick disk scsi0:0; FT enable will be disallowedSCSIDiskESXPopulateVDevDesc: Using FS backend
2013-12-23T11:45:45.599Z| vmx| I120: DISKUTIL: scsi0:0 : geometry=51028/255/63
2013-12-23T11:45:45.599Z| vmx| I120: SVGA: Device capabilities 0x01ff83e2
2013-12-23T11:45:45.599Z| vmx| I120: SVGA: Number of displays 1
2013-12-23T11:45:45.599Z| vmx| I120: SVGA: Maximum display topology 2560x1600.
2013-12-23T11:45:45.599Z| vmx| I120: SVGA: Truncated maximum resolution to VRAM size: 4194304 bytes VRAM, 1176x885 Max Resolution
2013-12-23T11:45:45.599Z| vmx| I120: SVGA: FIFO capabilities 0x0000077f
2013-12-23T11:45:45.599Z| vmx| I120: MKS3dCaps: host, at power on: 3d disabled
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 0]: 0x00000000 (3D)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 1]: 0x00000000 (MAX_LIGHTS)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 2]: 0x00000000 (MAX_TEXTURES)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 3]: 0x00000000 (MAX_CLIP_PLANES)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 4]: 0x00000000 (VERTEX_SHADER_VERSION)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 5]: 0x00000000 (VERTEX_SHADER)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 6]: 0x00000000 (FRAGMENT_SHADER_VERSION)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 7]: 0x00000000 (FRAGMENT_SHADER)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 8]: 0x00000000 (MAX_RENDER_TARGETS)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 9]: 0x00000000 (S23E8_TEXTURES)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 10]: 0x00000000 (S10E5_TEXTURES)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 11]: 0x00000000 (MAX_FIXED_VERTEXBLEND)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 12]: 0x00000000 (D16_BUFFER_FORMAT)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 13]: 0x00000000 (D24S8_BUFFER_FORMAT)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 14]: 0x00000000 (D24X8_BUFFER_FORMAT)
2013-12-23T11:45:45.599Z| vmx| I120: cap[ 15]: 0x00000000 (QUERY_TYPES)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 16]: 0x00000000 (TEXTURE_GRADIENT_SAMPLING)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 17]: 0.000000 (MAX_POINT_SIZE)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 18]: 0x00000000 (MAX_SHADER_TEXTURES)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 19]: 0x00000000 (MAX_TEXTURE_WIDTH)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 20]: 0x00000000 (MAX_TEXTURE_HEIGHT)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 21]: 0x00000000 (MAX_VOLUME_EXTENT)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 22]: 0x00000000 (MAX_TEXTURE_REPEAT)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 23]: 0x00000000 (MAX_TEXTURE_ASPECT_RATIO)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 24]: 0x00000000 (MAX_TEXTURE_ANISOTROPY)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 25]: 0x00000000 (MAX_PRIMITIVE_COUNT)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 26]: 0x00000000 (MAX_VERTEX_INDEX)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 27]: 0x00000000 (MAX_VERTEX_SHADER_INSTRUCTIONS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 28]: 0x00000000 (MAX_FRAGMENT_SHADER_INSTRUCTIONS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 29]: 0x00000000 (MAX_VERTEX_SHADER_TEMPS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 30]: 0x00000000 (MAX_FRAGMENT_SHADER_TEMPS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 31]: 0x00000000 (TEXTURE_OPS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 32]: 0x00000000 (SURFACEFMT_X8R8G8B8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 33]: 0x00000000 (SURFACEFMT_A8R8G8B8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 34]: 0x00000000 (SURFACEFMT_A2R10G10B10)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 35]: 0x00000000 (SURFACEFMT_X1R5G5B5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 36]: 0x00000000 (SURFACEFMT_A1R5G5B5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 37]: 0x00000000 (SURFACEFMT_A4R4G4B4)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 38]: 0x00000000 (SURFACEFMT_R5G6B5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 39]: 0x00000000 (SURFACEFMT_LUMINANCE16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 40]: 0x00000000 (SURFACEFMT_LUMINANCE8_ALPHA8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 41]: 0x00000000 (SURFACEFMT_ALPHA8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 42]: 0x00000000 (SURFACEFMT_LUMINANCE8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 43]: 0x00000000 (SURFACEFMT_Z_D16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 44]: 0x00000000 (SURFACEFMT_Z_D24S8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 45]: 0x00000000 (SURFACEFMT_Z_D24X8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 46]: 0x00000000 (SURFACEFMT_DXT1)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 47]: 0x00000000 (SURFACEFMT_DXT2)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 48]: 0x00000000 (SURFACEFMT_DXT3)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 49]: 0x00000000 (SURFACEFMT_DXT4)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 50]: 0x00000000 (SURFACEFMT_DXT5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 51]: 0x00000000 (SURFACEFMT_BUMPX8L8V8U8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 52]: 0x00000000 (SURFACEFMT_A2W10V10U10)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 53]: 0x00000000 (SURFACEFMT_BUMPU8V8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 54]: 0x00000000 (SURFACEFMT_Q8W8V8U8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 55]: 0x00000000 (SURFACEFMT_CxV8U8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 56]: 0x00000000 (SURFACEFMT_R_S10E5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 57]: 0x00000000 (SURFACEFMT_R_S23E8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 58]: 0x00000000 (SURFACEFMT_RG_S10E5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 59]: 0x00000000 (SURFACEFMT_RG_S23E8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 60]: 0x00000000 (SURFACEFMT_ARGB_S10E5)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 61]: 0x00000000 (SURFACEFMT_ARGB_S23E8)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 62]: 0x00000000 (MISSING62)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 63]: 0x00000000 (MAX_VERTEX_SHADER_TEXTURES)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 64]: 0x00000000 (MAX_SIMULTANEOUS_RENDER_TARGETS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 65]: 0x00000000 (SURFACEFMT_V16U16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 66]: 0x00000000 (SURFACEFMT_G16R16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 67]: 0x00000000 (SURFACEFMT_A16B16G16R16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 68]: 0x00000000 (SURFACEFMT_UYVY)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 69]: 0x00000000 (SURFACEFMT_YUY2)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 70]: 0x00000000 (MULTISAMPLE_NONMASKABLESAMPLES)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 71]: 0x00000000 (MULTISAMPLE_MASKABLESAMPLES)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 72]: 0x00000000 (ALPHATOCOVERAGE)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 73]: 0x00000000 (SUPERSAMPLE)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 74]: 0x00000000 (AUTOGENMIPMAPS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 75]: 0x00000000 (SURFACEFMT_NV12)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 76]: 0x00000000 (SURFACEFMT_AYUV)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 77]: 0x00000000 (MAX_CONTEXT_IDS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 78]: 0x00000000 (MAX_SURFACE_IDS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 79]: 0x00000000 (SURFACEFMT_Z_DF16)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 80]: 0x00000000 (SURFACEFMT_Z_DF24)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 81]: 0x00000000 (SURFACEFMT_Z_D24S8_INT)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 82]: 0x00000000 (SURFACEFMT_BC4_UNORM)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 83]: 0x00000000 (SURFACEFMT_BC5_UNORM)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 84]: 0x00000000 (VGPU10)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 85]: 0x00000000 (VIDEO_DECODE)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 86]: 0x00000000 (VIDEO_PROCESS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 87]: 0x00000000 (LINE_AA)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 88]: 0x00000000 (LINE_STIPPLE)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 89]: 0.000000 (MAX_LINE_WIDTH)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 90]: 0.000000 (MAX_AA_LINE_WIDTH)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 91]: 0x00000000 (SURFACEFMT_YV12)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 92]: 0x00000000 (LOGICOPS)
2013-12-23T11:45:45.600Z| vmx| I120: cap[ 93]: 0x00000000 (SCREENTARGETS)
2013-12-23T11:45:45.600Z| svga| I120: VTHREAD start thread 8 "svga" pid 4505626
2013-12-23T11:45:45.601Z| svga| I120: SVGA thread is alive
2013-12-23T11:45:45.601Z| vmx| I120: USB: Initializing 'UHCI' host controller
2013-12-23T11:45:45.609Z| vmx| I120: Ethernet0 MAC Address: 00:0c:29:30:0e:0d
2013-12-23T11:45:45.609Z| vmx| I120: Vmxnet_InitChip: ioHandle=0xb
2013-12-23T11:45:45.610Z| vmx| I120: Ethernet1 MAC Address: 00:0c:29:30:0e:17
2013-12-23T11:45:45.611Z| vmx| I120: Ethernet1 MAC Address: 00:0c:29:30:0e:17
2013-12-23T11:45:45.611Z| vmx| I120: USB: Initializing 'EHCI' host controller
2013-12-23T11:45:45.621Z| vmx| I120: GuestLib Generated SessionId 16654157683455313854
2013-12-23T11:45:45.621Z| vmx| I120: WORKER: Creating new group with numThreads=1 (4)
2013-12-23T11:45:45.621Z| vmx| I120: DISKUTIL: scsi0:0 : max toolsVersion = 9344
2013-12-23T11:45:45.621Z| vmx| I120: TOOLS setting legacy tools version to '9344', manifest status is 9
2013-12-23T11:45:45.622Z| vmx| I120: Tools: sending 'OS_Resume' (state = 4) state change request
2013-12-23T11:45:45.622Z| vmx| I120: Tools: Delaying state change request to state 4.
2013-12-23T11:45:45.622Z| vmx| I120: TOOLS INSTALL initializing state to IDLE on power on.
2013-12-23T11:45:45.622Z| Worker#0| I120: GetHostManifests: Extracting the manifest file.
2013-12-23T11:45:45.628Z| vmx| I120: FeatureCompat: VM masks:
2013-12-23T11:45:45.628Z| vmx| I120: MonPmc: ctrBase 0x4c1 selBase 0x186/1 PGC 1/1 SMM 1 drain 1 flush 0
2013-12-23T11:45:45.628Z| vmx| I120+ MonPmc: gen counters num: 8 width 48 write width 48
2013-12-23T11:45:45.628Z| vmx| I120+ MonPmc: fix counters num: 3 width 48
2013-12-23T11:45:45.628Z| vmx| I120+ MonPmc: unavailable counters: 0x600000000
2013-12-23T11:45:45.628Z| vmx| I120: CPT: Restoring checkpoint /vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vmss
2013-12-23T11:45:45.629Z| vmx| I120: DUMPER: Restoring checkpoint version 8.
2013-12-23T11:45:45.676Z| vmx| I120: guestCpuFeatures = 0x2fd
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'csRights' [0, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'paraGuest' [0, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'csRights' [1, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'paraGuest' [1, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'csRights' [2, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: DUMPER: Item 'paraGuest' [2, -1] not found.
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: found group Ethernet0
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no dumper group ethernet0
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: found group Ethernet1
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no dumper group ethernet1
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet2
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet3
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet4
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet5
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet6
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet7
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet8
2013-12-23T11:45:45.679Z| vmx| I120: Checkpoint: no group Ethernet9
2013-12-23T11:45:45.679Z| vmx| I120: Progress -1% (msg.checkpoint.restoreStatus)
2013-12-23T11:45:45.679Z| vmx| I120: restoring GuestVars
2013-12-23T11:45:45.679Z| vmx| I120: restoring BusMemSample
2013-12-23T11:45:45.679Z| vmx| I120: restoring UUIDVMX
2013-12-23T11:45:45.679Z| vmx| I120: restoring StateLogger
2013-12-23T11:45:45.679Z| vmx| I120: restoring memory
2013-12-23T11:45:45.679Z| vmx| I120: Progress 0% (none)
2013-12-23T11:45:45.680Z| vmx| I120: Progress 1% (none)
2013-12-23T11:45:45.681Z| vmx| I120: Progress 2% (none)
2013-12-23T11:45:45.682Z| vmx| I120: Progress 3% (none)
2013-12-23T11:45:45.683Z| vmx| I120: Progress 4% (none)
2013-12-23T11:45:45.684Z| vmx| I120: Progress 5% (none)
2013-12-23T11:45:45.685Z| vmx| I120: Progress 6% (none)
2013-12-23T11:45:45.686Z| vmx| I120: Progress 7% (none)
2013-12-23T11:45:45.687Z| vmx| I120: Progress 8% (none)
2013-12-23T11:45:45.688Z| vmx| I120: Progress 9% (none)
2013-12-23T11:45:45.689Z| vmx| I120: Progress 10% (none)
2013-12-23T11:45:45.690Z| vmx| I120: Progress 11% (none)
2013-12-23T11:45:45.691Z| vmx| I120: Progress 12% (none)
2013-12-23T11:45:45.692Z| vmx| I120: Progress 13% (none)
2013-12-23T11:45:45.693Z| vmx| I120: Progress 14% (none)
2013-12-23T11:45:45.694Z| vmx| I120: Progress 15% (none)
2013-12-23T11:45:45.695Z| vmx| I120: Progress 16% (none)
2013-12-23T11:45:45.696Z| vmx| I120: Progress 17% (none)
2013-12-23T11:45:45.697Z| vmx| I120: Progress 18% (none)
2013-12-23T11:45:45.698Z| vmx| I120: Progress 19% (none)
2013-12-23T11:45:45.699Z| vmx| I120: Progress 20% (none)
2013-12-23T11:45:45.700Z| vmx| I120: Progress 21% (none)
2013-12-23T11:45:45.701Z| vmx| I120: Progress 22% (none)
2013-12-23T11:45:45.702Z| vmx| I120: Progress 23% (none)
2013-12-23T11:45:45.703Z| vmx| I120: Progress 24% (none)
2013-12-23T11:45:45.704Z| vmx| I120: Progress 25% (none)
2013-12-23T11:45:45.705Z| vmx| I120: Progress 26% (none)
2013-12-23T11:45:45.706Z| vmx| I120: Progress 27% (none)
2013-12-23T11:45:45.707Z| vmx| I120: Progress 28% (none)
2013-12-23T11:45:45.708Z| vmx| I120: Progress 29% (none)
2013-12-23T11:45:45.709Z| vmx| I120: Progress 30% (none)
2013-12-23T11:45:45.710Z| vmx| I120: Progress 31% (none)
2013-12-23T11:45:45.711Z| vmx| I120: Progress 32% (none)
2013-12-23T11:45:45.712Z| vmx| I120: Progress 33% (none)
2013-12-23T11:45:45.713Z| vmx| I120: Progress 34% (none)
2013-12-23T11:45:45.714Z| vmx| I120: Progress 35% (none)
2013-12-23T11:45:45.715Z| vmx| I120: Progress 36% (none)
2013-12-23T11:45:45.716Z| vmx| I120: Progress 37% (none)
2013-12-23T11:45:45.717Z| vmx| I120: Progress 38% (none)
2013-12-23T11:45:45.718Z| vmx| I120: Progress 39% (none)
2013-12-23T11:45:45.719Z| vmx| I120: Progress 40% (none)
2013-12-23T11:45:45.720Z| vmx| I120: Progress 41% (none)
2013-12-23T11:45:45.721Z| vmx| I120: Progress 42% (none)
2013-12-23T11:45:45.722Z| vmx| I120: Progress 43% (none)
2013-12-23T11:45:45.723Z| vmx| I120: Progress 44% (none)
2013-12-23T11:45:45.724Z| vmx| I120: Progress 45% (none)
2013-12-23T11:45:45.725Z| vmx| I120: Progress 46% (none)
2013-12-23T11:45:45.726Z| vmx| I120: Progress 47% (none)
2013-12-23T11:45:45.727Z| vmx| I120: Progress 48% (none)
2013-12-23T11:45:45.728Z| vmx| I120: Progress 49% (none)
2013-12-23T11:45:45.729Z| vmx| I120: Progress 50% (none)
2013-12-23T11:45:45.730Z| vmx| I120: Progress 51% (none)
2013-12-23T11:45:45.731Z| vmx| I120: Progress 52% (none)
2013-12-23T11:45:45.732Z| vmx| I120: Progress 53% (none)
2013-12-23T11:45:45.733Z| vmx| I120: Progress 54% (none)
2013-12-23T11:45:45.734Z| vmx| I120: Progress 55% (none)
2013-12-23T11:45:45.735Z| vmx| I120: Progress 56% (none)
2013-12-23T11:45:45.736Z| vmx| I120: Progress 57% (none)
2013-12-23T11:45:45.737Z| vmx| I120: Progress 58% (none)
2013-12-23T11:45:45.738Z| vmx| I120: Progress 59% (none)
2013-12-23T11:45:45.739Z| vmx| I120: Progress 60% (none)
2013-12-23T11:45:45.740Z| vmx| I120: Progress 61% (none)
2013-12-23T11:45:45.741Z| vmx| I120: Progress 62% (none)
2013-12-23T11:45:45.742Z| vmx| I120: Progress 63% (none)
2013-12-23T11:45:45.743Z| vmx| I120: Progress 64% (none)
2013-12-23T11:45:45.744Z| vmx| I120: Progress 65% (none)
2013-12-23T11:45:45.745Z| vmx| I120: Progress 66% (none)
2013-12-23T11:45:45.746Z| vmx| I120: Progress 67% (none)
2013-12-23T11:45:45.747Z| vmx| I120: Progress 68% (none)
2013-12-23T11:45:45.748Z| vmx| I120: Progress 69% (none)
2013-12-23T11:45:45.749Z| vmx| I120: Progress 70% (none)
2013-12-23T11:45:45.750Z| vmx| I120: Progress 71% (none)
2013-12-23T11:45:45.751Z| vmx| I120: Progress 72% (none)
2013-12-23T11:45:45.752Z| vmx| I120: Progress 73% (none)
2013-12-23T11:45:45.753Z| vmx| I120: Progress 74% (none)
2013-12-23T11:45:45.754Z| vmx| I120: Progress 75% (none)
2013-12-23T11:45:45.755Z| vmx| I120: Progress 76% (none)
2013-12-23T11:45:45.756Z| vmx| I120: Progress 77% (none)
2013-12-23T11:45:45.757Z| vmx| I120: Progress 78% (none)
2013-12-23T11:45:45.758Z| vmx| I120: Progress 79% (none)
2013-12-23T11:45:45.759Z| vmx| I120: Progress 80% (none)
2013-12-23T11:45:45.760Z| vmx| I120: Progress 81% (none)
2013-12-23T11:45:45.761Z| vmx| I120: Progress 82% (none)
2013-12-23T11:45:45.762Z| vmx| I120: Progress 83% (none)
2013-12-23T11:45:45.763Z| vmx| I120: Progress 84% (none)
2013-12-23T11:45:45.764Z| vmx| I120: Progress 85% (none)
2013-12-23T11:45:45.765Z| vmx| I120: Progress 86% (none)
2013-12-23T11:45:45.766Z| vmx| I120: Progress 87% (none)
2013-12-23T11:45:45.767Z| vmx| I120: Progress 88% (none)
2013-12-23T11:45:45.768Z| vmx| I120: Progress 89% (none)
2013-12-23T11:45:45.769Z| vmx| I120: Progress 90% (none)
2013-12-23T11:45:45.770Z| vmx| I120: Progress 91% (none)
2013-12-23T11:45:45.771Z| vmx| I120: Progress 92% (none)
2013-12-23T11:45:45.772Z| vmx| I120: Progress 93% (none)
2013-12-23T11:45:45.773Z| vmx| I120: Progress 94% (none)
2013-12-23T11:45:45.774Z| vmx| I120: Progress 95% (none)
2013-12-23T11:45:45.775Z| vmx| I120: Progress 96% (none)
2013-12-23T11:45:45.776Z| vmx| I120: Progress 97% (none)
2013-12-23T11:45:45.776Z| Worker#0| I120: GetHostManifests: Done extracting the manifest file.
2013-12-23T11:45:45.777Z| vmx| I120: Progress 98% (none)
2013-12-23T11:45:45.777Z| Worker#0| I120: ToolsVersionGetStatus:
2013-12-23T11:45:45.778Z| vmx| I120: Progress 99% (none)
2013-12-23T11:45:45.779Z| vmx| I120: restoring MStats
2013-12-23T11:45:45.779Z| vmx| I120: restoring Snapshot
2013-12-23T11:45:45.779Z| vmx| I120: restoring pic
2013-12-23T11:45:45.780Z| vmx| I120: restoring FTCpt
2013-12-23T11:45:45.780Z| vmx| I120: restoring ide0:0
2013-12-23T11:45:45.780Z| vmx| I120: restoring scsi0:0
2013-12-23T11:45:45.780Z| vmx| I120: restoring TimeTracker
2013-12-23T11:45:45.780Z| vmx| I120: TimeTracker host to guest rate conversion 4521770816931658 @ 3092974000Hz -> 844823919839824 @ 3092974000Hz
2013-12-23T11:45:45.780Z| vmx| I120: TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + -3676946897091834
2013-12-23T11:45:45.780Z| vmx| I120: timeTracker.globalProgressMaxAllowanceMS: 2000
2013-12-23T11:45:45.780Z| vmx| I120: timeTracker.globalProgressToAllowanceNS: 1000
2013-12-23T11:45:45.780Z| vmx| I120: restoring Backdoor
2013-12-23T11:45:45.780Z| vmx| I120: restoring PCI
2013-12-23T11:45:45.780Z| vmx| I120: restoring Cs440bx
2013-12-23T11:45:45.781Z| vmx| I120: DUMPER: Item 'gpe.status' [2, -1] not found.
2013-12-23T11:45:45.781Z| vmx| I120: DUMPER: Item 'gpe.enable' [2, -1] not found.
2013-12-23T11:45:45.781Z| vmx| I120: restoring ExtCfgDevice
2013-12-23T11:45:45.781Z| vmx| I120: restoring Floppy
2013-12-23T11:45:45.781Z| vmx| I120: restoring AcpiNotify
2013-12-23T11:45:45.781Z| vmx| I120: restoring vcpuHotPlug
2013-12-23T11:45:45.781Z| vmx| I120: restoring devHP
2013-12-23T11:45:45.781Z| vmx| I120: restoring ACPIWake
2013-12-23T11:45:45.781Z| vmx| I120: restoring DevicesPowerOn
2013-12-23T11:45:45.781Z| vmx| I120: restoring PCIBridge0
2013-12-23T11:45:45.781Z| vmx| I120: restoring PCIBridge4
2013-12-23T11:45:45.781Z| vmx| I120: restoring pciBridge4:1
2013-12-23T11:45:45.781Z| vmx| I120: restoring pciBridge4:2
2013-12-23T11:45:45.782Z| vmx| I120: restoring pciBridge4:3
2013-12-23T11:45:45.782Z| vmx| I120: restoring pciBridge4:4
2013-12-23T11:45:45.782Z| vmx| I120: restoring pciBridge4:5
2013-12-23T11:45:45.782Z| vmx| I120: restoring pciBridge4:6
2013-12-23T11:45:45.782Z| vmx| I120: restoring pciBridge4:7
2013-12-23T11:45:45.782Z| vmx| I120: restoring PCIBridge5
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:1
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:2
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:3
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:4
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:5
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:6
2013-12-23T11:45:45.783Z| vmx| I120: restoring pciBridge5:7
2013-12-23T11:45:45.784Z| vmx| I120: restoring PCIBridge6
2013-12-23T11:45:45.784Z| vmx| I120: restoring pciBridge6:1
2013-12-23T11:45:45.784Z| vmx| I120: restoring pciBridge6:2
2013-12-23T11:45:45.784Z| vmx| I120: restoring pciBridge6:3
2013-12-23T11:45:45.784Z| vmx| I120: restoring pciBridge6:4
2013-12-23T11:45:45.785Z| vmx| I120: restoring pciBridge6:5
2013-12-23T11:45:45.785Z| vmx| I120: restoring pciBridge6:6
2013-12-23T11:45:45.785Z| vmx| I120: restoring pciBridge6:7
2013-12-23T11:45:45.785Z| vmx| I120: restoring PCIBridge7
2013-12-23T11:45:45.785Z| Worker#0| I120: ToolsVersionGetStatusWorkerThread: Tools status 3 derived from environment
2013-12-23T11:45:45.785Z| vmx| I120: restoring pciBridge7:1
2013-12-23T11:45:45.785Z| vmx| I120: restoring pciBridge7:2
2013-12-23T11:45:45.786Z| vmx| I120: restoring pciBridge7:3
2013-12-23T11:45:45.786Z| Worker#0| I120: GetHostManifests: Extracting the manifest file.
2013-12-23T11:45:45.786Z| vmx| I120: restoring pciBridge7:4
2013-12-23T11:45:45.786Z| vmx| I120: restoring pciBridge7:5
2013-12-23T11:45:45.786Z| vmx| I120: restoring pciBridge7:6
2013-12-23T11:45:45.786Z| vmx| I120: restoring pciBridge7:7
2013-12-23T11:45:45.786Z| vmx| I120: restoring vide
2013-12-23T11:45:45.787Z| vmx| I120: DUMPER: Block item 'monbuf' [0, -1] not found.
2013-12-23T11:45:45.787Z| vmx| I120: DUMPER: Block item 'monbuf' [1, -1] not found.
2013-12-23T11:45:45.787Z| vmx| I120: restoring SCSI0
2013-12-23T11:45:45.788Z| vmx| I120: restoring VGA
2013-12-23T11:45:45.788Z| vmx| I120: restoring SVGA
2013-12-23T11:45:45.789Z| vmx| I120: SVGA phys sizes: 1176x885x32 offset 0 fb 0x00400000
2013-12-23T11:45:45.789Z| vmx| I120: SVGA compatible geometry on checkpoint restore
2013-12-23T11:45:45.789Z| vmx| I120: SVGA old geometry 1176x885, max size = 4194304
2013-12-23T11:45:45.789Z| vmx| I120: SVGA new geometry 1176x885, max size = 4194304
2013-12-23T11:45:45.810Z| Worker#0| I120: GetHostManifests: Done extracting the manifest file.
2013-12-23T11:45:45.811Z| Worker#0| I120: ToolsVersionGetStatus:
2013-12-23T11:45:45.812Z| Worker#0| I120: ToolsVersionGetStatusWorkerThread: Tools status 3 derived from environment
2013-12-23T11:45:45.825Z| vmx| I120: DUMPER: Item 'screens.arraySize' [-1, -1] not found.
2013-12-23T11:45:45.827Z| vmx| I120: MKS3dCaps: guest, at resume: 3d checkpoint unsupported
2013-12-23T11:45:45.827Z| vmx| I120: restoring usb
2013-12-23T11:45:45.828Z| vmx| I120: DUMPER: Item 'lastFrnumChangeTime' [-1, -1] not found.
2013-12-23T11:45:45.828Z| vmx| I120: restoring usb:0
2013-12-23T11:45:45.828Z| vmx| I120: restoring usb:1
2013-12-23T11:45:45.828Z| vmx| I120: restoring Ethernet0
2013-12-23T11:45:45.828Z| vmx| I120: restoring Ethernet1
2013-12-23T11:45:45.836Z| vmx| I120: restoring hpet0
2013-12-23T11:45:45.836Z| vmx| I120: restoring ich7m.hpet
2013-12-23T11:45:45.837Z| vmx| I120: restoring ehci
2013-12-23T11:45:45.837Z| vmx| I120: restoring vmci0
2013-12-23T11:45:45.837Z| vmx| I120: restoring vmioplugin
2013-12-23T11:45:45.837Z| vmx| I120: restoring OEMDevice
2013-12-23T11:45:45.837Z| vmx| I120: restoring HotButton
2013-12-23T11:45:45.837Z| vmx| I120: restoring GuestMsg
2013-12-23T11:45:45.837Z| vmx| I120: restoring GuestRpc
2013-12-23T11:45:45.837Z| vmx| I120: restoring Timer
2013-12-23T11:45:45.838Z| vmx| I120: restoring ACPI
2013-12-23T11:45:45.838Z| vmx| I120: restoring XPMode
2013-12-23T11:45:45.838Z| vmx| I120: restoring Tools
2013-12-23T11:45:45.838Z| vmx| I120: restoring Tools Install
2013-12-23T11:45:45.838Z| vmx| I120: TOOLS INSTALL setting state to 0 on restore.
2013-12-23T11:45:45.838Z| vmx| I120: restoring GuestAppMonitor
2013-12-23T11:45:45.838Z| vmx| I120: DUMPER: Requested 10 bytes, found 5 bytes.
2013-12-23T11:45:45.838Z| vmx| I120: DUMPER: Requested 20 bytes, found 5 bytes.
2013-12-23T11:45:45.838Z| vmx| I120: restoring MKSVMX
2013-12-23T11:45:45.838Z| vmx| I120: restoring DMA
2013-12-23T11:45:45.838Z| vmx| I120: restoring BackdoorAPM
2013-12-23T11:45:45.838Z| vmx| I120: restoring CMOS
2013-12-23T11:45:45.838Z| vmx| I120: restoring FlashRam
2013-12-23T11:45:45.838Z| vmx| I120: restoring A20
2013-12-23T11:45:45.838Z| vmx| I120: restoring backdoorAbsMouse
2013-12-23T11:45:45.838Z| vmx| I120: restoring Keyboard
2013-12-23T11:45:45.839Z| vmx| I120: restoring SIO
2013-12-23T11:45:45.839Z| vmx| I120: restoring serial0
2013-12-23T11:45:45.839Z| vmx| I120: restoring serial1
2013-12-23T11:45:45.839Z| vmx| I120: restoring parallel0
2013-12-23T11:45:45.839Z| vmx| I120: restoring monitorLate
2013-12-23T11:45:45.839Z| vmx| I120: restoring MemoryHotplug
2013-12-23T11:45:45.839Z| vmx| I120: restoring devices
2013-12-23T11:45:45.839Z| vmx| I120: restoring configdbFT
2013-12-23T11:45:45.839Z| vmx| I120: restoring FeatureCompat
2013-12-23T11:45:45.840Z| vmx| I120: restoring NamespaceMgr
2013-12-23T11:45:45.840Z| vmx| I120: Progress 101% (none)
2013-12-23T11:45:45.840Z| vmx| I120: DUMPER: Updating header magic on restore.
2013-12-23T11:45:45.850Z| vmx| I120: Guest CPUID differences from hostCPUID.
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000001, 0: 0x000306a9 0x00040800 0xf6ba2203 0x1fabbbff
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 0: 0x0c00c121 0x01c0003f 0x0000003f 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 1: 0x0c00c122 0x01c0003f 0x0000003f 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 2: 0x0c00c143 0x01c0003f 0x000001ff 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 3: 0x0c00c163 0x03c0003f 0x00001fff 0x00000006
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 4: 0x0c000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 00000004, 5: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 0000000a, 0: 0x07300801 0x0000007f 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 0000000b, 0: 0x00000000 0x00000001 0x00000100 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 0000000b, 1: 0x00000002 0x00000004 0x00000201 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 0000000b, 2: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000000, 0: 0x40000010 0x61774d56 0x4d566572 0x65726177
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000001, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000002, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000004, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000006, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000008, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000a, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000b, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000c, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000d, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000e, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 4000000f, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 40000010, 0: 0x002f31ee 0x000101d0 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 80000008, 0: 0x00003028 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: guestCPUID level 80000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
2013-12-23T11:45:45.850Z| vmx| I120: CPUID control desired.
2013-12-23T11:45:45.850Z| vmx| I120: VPMC: events will use hybrid freeze.
2013-12-23T11:45:45.850Z| vmx| I120: VPMC: gen counters: num 8 mask 0xffffffffffff
2013-12-23T11:45:45.850Z| vmx| I120: VPMC: fix counters: num 0 mask 0; version 1
2013-12-23T11:45:45.850Z| vmx| I120: VPMC: hardware counters: 0
2013-12-23T11:45:45.851Z| vmx| I120: SVGA: Registering IOSpace at 0x1070
2013-12-23T11:45:45.851Z| vmx| I120: BusMemSampleSetUpStats: touched: initPct 8 pages 94371 : dirtied: initPct 5 pages 62914
2013-12-23T11:45:45.851Z| vmx| I120: FeatureCompat: Capabilities:
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.6 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.Intel = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.RDRAND = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.XSAVE = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.fixctr.0 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.LM = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.7 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.ENFSTRG = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.MWAIT = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.numGenCtrs = 0x8
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.fixedWidth = 0x30
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.4 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.VMX = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genWidth = 0x30
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.version = 0x3
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.XCR0_MASTER_YMM_H = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.5 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: misc.cpuidFaulting = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.PCID = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.2 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SSSE3 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SSE3 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.NX = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SSE41 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.AES = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.PCLMULQDQ = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SS = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.POPCNT = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.AVX = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.3 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vt.realmode = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.F16C = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.microarchitecture.ivybridge = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.FSGSBASE = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.DS = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.0 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.RDTSCP = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.LAHF64 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: hv.capable = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.CMPXCHG16B = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SMEP = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.numFixedCtrs = 0x3
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: vpmc.genctr.1 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.SSE42 = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: Capability Found: cpuid.XCR0_MASTER_SSE = 0x1
2013-12-23T11:45:45.851Z| vmx| I120: FeatureCompat: Requirements:
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SSE3 - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.PCLMULQDQ - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SSSE3 - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.CMPXCHG16B - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.PCID - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SSE41 - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SSE42 - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.POPCNT - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.AES - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.XSAVE - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.AVX - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.F16C - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.RDRAND - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.DS - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SS - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.FSGSBASE - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.SMEP - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.ENFSTRG - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.XCR0_MASTER_SSE - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.XCR0_MASTER_YMM_H - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.LAHF64 - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.NX - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.RDTSCP - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.LM - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: cpuid.Intel - Bool:Min:1
2013-12-23T11:45:45.851Z| vmx| I120: VM Features Required: misc.cpuidFaulting - Bool:Min:1
2013-12-23T11:45:45.853Z| vmx| I120:
2013-12-23T11:45:45.853Z| vmx| I120+ OvhdMem: Static (Power On) Overheads
2013-12-23T11:45:45.853Z| vmx| I120: reserved | used
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem excluded cur max | cur max avg
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MainMem : 1048576 1048576 | - - -
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxText : 5376 5376 | - - -
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxTextLibs : 15360 15360 | - - -
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem Total excluded : 1069312 1069312 | - - -
2013-12-23T11:45:45.853Z| vmx| I120:
2013-12-23T11:45:45.853Z| vmx| I120: reserved | used
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem paged cur max | cur max avg
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_KSTATS_vmm : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_STATS_vmm : 8 8 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_KSTATS_device : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_STATS_device : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_KSTATS_migrate : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_DiskLibMemUsed : 3075 3075 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VgaShadowFB : 347 347 | 347 347 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SvgaSurfaceTable : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SvgaShaderTable : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SvgaShaderText : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SvgaContextTable : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxAllocTrack : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxCallStackProf : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxGlobals : 1152 1152 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxGlobalsLibs : 3584 3584 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxHeap : 6400 6400 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxHeapFreeList : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMainMemCheck : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMks : 33 33 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksThumbnail : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMks3d : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksGLRenderer : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksLLVM : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksScreenshot : 2049 2049 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksVnc : 2158 2158 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxMksShadowFB : 1536 1536 | 771 771 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxPhysMemRingBuf : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxReplayCheck : 0 4096 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxFTCptOutputBuf : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxSLEntryBuf : 128 128 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxThreadMks : 512 512 | 512 512 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxThreadVmx : 512 512 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxThreadsVcpu : 1024 1024 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxThreadsWorker : 1536 1536 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VmxThreadSvga : 512 512 | 512 512 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem Total paged : 24570 28666 | 2143 2143 0
2013-12-23T11:45:45.853Z| vmx| I120:
2013-12-23T11:45:45.853Z| vmx| I120: reserved | used
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem nonpaged cur max | cur max avg
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SharedArea : 360 360 | 89 89 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_BusMemTraceBitmap : 35 35 | 35 35 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PFrame : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VProbe : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VIDE_KSEG : 16 16 | 16 16 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VGA : 64 64 | 64 64 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PShareMPN : 2 2 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_P2MUpdateBuffer : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SharedMPNsPool : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_ServicesMPN : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_LocalApic : 4 4 | 4 4 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_BusError : 1 1 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VBIOS : 8 8 | 8 8 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VnicGuest : 32 32 | 32 32 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VnicMmap : 1 1 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_TestDev : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_LSIBIOS : 4 4 | 4 4 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_LSIRings : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PCIPBIOS : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PVSCSIBIOS : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PVSCSIKickReg : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SAS1068BIOS : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SBIOS : 16 16 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_AHCIBIOS : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_FlashRam : 128 128 | 128 128 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SVGAFB : 1024 1024 | 1024 1024 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SVGAMEM : 64 512 | 64 64 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_HDAudioReg : 3 3 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_EHCIRegister : 1 1 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_XhciRegister : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PhysMemDebug : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_HyperV : 2 2 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_HVIOBitmap : 3 3 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_HVMSRBitmap : 2 2 | 1 1 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VHVGuestMSRBitmap : 2 2 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_vhvCachedVMCS : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_StateLoggerLogBuf : 0 512 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PCIP : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_VMsafe : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MonWired : 4 4 | 4 4 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MonLow : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MonWiredNuma : 104 104 | 104 104 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MonNuma : 1081 1081 | 359 359 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_MonOther : 72 72 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_SVMLowMem : 5 5 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_PAEShadow : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdUser_FTCpt : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem Total nonpaged : 3055 4015 | 1940 1940 0
2013-12-23T11:45:45.853Z| vmx| I120:
2013-12-23T11:45:45.853Z| vmx| I120: reserved | used
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem anonymous cur max | cur max avg
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_Alloc : 284 284 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemFrame : 2308 2316 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemFramePGAR : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemTracePGAR : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMem2MRegionPGAR : 16 16 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemZapListMPN : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemRemap : 2 2 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_MMU : 2804 2804 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_ScratchAS : 648 648 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_MonTLB : 24 24 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_DT : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_TCCoherency : 24 24 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_TC : 2048 2048 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_ChainInfo : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_Island : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusMemScratchAS : 8 8 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_PlatformScratchAS : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BackdoorHintsMPN : 5 5 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_HV : 8 8 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VHV : 16 16 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VNPTShadow : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VNPTShadowCache : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VNPTBackmap : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_SVMIDT : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_CallStackProfAnon : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_Numa : 981 981 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_WiredNuma : 104 104 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_GPhysTraced : 439 439 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_GPhysHWMMU : 2209 2209 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_GPhysNoTrace : 109 109 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BTScratchPage : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_StateLoggerBufferPA : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_TraceALot : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VIDE : 4 4 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VMXNETWake : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_BusLogic : 8 8 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_Ahci : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_PVSCSIShadowRing : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_LSIRings : 8 8 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_FTCptScratchAS : 0 0 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem OvhdMon_VProbe : 1 1 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem Total anonymous : 12078 12086 | 0 0 0
2013-12-23T11:45:45.853Z| vmx| I120:
2013-12-23T11:45:45.853Z| vmx| I120: OvhdMem: memsize 4096 MB VMK fixed 83 pages var 0 pages cbrcOverhead 0 pages total 2133 pages
2013-12-23T11:45:45.853Z| vmx| I120: VMMEM: Precise Reservation: 174MB (MainMem=4096MB) VMK=8MB
2013-12-23T11:45:45.854Z| vmx| I120: Vix: [4505616 mainDispatch.c:1095]: VMAutomation_PowerOn. Powering on.
2013-12-23T11:45:45.855Z| vmx| I120: VMX_PowerOn: ModuleTable_PowerOn = 1
2013-12-23T11:45:45.864Z| vcpu-0| I120: VTHREAD start thread 3 "vcpu-0" pid 4505627
2013-12-23T11:45:45.864Z| vcpu-0| I120: VMMon_Start: vcpu-0: worldID=4505619
2013-12-23T11:45:45.865Z| vcpu-0| I120: APIC: version = 0x15, max LVT = 6, LDR = 0x1000000, DFR = 0xffffffff
2013-12-23T11:45:45.865Z| vcpu-0| I120: LSI:Initialize adapter scsi0
2013-12-23T11:45:45.866Z| vcpu-1| I120: VTHREAD start thread 4 "vcpu-1" pid 4505628
2013-12-23T11:45:45.866Z| vcpu-1| I120: VMMon_Start: vcpu-1: worldID=4505621
2013-12-23T11:45:45.866Z| vcpu-1| I120: APIC: version = 0x15, max LVT = 6, LDR = 0x4000000, DFR = 0xffffffff
2013-12-23T11:45:45.866Z| vcpu-2| I120: VTHREAD start thread 5 "vcpu-2" pid 4505629
2013-12-23T11:45:45.866Z| vcpu-2| I120: VMMon_Start: vcpu-2: worldID=4505622
2013-12-23T11:45:45.866Z| vcpu-2| I120: APIC: version = 0x15, max LVT = 6, LDR = 0x2000000, DFR = 0xffffffff
2013-12-23T11:45:45.866Z| vcpu-3| I120: VTHREAD start thread 6 "vcpu-3" pid 4505630
2013-12-23T11:45:45.866Z| vcpu-3| I120: VMMon_Start: vcpu-3: worldID=4505623
2013-12-23T11:45:45.866Z| vcpu-3| I120: APIC: version = 0x15, max LVT = 6, LDR = 0x2000000, DFR = 0xffffffff
2013-12-23T11:45:45.867Z| vcpu-3| I120: Intel VT: VPID enabled.
2013-12-23T11:45:45.867Z| vcpu-1| I120: Intel VT: VPID enabled.
2013-12-23T11:45:45.867Z| vcpu-2| I120: Intel VT: VPID enabled.
2013-12-23T11:45:45.867Z| vcpu-3| I120: Intel VT enabled.
2013-12-23T11:45:45.867Z| vcpu-1| I120: Intel VT enabled.
2013-12-23T11:45:45.867Z| vcpu-2| I120: Intel VT enabled.
2013-12-23T11:45:45.867Z| vcpu-0| I120: PIIX4: PM Resuming from suspend type 0x5, chipset.onlineStandby 1
2013-12-23T11:45:45.868Z| vcpu-3| W110: Restoring VMM
2013-12-23T11:45:45.868Z| vcpu-1| W110: Restoring VMM
2013-12-23T11:45:45.868Z| vcpu-2| W110: Restoring VMM
2013-12-23T11:45:45.875Z| vcpu-0| I120: CDROM: Connecting ide0:0 to '/vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0'. type=1 remote=0
2013-12-23T11:45:45.875Z| vcpu-0| I120: CDROM-SG: Opening device '/vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0'
2013-12-23T11:45:45.887Z| vcpu-0| I120: SGLIN: /vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0 is not a block device
2013-12-23T11:45:45.887Z| vcpu-0| I120: SGLIN: Failed to get maximum transfer length for '/vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0' : Block device required (f0002).
2013-12-23T11:45:45.887Z| vcpu-0| I120: SGLIN: Using default maximum transfer length (131072 bytes)
2013-12-23T11:45:45.889Z| vcpu-0| I120: CDROM: Checking initial physical media state...
2013-12-23T11:45:45.890Z| vcpu-0| I120: CDROM: initial physical CDROM state is 4 (sense)
2013-12-23T11:45:45.891Z| vcpu-0| I120: Intel VT: VPID enabled.
2013-12-23T11:45:45.891Z| vcpu-0| I120: Intel VT enabled.
2013-12-23T11:45:45.892Z| vcpu-0| W110: Restoring VMM
2013-12-23T11:45:45.894Z| vcpu-0| I120: USB: Disconnecting missing device on Virtual Hub 1, Port 1
2013-12-23T11:45:45.894Z| vcpu-0| I120: USB: Disconnecting missing device on Virtual Hub 1, Port 2
2013-12-23T11:45:46.037Z| vcpu-0| I120: VMXNET3 user: Ethernet1 Driver Info: version = 1107087 gosBits = 1 gosType = 2, gosVer = 21024, gosMisc = 161
2013-12-23T11:45:46.037Z| vcpu-0| I120: SVGA: Registering MemSpace at 0xec000000(0xec000000) and 0xfe000000(0xfe000000)
2013-12-23T11:45:46.037Z| vcpu-0| I120: SCSI: switching scsi0 to push completion mode
2013-12-23T11:45:46.037Z| vcpu-0| I120: Vix: [4505627 mainDispatch.c:3964]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1872, success=1 additionalError=0
2013-12-23T11:45:46.038Z| vcpu-0| I120: Vix: [4505627 mainDispatch.c:3884]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=0, err=0).
2013-12-23T11:45:46.038Z| vcpu-0| I120: Vix: [4505627 mainDispatch.c:3884]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=2, err=0).
2013-12-23T11:45:46.038Z| vcpu-0| I120: Transitioned vmx/execState/val to poweredOn
2013-12-23T11:45:46.052Z| vcpu-0| I120: CPT: vmstart
2013-12-23T11:45:46.052Z| vcpu-2| I120: CPT: vmstart
2013-12-23T11:45:46.052Z| vcpu-1| I120: CPT: vmstart
2013-12-23T11:45:46.052Z| vcpu-3| I120: CPT: vmstart
2013-12-23T11:45:47.020Z| vmx| I120: VUsbUpdateVigorFieldsAndAutoconnect: New set of 2 USB devices
2013-12-23T11:45:47.020Z| vmx| I120: USB: Found device [name:U.S.\ Robotics\ 56K\ Faxmodem\ USB vid:0baf pid:6112 path:2/0/4 speed:full family:vendor serialnum:USBHCF00000006 arbRuntimeKey:3 version:2]
2013-12-23T11:45:47.020Z| vmx| I120: USB: Autoconnecting device "U.S. Robotics 56K Faxmodem USB" matching pattern [path:2/0/4 autoclean:1 virtPath:usb.autoConnect.device1 version:2] prefer usb
2013-12-23T11:45:47.020Z| vmx| I120: USB: Connecting device 0x200000030baf6112
2013-12-23T11:45:47.020Z| vmx| I120: USB: Found device [name:Feitian\ USB\ Key\ Ver\ 1.0\ Microcosm\ Ltd. vid:096e pid:0003 path:2/0/5 speed:low family:vendor,other arbRuntimeKey:1 version:2]
2013-12-23T11:45:47.020Z| vmx| I120: USB: Autoconnecting device "Feitian USB Key Ver 1.0 Microcosm Ltd." matching pattern [path:2/0/5 autoclean:1 virtPath:usb.autoConnect.device0 version:2] prefer usb
2013-12-23T11:45:47.020Z| vmx| I120: USB: Connecting device 0x20000001096e0003
2013-12-23T11:45:47.028Z| vmx| I120: USBGA: device 200000030baf6112 arrived
2013-12-23T11:45:47.028Z| vmx| I120: VMXVmdb_SetToolsVersionStatus: status value set to 'ok', 'current', install possible
2013-12-23T11:45:47.029Z| vmx| I120: VMXVmdb_SetToolsVersionStatus: status value set to 'ok', 'current', install possible
2013-12-23T11:45:47.029Z| vmx| I120: USBGA: device 20000001096e0003 arrived
2013-12-23T11:45:47.029Z| vmx| I120: VUsbUpdateVigorFieldsAndAutoconnect: New set of 2 USB devices
2013-12-23T11:45:47.029Z| vmx| I120: USB: Found device [name:U.S.\ Robotics\ 56K\ Faxmodem\ USB vid:0baf pid:6112 path:2/0/4 speed:full family:vendor virtPath:usb:2 serialnum:USBHCF00000006 arbRuntimeKey:3 ownerdisplay:Server1 version:2], connected to [Virtual Hub 1, Port 1]
2013-12-23T11:45:47.029Z| vmx| I120: USB: Device [name:U.S.\ Robotics\ 56K\ Faxmodem\ USB vid:0baf pid:6112 path:2/0/4 speed:full family:vendor virtPath:usb:2 serialnum:USBHCF00000006 arbRuntimeKey:3 ownerdisplay:Server1 version:2] should already be connected
2013-12-23T11:45:47.029Z| vmx| I120: USB: Found device [name:Feitian\ USB\ Key\ Ver\ 1.0\ Microcosm\ Ltd. vid:096e pid:0003 path:2/0/5 speed:low family:vendor,other virtPath:usb:3 arbRuntimeKey:1 ownerdisplay:Server1 version:2], connected to [Virtual Hub 1, Port 2]
2013-12-23T11:45:47.029Z| vmx| I120: USB: Device [name:Feitian\ USB\ Key\ Ver\ 1.0\ Microcosm\ Ltd. vid:096e pid:0003 path:2/0/5 speed:low family:vendor,other virtPath:usb:3 arbRuntimeKey:1 ownerdisplay:Server1 version:2] should already be connected
2013-12-23T11:45:57.553Z| vcpu-3| I120: Guest: toolbox: Version: build-1280544
2013-12-23T11:45:57.720Z| vcpu-3| I120: GuestRpc: Channel 0, guest application toolbox.
2013-12-23T11:45:58.764Z| vcpu-1| I120: HBACommon: First write on scsi0:0.fileName='/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1.vmdk'
2013-12-23T11:45:58.764Z| vcpu-1| I120: DDB: "longContentID" = "0dc47221862c734fff6d46a9b601c799" (was "ab4197b1736f4b67ade4db5b8928aab4")
2013-12-23T11:45:59.292Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x8928aab4, new=0xb601c799 (0dc47221862c734fff6d46a9b601c799)
2013-12-23T11:45:59.693Z| vmx| I120: MainMem: Completed pending lazy prefault.
2013-12-23T11:45:59.693Z| vmx| I120: CPT: Deleting checkpoint state, '/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vmss'.
2013-12-23T11:45:59.964Z| vcpu-1| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T11:45:59.965Z| vcpu-1| I120: GuestRpc: Channel 4, guest application toolbox-dnd.
2013-12-23T11:45:59.965Z| vcpu-3| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T11:45:59.967Z| vcpu-3| I120: GuestRpc: Channel 2, conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 4
2013-12-23T11:45:59.967Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:45:59.967Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:45:59.967Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:00.034Z| vcpu-2| I120: TOOLS autoupgrade protocol version 2
2013-12-23T11:46:00.037Z| vcpu-2| I120: TOOLS Received tools.set.version rpc call, version = 9344.
2013-12-23T11:46:00.037Z| vcpu-2| I120: ToolsSetVersionWork did nothing; new tools version (9344) matches old Tools version
2013-12-23T11:46:00.119Z| vcpu-2| I120: Starting copy guest manifest.
2013-12-23T11:46:00.121Z| vcpu-0| I120: HGFileCopyCreateSessionCB: Successfully created the session.
2013-12-23T11:46:00.147Z| vcpu-2| I120: ToolsLoadManifestFileCB: Queuing a request to update the manifest information.
2013-12-23T11:46:00.148Z| Worker#0| I120: GetHostManifests: Extracting the manifest file.
2013-12-23T11:46:00.226Z| Worker#0| I120: GetHostManifests: Done extracting the manifest file.
2013-12-23T11:46:00.227Z| Worker#0| I120: ToolsVersionGetStatus:
2013-12-23T11:46:00.284Z| Worker#0| I120: ToolsVersionGetStatusWorkerThread: Tools status 3 derived from environment
2013-12-23T11:46:00.284Z| vmx| I120: ToolsUpdateManifestInfoWorkerThreadDone: Compared tools manifest from host and from the guest. Status = 3.
2013-12-23T11:46:00.284Z| vmx| I120: ToolsUpdateManifestInfoWorkerThreadDone: Updating the manifest info.
2013-12-23T11:46:00.285Z| vmx| I120: VMXVmdb_SetToolsVersionStatus: status value set to 'ok', 'current', install possible
2013-12-23T11:46:00.285Z| vmx| I120: TOOLS installed legacy version 9344, available legacy version 9344
2013-12-23T11:46:00.285Z| vmx| I120: TOOLS manifest update status is 3
2013-12-23T11:46:00.285Z| vmx| I120: TOOLS can be autoupgraded.
2013-12-23T11:46:00.285Z| vmx| I120: TOOLS Setting autoupgrade-checked TRUE.
2013-12-23T11:46:00.285Z| vmx| I120: RPT: Disabled. Skipped.
2013-12-23T11:46:00.351Z| vmx| I120: USBGL: Disable port is not supported.
2013-12-23T11:46:00.370Z| vmx| I120: USBGL: Disable port is not supported.
2013-12-23T11:46:00.907Z| vthread-9| I120: VTHREAD start thread 9 "vthread-9" pid 4505696
2013-12-23T11:46:00.908Z| vcpu-3| I120: TOOLS state change 4 returned status 1
2013-12-23T11:46:00.908Z| vcpu-3| I120: Vix: [4505630 mainDispatch.c:3884]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=2, err=0).
2013-12-23T11:46:00.912Z| vcpu-3| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T11:46:00.912Z| vcpu-3| I120: GuestRpc: Channel 2, conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 4
2013-12-23T11:46:00.912Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:00.912Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:00.912Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:02.273Z| vcpu-3| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T11:46:02.273Z| vcpu-3| I120: GuestRpc: Channel 2, conflict: guest application toolbox-dnd tried to register, but it is still registered on channel 4
2013-12-23T11:46:02.273Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:02.273Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:02.273Z| vcpu-3| I120: GuestRpc: Channel 2 reinitialized.
2013-12-23T11:46:20.677Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox timed out.
2013-12-23T11:46:20.678Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2013-12-23T11:46:24.274Z| vmx| I120: Tools: Tools heartbeat timeout.
2013-12-23T11:46:35.722Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox timed out.
2013-12-23T11:46:35.722Z| vmx| I120: GuestRpc: app toolbox's second ping timeout; assuming app is down
2013-12-23T11:46:35.728Z| vmx| I120: GuestRpc: Reinitializing Channel 0(toolbox)
2013-12-23T11:46:35.728Z| vmx| I120: GuestMsg: Channel 0, Cannot unpost because the previous post is already completed
2013-12-23T11:46:35.731Z| vmx| I120: GuestRpc: Channel 0 reinitialized.
2013-12-23T11:46:35.731Z| vmx| I120: GuestRpc: Channel 0 reinitialized.
2013-12-23T11:46:35.734Z| vcpu-3| I120: GuestMsg: Cannot close channel 7: it is not opened
2013-12-23T11:46:35.736Z| vcpu-3| I120: GuestRpc: Channel 4, unable to send an rpc.
2013-12-23T11:46:35.736Z| vcpu-3| I120: GuestRpc: Reinitializing Channel 4(toolbox-dnd)
2013-12-23T11:46:35.736Z| vcpu-3| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T11:46:35.736Z| vcpu-3| I120: GuestRpc: Channel 4 reinitialized.
2013-12-23T11:46:57.741Z| vmx| I120: Tools: Tools heartbeat timeout.
2013-12-23T11:47:02.074Z| vcpu-2| I120: Guest: toolbox-dnd: Version: build-1280544
2013-12-23T11:47:02.075Z| vcpu-1| I120: GuestRpc: Channel 0, guest application toolbox-dnd.
2013-12-23T11:47:15.696Z| vcpu-2| I120: GuestMsg: channel 0: wrong cookie, discarding message.
2013-12-23T11:47:15.696Z| vcpu-2| I120: GuestMsg: channel 0: wrong cookie, discarding message.
2013-12-23T11:47:16.697Z| vcpu-3| I120: Guest: toolbox: Version: build-1280544
2013-12-23T11:47:16.697Z| vcpu-3| I120: GuestRpc: Channel 1, guest application toolbox.
2013-12-23T11:47:16.705Z| vcpu-3| I120: TOOLS autoupgrade protocol version 2
2013-12-23T11:47:16.705Z| vcpu-3| I120: Vix: [4505630 mainDispatch.c:3884]: VMAutomationReportPowerStateChange: Reporting power state change (opcode=2, err=0).
2013-12-23T11:47:16.707Z| vcpu-3| I120: TOOLS Received tools.set.version rpc call, version = 9344.
2013-12-23T11:47:16.707Z| vcpu-3| I120: ToolsSetVersionWork did nothing; new tools version (9344) matches old Tools version
Check vmx file for these entries:
powerType.powerOff = "default"
powerType.powerOn = "default"
powerType.reset = "default"
powerType.suspend = "default"
-A
I can't see any of those options in the vmx file..
See Below:
.encoding = "UTF-8"
config.version = "8"
virtualHW.version = "9"
nvram = "Server1.nvram"
pciBridge0.present = "TRUE"
svga.present = "TRUE"
pciBridge4.present = "TRUE"
pciBridge4.virtualDev = "pcieRootPort"
pciBridge4.functions = "8"
pciBridge5.present = "TRUE"
pciBridge5.virtualDev = "pcieRootPort"
pciBridge5.functions = "8"
pciBridge6.present = "TRUE"
pciBridge6.virtualDev = "pcieRootPort"
pciBridge6.functions = "8"
pciBridge7.present = "TRUE"
pciBridge7.virtualDev = "pcieRootPort"
pciBridge7.functions = "8"
vmci0.present = "TRUE"
hpet0.present = "TRUE"
displayName = "Server1"
extendedConfigFile = "Server1.vmxf"
virtualHW.productCompatibility = "hosted"
floppy0.present = "FALSE"
numvcpus = "4"
cpuid.coresPerSocket = "4"
memSize = "4096"
sched.cpu.affinity = "all"
sched.mem.affinity = "all"
usb.present = "TRUE"
ehci.present = "TRUE"
scsi0.virtualDev = "lsilogic"
scsi0.present = "TRUE"
ethernet0.networkName = "VM Network"
ethernet0.addressType = "generated"
ethernet0.present = "TRUE"
ide0:0.deviceType = "atapi-cdrom"
ide0:0.fileName = "/vmfs/devices/cdrom/mpx.vmhba1:C0:T1:L0"
ide0:0.present = "TRUE"
scsi0:0.deviceType = "scsi-hardDisk"
scsi0:0.fileName = "Server1.vmdk"
scsi0:0.present = "TRUE"
guestOS = "winnetstandard"
uuid.bios = "56 4d 51 2c da ac 08 3b-4c 1a db 90 2f 30 0e 0d"
uuid.location = "56 4d 51 2c da ac 08 3b-4c 1a db 90 2f 30 0e 0d"
vc.uuid = "52 50 c5 11 52 9b f9 ae-af 36 b8 4c f4 8b 6f 00"
sched.swap.derivedName = "/vmfs/volumes/521b8583-d529735c-74a0-a45d36c4b430/Server1/Server1-84d336b7.vswp"
replay.supported = "FALSE"
replay.filename = ""
scsi0:0.redo = ""
pciBridge0.pciSlotNumber = "17"
pciBridge4.pciSlotNumber = "21"
pciBridge5.pciSlotNumber = "22"
pciBridge6.pciSlotNumber = "23"
pciBridge7.pciSlotNumber = "24"
scsi0.pciSlotNumber = "16"
usb.pciSlotNumber = "32"
ethernet0.pciSlotNumber = "33"
ehci.pciSlotNumber = "34"
vmci0.pciSlotNumber = "35"
ethernet0.generatedAddress = "00:0c:29:30:0e:0d"
ethernet0.generatedAddressOffset = "0"
vmci0.id = "791678477"
vmotion.checkpointFBSize = "4194304"
cleanShutdown = "FALSE"
softPowerOff = "FALSE"
usb:1.speed = "2"
usb:1.present = "TRUE"
usb:1.deviceType = "hub"
usb:1.port = "1"
usb:1.parent = "-1"
toolsInstallManager.lastInstallError = "0"
tools.syncTime = "FALSE"
unity.wasCapable = "TRUE"
tools.remindInstall = "FALSE"
toolsInstallManager.updateCounter = "1"
ide0:0.allowGuestConnectionControl = "TRUE"
usb.autoConnect.device0 = "path:2/0/5 autoclean:1"
usb.autoConnect.device1 = "path:2/0/4 autoclean:1"
usb.autoConnect.device2 = ""
checkpoint.vmState = ""
ethernet1.pciSlotNumber = "160"
ethernet1.virtualDev = "vmxnet3"
ethernet1.networkName = "VM Network"
ethernet1.addressType = "generated"
ethernet1.present = "TRUE"
migrate.hostlog = "./Server1-84d336b7.hlog"
config.readOnly = "FALSE"
ethernet1.generatedAddress = "00:0c:29:30:0e:17"
ethernet1.generatedAddressOffset = "10"
usb:0.present = "TRUE"
usb:0.deviceType = "hid"
usb:0.port = "0"
usb:0.parent = "-1"
Would using
"suspend.disabled = “TRUE” "
work with an ESXi vm server?
>work with an ESXi vm server?
Are you using esxi as vm?? can you please detailed about this...
Hello,
Yes we are running this in an ESXi 5.5 environment. (I did say at the top )
Do you have any logs inside your VM that may help ?
Which Logs would you like?
ESXi Logs or Windows Server Logs
I guessed that may in the Windows server, the system logs (or app or security logs) may give some information about which driver launch the suspend state.
The VMware Tools may have registered a log detailing which service ordered stand by.
I was just about to post that the issues have been resolved.
As I logged into the console and changed the power settings that had been set to "Turn off Hard Disk" after 1hr.
But this didn't work. Not sure why that setting would have been set as this was a Server going from P 2 V.
And another server of the exact same type is working correctly.
This server is a Windows 2003 Terminal Server. If that makes any difference.
If I can just prevent ESXi from Suspending the VM this would be a step forward.
Maybe you can do this test :
- Stop this VM
- Create another VM shell and attach the disks of the old VM to the newer
- Start the newer VM
If it works, you got your answer and it means that it was a misconfiguration of the old VM
It it does not work, I guess you have to focus on your Windows configuration.
Ok well we did all these tests but the Server is still being Suspended.
This happens so randomly that this can't be a power time out.
Something must be telling vSphere to Suspend the VM...
At the times noted in the vm log, there is nothing in the windows event log.