vmx プロセス クラッシュが原因で、ESXi ホストが vCenter Server に応答しない
search cancel

vmx プロセス クラッシュが原因で、ESXi ホストが vCenter Server に応答しない

book

Article ID: 334438

calendar_today

Updated On:

Products

VMware vSphere ESXi

Issue/Introduction

  • ESXi ホストが vCenter Server に応答しない。

  • ESXi ホスト上の vpxa プロセスがシャットダウンし、すぐに自動的に再起動する。

  • vmx プロセスのダンプ ファイルが仮想マシン フォルダの下に作成された。

  • 仮想マシン ディレクトリの vmware.log に次のようなエントリが表示される。

    2017-05-11T08:38:18.497Z| svga| I125: MKS-RenderMain: Stopping MKSBasicOps
    2017-05-11T08:38:18.498Z| svga| W115: GLWindow: Unable to reserve host GPU resources
    2017-05-11T08:38:18.498Z| vmx| I125: Msg_Post: Information
    2017-05-11T08:38:18.498Z| vmx| I125: [msg.mks.noGPUResourceFallback] Hardware GPU resources are not available. The virtual machine will use software rendering.
    2017-05-11T08:38:18.498Z| vmx| I125: ----------------------------------------
    2017-05-11T08:38:18.499Z| svga| I125: MKS-SWP: plugin started - llvmpipe (LLVM 3.3, 256 bits)
    2017-05-11T08:38:18.500Z| svga| I125: Started Shim3D
    2017-05-11T08:38:18.500Z| svga| I125: MKS-RenderMain: Starting SWRenderer
    2017-05-11T08:38:18.506Z| svga| I125: Stopped Shim3D
    2017-05-11T08:38:18.506Z| svga| I125: MKS-SWP: plugin stopped
    2017-05-11T08:38:18.506Z| svga| I125: MKS-RenderMain: Stopping SWRenderer
    2017-05-11T08:38:18.506Z| svga| I125: MKS-RenderMain: Starting MKSBasicOps
    2017-05-11T08:38:18.512Z| svga| I125: MKS-RenderMain: Stopping MKSBasicOps
    2017-05-11T08:38:18.513Z| svga| W115: GLWindow: Unable to reserve host GPU resources
    2017-05-11T08:38:18.514Z| svga| I125: MKS-SWP: plugin started - llvmpipe (LLVM 3.3, 256 bits)
    2017-05-11T08:38:18.514Z| svga| I125: Started Shim3D
    2017-05-11T08:38:18.514Z| svga| I125: MKS-RenderMain: Starting SWRenderer
    2017-05-11T08:38:19.024Z| vmx| I125: Vigor_MessageRevoke: message 'msg.mks.noGPUResourceFallback' (seq 17226643) is revoked
    2017-05-11T08:38:19.025Z| vmx| I125: Msg_Post: Information
    2017-05-11T08:38:19.025Z| vmx| I125: [***] ************
    2017-05-11T08:38:19.025Z| vmx| I125: ----------------------------------------
    2017-05-11T08:38:19.035Z| vmx| I125: Vigor_MessageRevoke: message '***' (seq 17226644) is revoked
    2017-05-11T08:38:19Z[+0.000]| vmx| W115: Caught signal 11 -- tid 2946475 (addr 51CB83E0)

    ここで、上のログ　メッセージで *** のマークが付いた領域は、文字化けが含まれる文字列の場合があります。

  • /var/run/log ディレクトリの hostd ログに次のようなエントリが表示される。

    2017-05-11T08:38:19.024Z info hostd[60980B70] [Originator@6876 sub=Vimsvc.ha-eventmgr] Event 124098 : Message on <VM_name> on <ESXi_name> in ha-datacenter: Hardware GPU resources are not available. The virtual machine will use software rendering.
    ..
    2017-05-11T08:38:19.035Z info hostd[60980B70] [Originator@6876 sub=Vimsvc.ha-eventmgr] Event 124100 : Message on <VM_name> on <ESXi_name> in ha-datacenter: ***
    ..
    2017-05-11T08:38:21.173Z info hostd[611C4B70] [Originator@6876 sub=Vimsvc.ha-eventmgr] Event 124104 : An application (/bin/vmx) running on ESXi host has crashed (1 time(s) so far). A core file might have been created at /vmfs/volumes/bae09318-1962d078/<VM_name>/vmx-zdump.000.

    vmware.log の場合と同じように、上記の hostd ログの *** は文字化けを表します。

  • /var/run/log ディレクトリの vpxa ログに次のようなエントリが表示される。

    2017-05-11T08:38:19.757Z error vpxa[FFEB3B70] [Originator@6876 sub=vmomi.soapStub[1] opID=WFU-76958b15] Error deserializating SOAP response body:
    --> Error returned by expat parser: not well-formed (invalid token)
    -->
    --> while parsing serialized value of type string
    --> at line 7, column 626
    -->
    --> while parsing property "fullFormattedMessage" of static type string
    -->
    --> while parsing serialized DataObject of type vim.event.VmMessageEvent
    --> at line 7, column
    -->
    --> while parsing return value of type vim.event.Event[], version vim.version.version
    --> at line 7, column 0
    -->
    --> while parsing SOAP body
    --> at line 6, column 0
    -->
    --> while parsing SOAP envelope
    --> at line 2, column 0
    -->
    --> while parsing HTTP response for method readNext
    --> on object of type vim.event.EventHistoryCollector
    --> at line 1, column 0
    2017-05-11T08:38:19.758Z error vpxa[FFEB3B70] [Originator@6876 sub=vpxaVmomi opID=WFU-76958b15] [VpxaClientAdapter::InvokeCommon] Got exception while invoking readNext on vim.event.EventHistoryCollector:session[52524d42-09c9-7049-b373-1909e8ca4582]5284e251-e630-1e82-5dff-df13ab09949a: 'N7Vmacore4Soap24InvalidResponseExceptionE(
    --> Error returned by expat parser: not well-formed (invalid token)
    -->
    --> while parsing serialized value of type string
    --> at line 7, column 626
    -->
    --> while parsing property "fullFormattedMessage" of static type string
    -->
    --> while parsing serialized DataObject of type vim.event.VmMessageEvent
    --> at line 7, column 42
    -->
    --> while parsing return value of type vim.event.Event[], version vim.version.version10
    --> at line 7, column 0
    -->
    --> while parsing SOAP body
    --> at line 6, column 0
    -->
    --> while parsing SOAP envelope
    --> at line 2, column 0
    -->
    --> while parsing HTTP response for method readNext
    --> on object of type vim.event.EventHistoryCollector
    --> at line 1, column 0)'
    2017-05-11T08:38:19.758Z error vpxa[FFEB3B70] [Originator@6876 sub=VpxaHalCnxHostagent opID=WFU-76958b15] [WaitForUpdatesDone] Got error while processing updates: N5Vmomi5Fault17HostCommunication9ExceptionE(vmodl.fault.HostCommunication)
    2017-05-11T08:38:19.758Z error vpxa[FFEB3B70] [Originator@6876 sub=VpxaHalCnxHostagent opID=WFU-76958b15] [WaitForUpdatesDone] Fatal error while listening-for/processing updates from hostd.
    --> N5Vmomi5Fault17HostCommunication9ExceptionE(vmodl.fault.HostCommunication)
    2017-05-11T08:38:19.763Z info vpxa[FFEB3B70] [Originator@6876 sub=vpxaInvtHost opID=WFU-76958b15] [VpxaInvtHost] ServerId has been changed from 54132 to 0
    2017-05-11T08:38:19.763Z error vpxa[FFEB3B70] [Originator@6876 sub=vpxaInvtHostCnx opID=WFU-76958b15] [VpxaInvtHost] Can't connect to hostd/serverd.Shutting down...
    2017-05-11T08:38:19.763Z info vpxa[FFEB3B70] [Originator@6876 sub=Default opID=WFU-76958b15] [Vpxa] Shutting down now




Symptoms:
免責事項：これは英文の記事「ESXi host not responding to vCenter server due to vmx process crash.(2150430)」の日本語訳です。記事はベストエフォートで翻訳を進めているため、ローカライズ化コンテンツは最新情報ではない可能性があります。最新情報は英語版の記事で参照してください。


Environment

VMware vSphere ESXi 6.0

Cause

vmx プロセスは、メッセージ イベント「[msg.mks.noGPUResourceFallback] Hardware GPU resources are not available. The virtual machine will use software rendering」の処理中にクラッシュしました。vmx プロセスが hostd に無効な文字列を含むメッセージイベントを渡し、その直後にクラッシュしたため、hostd は vpxa からの GetChange 要求に対する適切な応答を作成できず、vpxa は SOAP 応答の本文をデシリアライズする際にエラーが発生し、自分自身で終了することを選択しました。

その結果、ESXi ホストが vCenter からのハートビートに応答しなくなります。


Resolution

これは既知の問題で、ESXi 6.0 以降に影響します。

現在、解決方法はありません。

この問題を回避するには、次のコマンドを使用して ESXi ホスト デーモンと vCenter エージェント サービスを再起動します。

/etc/init.d/hostd restart

/etc/init.d/vpxa restart





Additional Information

ESXi host not responding to vCenter server due to vmx process crash.

Powered by Wolken Software