My Virtual Machine will automatic shutdown, when I login in the windows,why?

[#1]

I have sever  several Virtual Machine,with win2003 os;run on vm4.1.

recently, I find this vm, if I login , the system will shudown in few secends.

Only I use snapshot to recover the system, then it's OK.

system log :

Dec 03 15:50:07.851: mks| MKS: Base polling period is 10000us

Dec 03 15:50:07.964: mks| VNCENCODE 2 encoding mode change: (1024x768x24depth,32bpp,4096bytes/line)

Dec 03 15:50:10.124: vcpu-0| VMMouse: CMD Read ID

Dec 03 15:50:10.257: mks| MKS switching absolute mouse on

Dec 03 15:50:13.174: mks| SVGA: display status changed, using optimizations for remote consoles.

Dec 03 15:50:28.317: vcpu-0| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO

Dec 03 15:50:28.319: vcpu-0| GuestRpc: application toolbox-dnd already registered, id: -1

Dec 03 15:50:28.320: vcpu-0| GuestRpc: Channel 3, guest application toolbox-dnd.

Dec 03 15:50:28.337: vcpu-0| VMXVmdb_LoadRawConfig: Loading raw config

Dec 03 15:50:28.398: vcpu-2| E1000: -- read not allowed on IMC

Dec 03 15:50:28.416: vcpu-2| VMMouse: CMD Disable

Dec 03 15:50:28.417: vcpu-2| VMMouse: Disabling VMMouse mode

Dec 03 15:50:28.440: mks| MKS switching absolute mouse off

Dec 03 15:50:28.571: mks| VNCENCODE 2 show cursor with invalid cursor definition (bug 51988)

Dec 03 15:50:28.653: mks| VNCENCODE 2 encoding mode change: (640x480x24depth,32bpp,2560bytes/line)

Dec 03 15:50:29.468: vcpu-0| PIIX4: PM Soft Off.  Good-bye.

Dec 03 15:50:29.523: vmx| Stopping VCPU threads...

Dec 03 15:50:29.524: vcpu-0| VMMon_WaitForExit: vcpu-0: worldID=4335

Dec 03 15:50:29.525: vcpu-2| VMMon_WaitForExit: vcpu-2: worldID=4342

Dec 03 15:50:29.526: vcpu-1| VMMon_WaitForExit: vcpu-1: worldID=4341

Dec 03 15:50:29.527: vcpu-3| VMMon_WaitForExit: vcpu-3: worldID=4343

Dec 03 15:50:29.627: mks| Ending MKSRole pseudocalls, state was 1

Dec 03 15:50:29.628: mks| Async MKS thread is exiting

Dec 03 15:50:29.628: vmx| Vix: [104330 mainDispatch.c:926]: VMAutomation_PowerOff: Powering off.

Dec 03 15:50:29.658: vmx| VMXVmdb_SetToolsVersionState: status value set to 'ok'

Dec 03 15:50:29.663: vmx| Destroying virtual dev for scsi0:0 vscsi=8212

Dec 03 15:50:29.666: vmx| VMMon_VSCSIStopVports: Invalid handle

Dec 03 15:50:29.667: vmx| VMMon_VSCSIDestroyDev: Not found

Dec 03 15:50:29.669: vmx| SOCKET 2 (116) close VNC socket on VNCBackendDestroy

Dec 03 15:50:29.702: vmx| MKS local poweroff

Dec 03 15:50:29.711: vmx| scsi0:0: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)

Dec 03 15:50:29.712: vmx| Closing disk scsi0:0DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000003-delta.vmdk" : closed.

Dec 03 15:50:29.724: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000002-delta.vmdk" : closed.

Dec 03 15:50:29.724: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000001-delta.vmdk" : closed.

Dec 03 15:50:29.725: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-flat.vmdk" : closed.

Dec 03 15:50:29.764: vmx| WORKER: asyncOps=0 maxActiveOps=0 maxPending=0 maxCompleted=0

Dec 03 15:50:31.976: vmx| Vix: [104330 mainDispatch.c:3709]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0

Dec 03 15:50:31.977: vmx| Vix: [104330 mainDispatch.c:3715]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.

Dec 03 15:50:32.016: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Dec 03 15:50:32.090: vmx| Vix: [104330 mainDispatch.c:3709]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 additionalError=0

Dec 03 15:50:32.096: vmx| Vix: [104330 mainDispatch.c:3715]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.

Dec 03 15:50:32.096: vmx| Transitioned vmx/execState/val to poweredOff

Dec 03 15:50:32.097: vmx| VMX idle exit

Dec 03 15:50:32.103: vmx| VMIOP: Exit

Dec 03 15:50:32.105: vmx| Vix: [104330 mainDispatch.c:671]: VMAutomation_LateShutdown()

Dec 03 15:50:32.106: vmx| Vix: [104330 mainDispatch.c:621]: VMAutomationCloseListenerSocket. Closing listener socket.

Dec 03 15:50:32.116: vmx| Flushing VMX VMDB connections

Dec 03 15:50:32.121: vmx| VMX exit (0).

Dec 03 15:50:32.122: vmx| AIOMGR-S : stat o=13 r=36 w=1 i=0 br=589824 bw=167936

Dec 03 15:50:32.122: vmx| VMX has left the building: 0.

[john23]

Check this KB.

VMware KB: Virtual machines on ESXi/ESX 4.1 U1 power off when sent a reset command

Please don't  ask question as document.

[fangxia712]

Thank you，and i'm sorry to use the document.

I tried this KB，I made the video RAM to 32M,but Virtual machines still power off,when I login.

Dec 04 13:58:27.254: vcpu-2| Compared tools manifest from host and from the guest. Status = 2.

Dec 04 13:58:27.255: vcpu-2| VMXVmdb_SetToolsVersionState: status value set to 'ok'

Dec 04 13:58:27.255: vcpu-2| TOOLS installed legacy version 8300, available legacy version 8300

Dec 04 13:58:27.255: vcpu-2| TOOLS manifest update status is 2 (1-out of date, 2-ok, 3-no tools, 4-unmanaged, 5-unknown)

Dec 04 13:58:27.256: vcpu-2| TOOLS will not be autoupgraded.

Dec 04 13:58:27.256: vcpu-2| TOOLS Setting autoupgrade-checked TRUE.

Dec 04 13:58:27.256: vcpu-2| TOOLS unified loop capability requested by 'toolbox'; now sending options via TCLO

Dec 04 13:58:27.258: vcpu-2| TOOLS sending 'OS_PowerOn' (3) state change request

Dec 04 13:58:27.261: vcpu-2| Guest: toolbox: Version: build-493255

Dec 04 13:58:27.298: vcpu-2| TOOLS state change 3 returned status 1

Dec 04 13:58:55.285: vmx| GuestRpcSendTimedOut: message to toolbox-dnd timed out.

Dec 04 14:04:04.707: vcpu-0| VMMouse: CMD Read ID

Dec 04 14:04:04.749: mks| MKS switching absolute mouse on

Dec 04 14:04:14.635: vcpu-2| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO

Dec 04 14:04:14.635: vcpu-2| GuestRpc: application toolbox-dnd already registered, id: -1

Dec 04 14:04:14.636: vcpu-2| GuestRpc: Channel 3, guest application toolbox-dnd.

Dec 04 14:04:14.651: vcpu-1| VMXVmdb_LoadRawConfig: Loading raw config

Dec 04 14:04:15.121: vcpu-0| VMMouse: CMD Disable

Dec 04 14:04:15.121: vcpu-0| VMMouse: Disabling VMMouse mode

Dec 04 14:04:16.191: vcpu-0| PIIX4: PM Soft Off.  Good-bye.

Dec 04 14:04:16.250: vmx| Stopping VCPU threads...

Dec 04 14:04:16.251: vcpu-1| VMMon_WaitForExit: vcpu-1: worldID=13014

Dec 04 14:04:16.251: vcpu-0| VMMon_WaitForExit: vcpu-0: worldID=13012

Dec 04 14:04:16.290: vcpu-3| VMMon_WaitForExit: vcpu-3: worldID=13016

Dec 04 14:04:16.296: vcpu-2| VMMon_WaitForExit: vcpu-2: worldID=13015

Dec 04 14:04:16.353: mks| Ending MKSRole pseudocalls, state was 1

Dec 04 14:04:16.354: mks| Async MKS thread is exiting

Dec 04 14:04:16.354: vmx| Vix: [113011 mainDispatch.c:926]: VMAutomation_PowerOff: Powering off.

Dec 04 14:04:16.358: vmx| VMXVmdb_SetToolsVersionState: status value set to 'ok'

Dec 04 14:04:16.370: vmx| Destroying virtual dev for scsi0:0 vscsi=8269

Dec 04 14:04:16.370: vmx| VMMon_VSCSIStopVports: Invalid handle

Dec 04 14:04:16.370: vmx| VMMon_VSCSIDestroyDev: Not found

Dec 04 14:04:16.372: vmx| SOCKET 2 (116) close VNC socket on VNCBackendDestroy

Dec 04 14:04:16.402: vmx| MKS local poweroff

Dec 04 14:04:16.404: vmx| scsi0:0: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)

Dec 04 14:04:16.405: vmx| Closing disk scsi0:0DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000003-delta.vmdk" : closed.

Dec 04 14:04:16.411: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000002-delta.vmdk" : closed.

Dec 04 14:04:16.411: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-000001-delta.vmdk" : closed.

Dec 04 14:04:16.412: vmx| DISKLIB-VMFS  : "/vmfs/volumes/5097ac89-93d372e4-a32b-f4ce467ef348/fwwz7/fwwz7-flat.vmdk" : closed.

Dec 04 14:04:16.438: vmx| WORKER: asyncOps=0 maxActiveOps=0 maxPending=0 maxCompleted=0

Dec 04 14:04:17.598: vmx| Vix: [113011 mainDispatch.c:3709]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0

Dec 04 14:04:17.599: vmx| Vix: [113011 mainDispatch.c:3715]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.

Dec 04 14:04:17.659: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Dec 04 14:04:17.722: vmx| Vix: [113011 mainDispatch.c:3709]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 additionalError=0

Dec 04 14:04:17.726: vmx| Vix: [113011 mainDispatch.c:3715]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.

Dec 04 14:04:17.726: vmx| Transitioned vmx/execState/val to poweredOff

Dec 04 14:04:17.726: vmx| VMX idle exit

Dec 04 14:04:17.733: vmx| VMIOP: Exit

Dec 04 14:04:17.735: vmx| Vix: [113011 mainDispatch.c:671]: VMAutomation_LateShutdown()

Dec 04 14:04:17.735: vmx| Vix: [113011 mainDispatch.c:621]: VMAutomationCloseListenerSocket. Closing listener socket.

Dec 04 14:04:17.743: vmx| Flushing VMX VMDB connections

Dec 04 14:04:17.746: vmx| VMX exit (0).

Dec 04 14:04:17.746: vmx| AIOMGR-S : stat o=4 r=12 w=0 i=0 br=196608 bw=0

Dec 04 14:04:17.747: vmx| VMX has left the building: 0.