neben einigen offensichtlichen Netzproblemen die wir aktuell haben, meldet das vCenter (4.1) immer wieder "Host is not responding" Warnungen. Anschließend kommen die üblichem "VMxxx is disconnected" und weiteren Alarme. Der Spuk dauert 30-40 Sek. in der Zeit ist kein Netzwerkproblem zu erkennen. Das vCenter und der betroffene ESXi Host sind von außen ohne Paketverluste zu erreichen.
Was mir in /var/log/messages bei diesem Problem auffällt, ist die Meldung VMOverheadGrowthLimit. Diese ist immer vorhanden.
Code: Alles auswählen
Apr 10 07:20:31 vmkernel: 7:19:34:15.783 cpu18:347867)Config: 297: "VMOverheadGrowthLimit" = -1, Old Value: 0, (Status: 0x0)
Apr 10 07:20:48 vmkernel: 7:19:34:32.692 cpu38:10783)Config: 297: "HostLocalSwapDirEnabled" = 0, Old Value: 0, (Status: 0x0)
Apr 10 07:20:59 vmkernel: 7:19:34:44.307 cpu51:347871)Config: 297: "VMOverheadGrowthLimit" = 0, Old Value: -1, (Status: 0x0)
Im zentralen remote Syslog finde ich um den Zeitpunkt relative viele Meldungen, bei denen ich aber nicht unmittelbar ein Problem erkennen kann.
Code: Alles auswählen
....
Apr 10 07:20:27 sdev2001 Vpxa: [2012-04-10 07:20:27.678 1FC0AB90 verbose 'App'] [VpxaHalServices] HostChanged Event Fired, properties changed []
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.017 159C9B90 info 'FirmwareSystem' opID=HB-host-65120@11954-6e] SyncConfig succeeded
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.017 159C9B90 verbose 'FirmwareSystem' opID=HB-host-65120@11954-6e] SyncConfiguration: Successfully synced config to persistent store.
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.017 159C9B90 info 'TaskManager' opID=HB-host-65120@11954-6e] Task Completed : haTask--vim.host.FirmwareSystem.syncConfiguration-1006115 Status success
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.022 1FD4FB90 verbose 'VpxaHalCnxHostagent'] Received callback in WaitForUpdatesDone
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.022 1FD4FB90 verbose 'VpxaHalCnxHostagent'] [VpxaHalCnxHostagent::ProcessUpdate] Applying updates from 334864 to 334865 (at 334864)
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.060 1FC4BB90 info 'App' opID=HB-host-65120@11954-6e] [VpxaHalHostHostagent::SetManagementNic]Setting the NIC with address 10.24.38.201 as a management nic
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.061 159C9B90 info 'TaskManager' opID=HB-host-65120@11954-6e] Task Created : haTask-ha-host-vim.host.VirtualNicManager.selectVnic-1006116
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.063 1FC0AB90 verbose 'VpxaHalCnxHostagent'] Received callback in WaitForUpdatesDone
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.063 1FC0AB90 verbose 'VpxaHalCnxHostagent'] [VpxaHalCnxHostagent::ProcessUpdate] Applying updates from 334865 to 334866 (at 334865)
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.089 15B4FB90 info 'TaskManager' opID=HB-host-65120@11954-6e] Task Completed : haTask-ha-host-vim.host.VirtualNicManager.selectVnic-1006116 Status success
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.090 1FC4BB90 verbose 'SoapAdapter.HTTPService' opID=HB-host-65120@11954-6e] HTTP Response: Complete (processed 384 bytes)
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.091 1FC4BB90 info 'App' opID=HB-host-65120@11954-6e] [VpxLRO] -- FINISH task-internal-21779 -- -- vpxapi.VpxaService.setServer -- 529b827c-235b-7071-c19b-5f7d74bb
4b5d
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.102 1FD0EB90 verbose 'SoapAdapter.HTTPService'] User agent is 'VMware-client/4.1.0'
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.102 1FD0EB90 verbose 'SoapAdapter.HTTPService'] HTTP Response: Client: NeedsContentLength: false UnderstandsChunking: true CanKeepAlive: true (PresetContentLength
-1)
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.109 1FD4FB90 info 'App' opID=HB-host-65120@11954-34] [VpxLRO] -- BEGIN task-internal-21780 -- -- vpxapi.VpxaService.setConfig -- 529b827c-235b-7071-c19b-5f7d74bb4
b5d
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.109 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [1+] VpxaMoService::SetConfig
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.110 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [2+] VpxaDatastore::ProcessSpec
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.110 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [2-] VpxaDatastore::ProcessSpec (took 0 ms)
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.110 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [2+] VpxaDas::ProcessSpec
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.111 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] [VpxaDas::SetDasEnabled] Setting dasEnabled to false
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.111 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] [VpxaDas::ProcessSpecInt] Updating cluster defaults for VM monitoring
....
....
sanfs://vmfs_uuid:4eb7b610-f6ac3e24-2cd2-68b599b71fbd/xxxxxxxxx.vmx
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.119 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] [VpxURL] Resolved localPath /vmfs/volumes/4ec61e60-34052c6a-7c32-78acc010efc1/xxxxx/xxxxx.vmx to URL
sanfs://vmfs_uuid:4ec61e60-34052c6a-7c32-78acc010efc1/xxxx/xxxxx.vmx
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.119 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] [VpxURL] Resolved localPath /vmfs/volumes/4eb7b754-e28216c8-12c9-3c4a92f95869/xxxx/xxxxx.vmx to URL
sanfs://vmfs_uuid:4eb7b754-e28216c8-12c9-3c4a92f95869/xxxxx/xxxxx.vmx
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.119 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [2-] VpxaDas::ProcessSpec (took 9 ms)
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.119 1FD4FB90 verbose 'VpxProfiler' opID=HB-host-65120@11954-34] [2+] VpxaInvtHost::ProcessSpec
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.119 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] Setting the VMOverheadGrowthLimit
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.122 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] ESX 4.0 or later host, reading the value as long
Apr 10 07:20:28 sdev2001 Vpxa: [2012-04-10 07:20:28.122 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] ESX 4.0 or later host, setting the value as long
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.124 15A4BB90 info 'TaskManager' opID=HB-host-65120@11954-34] Task Created : haTask-ha-host-vim.option.OptionManager.updateValues-1006118
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.188 15BD1B90 verbose 'App'] Looking up object with name = "firewallSystem" failed.
Apr 10 07:20:28 sdev2001 Hostd: [2012-04-10 07:20:28.274 15BD1B90 verbose 'NetConfigProvider'] FetchFn: List of pnics opted out
Apr 10 07:20:29 sdev2001 Hostd: [2012-04-10 07:20:29.752 15BD1B90 verbose 'NetConfigProvider'] FetchFn: List of pnics opted out
Apr 10 07:20:31 sdev2001 Hostd: [2012-04-10 07:20:31.139 15BD1B90 warning 'PropertyCollector'] ComputeGUReq took 3049542 microSec
Apr 10 07:20:31 sdev2001 Vpxa: [2012-04-10 07:20:31.143 1FDD1B90 verbose 'VpxaHalCnxHostagent'] Received callback in WaitForUpdatesDone
Apr 10 07:20:31 sdev2001 Vpxa: [2012-04-10 07:20:31.143 1FDD1B90 verbose 'VpxaHalCnxHostagent'] [VpxaHalCnxHostagent::ProcessUpdate] Applying updates from 334866 to 334867 (at 334866)
Apr 10 07:20:31 sdev2001 Vpxa: [2012-04-10 07:20:31.143 1FDD1B90 verbose 'App'] [VpxaHalServices] HostChanged Event Fired, properties changed []
Apr 10 07:20:31 sdev2001 vmkernel: 7:19:34:15.783 cpu18:347867)Config: 297: "VMOverheadGrowthLimit" = -1, Old Value: 0, (Status: 0x0)
Apr 10 07:20:31 sdev2001 Hostd: [2012-04-10 07:20:31.157 15B90B90 info 'TaskManager' opID=HB-host-65120@11954-34] Task Completed : haTask-ha-host-vim.option.OptionManager.updateValues-1006118 Status success
Apr 10 07:20:31 sdev2001 Vpxa: [2012-04-10 07:20:31.158 1FD4FB90 verbose 'App' opID=HB-host-65120@11954-34] VMOverheadGrowthLimit has been changed from 0 to -1
Die VMware KB sagt dazu nichts eindeutiges. Die dort beschriebenen Fehlermeldungen bzgl. SSL Handshake finde ich nicht in den Logs.
Hat jemand eine Idee was die Ursache sein kann, bzw. wie man weiter debuggen kann?