Karl666
Enthusiast
Enthusiast

Shutdown of VM in vSphere Client results in error-message "Device ´PowerState´ is not available"

Hi,

in vSphere-client (v6.0.0) the VM is up and running, showing VMware-tools up-to-date and also running.

When shutting the VM down via vSphere-client the OS shuts down as requested, but the above error-message in subject is thrown.

Due to the error we run in several problems with Veeam Backup & Replication / Failover, that is why we want to get this resolved.

In hostd.log the following is reported:

2021-10-16T12:58:34.750Z info hostd[3BE86B70] [Originator@6876 sub=Vimsvc.TaskManager opID=86C5D693-00000173-c53a user=root] Task Created : haTask-126-vim.VirtualMachine.shutdownGuest-2693466
2021-10-16T12:58:34.750Z info hostd[3BA40B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx opID=86C5D693-00000173-c53a user=root] State Transition (VM_STATE_ON -> VM_STATE_SHUTTING_DOWN)
2021-10-16T12:58:34.751Z info hostd[3BA40B70] [Originator@6876 sub=Vimsvc.ha-eventmgr opID=86C5D693-00000173-c53a user=root] Event 554651 : Guest OS shut down for Netware 6 - Srv-Brdm (Stdby) on ESX60 in ha-datacenter
2021-10-16T12:58:51.975Z info hostd[3BE86B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx] Send config update invoked
2021-10-16T12:58:52.452Z warning hostd[37CC2B70] [Originator@6876 sub=Libs] VigorOnlineStatusCb: Failed to find RPC Request in pending list for sequence 0
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] SOCKET 108 (52)
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] recv detected client closed connection
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] VigorTransportClientProcessError: Remote connection failure
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] VigorTransportClientDrainRecv: draining read.
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] SOCKET 108 (52)
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] recv detected client closed connection
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] VigorTransportClientProcessError: closing connection.
2021-10-16T12:58:52.452Z info hostd[37CC2B70] [Originator@6876 sub=Libs] VigorTransportClientManageConnection: connection closed.
2021-10-16T12:58:52.474Z info hostd[37CC2B70] [Originator@6876 sub=Libs] CnxAuthdProtoSecureConnect: Unencrypted connection, skipping thumbprint exchange.
2021-10-16T12:58:52.478Z info hostd[37CC2B70] [Originator@6876 sub=Libs] CnxConnectAuthd: Returning false because CnxAuthdProtoConnect failed
2021-10-16T12:58:52.478Z info hostd[37CC2B70] [Originator@6876 sub=Libs] Cnx_Connect: Returning false because CnxConnectAuthd failed
2021-10-16T12:58:52.478Z info hostd[37CC2B70] [Originator@6876 sub=vm:Cnx_Connect: Error message: There is no VMware process running for config file /vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx]
2021-10-16T12:58:52.478Z warning hostd[37CC2B70] [Originator@6876 sub=vm:VigorTransportClientManageConnection: Failed to re-connect to VM /vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx]
2021-10-16T12:58:52.480Z info hostd[37CC2B70] [Originator@6876 sub=Libs] VigorOnlineDisconnectCb: connection closed (is final).
2021-10-16T12:58:52.484Z info hostd[3BE86B70] [Originator@6876 sub=Hostsvc] Lookupvm: Cartel ID not set for VM 126
2021-10-16T12:58:52.484Z warning hostd[3BE86B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx] Unable to get resource settings for a powered on VM
2021-10-16T12:58:52.485Z info hostd[3BE86B70] [Originator@6876 sub=Hostsvc] Lookupvm: Cartel ID not set for VM 126
2021-10-16T12:58:52.499Z info hostd[3BA40B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx opID=86C5D693-00000173-c53a user=root] Failed to issue guest operation: [N3Vim5Fault20GenericVmConfigFaultE:0x38e4d558]
2021-10-16T12:58:52.499Z info hostd[3BA40B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx opID=86C5D693-00000173-c53a user=root] State Transition (VM_STATE_SHUTTING_DOWN -> VM_STATE_OFF)
2021-10-16T12:58:52.499Z info hostd[3BE45B70] [Originator@6876 sub=Guestsvc.GuestFileTransferImpl] Entered VmPowerStateListener
2021-10-16T12:58:52.499Z info hostd[3BE45B70] [Originator@6876 sub=Guestsvc.GuestFileTransferImpl] VmPowerStateListener succeeded
2021-10-16T12:58:52.499Z info hostd[3BE45B70] [Originator@6876 sub=Hbrsvc] Replicator: powerstate change VM: 126 Old: 1 New: 0
2021-10-16T12:58:52.499Z info hostd[3BE45B70] [Originator@6876 sub=Hbrsvc] Replicator: Poweroff for VM: (id=126)
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Vimsvc.ha-eventmgr opID=86C5D693-00000173-c53a user=root] Event 554652 : Netware 6 - Srv-Brdm (Stdby) cannot shut down the guest OS on ESX60 in ha-datacenter: Device 'PowerState' is not available.
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Default opID=86C5D693-00000173-c53a user=root] AdapterServer caught exception: vim.fault.GenericVmConfigFault
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Vimsvc.TaskManager opID=86C5D693-00000173-c53a user=root] Task Completed : haTask-126-vim.VirtualMachine.shutdownGuest-2693466 Status error
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000173-c53a user=root] Activation [N5Vmomi10ActivationE:0x3866ed18] : Invoke done [shutdownGuest] on [vim.VirtualMachine:126]
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000173-c53a user=root] Throw vim.fault.GenericVmConfigFault
2021-10-16T12:58:52.500Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000173-c53a user=root] Result:
--> (vim.fault.GenericVmConfigFault) {
--> faultCause = (vmodl.MethodFault) null,
--> faultMessage = (vmodl.LocalizableMessage) [
--> (vmodl.LocalizableMessage) {
--> key = "msg.vigor.deviceNotAvailable",
--> arg = (vmodl.KeyAnyValue) [
--> (vmodl.KeyAnyValue) {
--> key = "1",
--> value = "PowerState"
--> }
--> ],
--> message = "Device 'PowerState' is not available."
--> }
--> ],
--> reason = "Device 'PowerState' is not available.",
--> messageInfo = (vim.vm.Message) [
--> (vim.vm.Message) {
--> id = "msg.vigor.deviceNotAvailable",
--> argument = (anyType) [
--> "PowerState"
--> ],
--> text = "Device 'PowerState' is not available."
--> }
--> ]
--> msg = "Device 'PowerState' is not available.
--> "
--> }
2021-10-16T12:58:52.500Z error hostd[3BA40B70] [Originator@6876 sub=SoapAdapter opID=86C5D693-00000173-c53a user=root] Method vim.VirtualMachine.shutdownGuest threw undeclared fault of type vim.fault.GenericVmConfigFault
2021-10-16T12:58:52.501Z info hostd[3BE86B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx] Send config update invoked
2021-10-16T12:58:52.514Z info hostd[3BE86B70] [Originator@6876 sub=Vmsvc.vm:/vmfs/volumes/602c1658-74b3283c-5473-6805ca02df5e/Netware 6 - Srv-Brdm (Stdby)/Netware 6 - Srv-Brdm.vmx] Skip a duplicate transition to: VM_STATE_OFF
2021-10-16T12:59:19.390Z warning hostd[3BA40B70] [Originator@6876 sub=VigorStatsProvider(947940680)] AddVirtualMachine: VM '66' already registered
2021-10-16T12:59:19.390Z warning hostd[3BA40B70] [Originator@6876 sub=VigorStatsProvider(947940680)] AddVirtualMachine: VM '80' already registered
2021-10-16T12:59:19.390Z warning hostd[3BA40B70] [Originator@6876 sub=VigorStatsProvider(947940680)] AddVirtualMachine: VM '81' already registered
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000136-c47c user=root] Activation [N5Vmomi10ActivationE:0x3a511318] : Invoke done [waitForUpdates] on [vmodl.query.PropertyCollector:session[527acd7a-6230-623c-508b-e124bd07b06a]528196ed-00b7-ed49-cb16-9ff1f16c3e3d]
2021-10-16T12:59:21.912Z verbose hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000136-c47c user=root] Arg version:
--> "5"
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000136-c47c user=root] Throw vmodl.fault.RequestCanceled
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-00000136-c47c user=root] Result:
--> (vmodl.fault.RequestCanceled) {
--> faultCause = (vmodl.MethodFault) null,
--> msg = ""
--> }
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-0000018D-c562 user=root] Activation [N5Vmomi10ActivationE:0x38e9ce78] : Invoke done [waitForUpdates] on [vmodl.query.PropertyCollector:session[527acd7a-6230-623c-508b-e124bd07b06a]528196ed-00b7-ed49-cb16-9ff1f16c3e3d]
2021-10-16T12:59:21.912Z verbose hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-0000018D-c562 user=root] Arg version:
--> "5"
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-0000018D-c562 user=root] Throw vmodl.fault.RequestCanceled
2021-10-16T12:59:21.912Z info hostd[3BA40B70] [Originator@6876 sub=Solo.Vmomi opID=86C5D693-0000018D-c562 user=root] Result:
--> (vmodl.fault.RequestCanceled) {
--> faultCause = (vmodl.MethodFault) null,
--> msg = ""
--> }
[LikewiseGetDomainJoinInfo:355] QueryInformation(): ERROR_FILE_NOT_FOUND (2/0):

Any help on what is going wrong here is highly appreciated.

Regards

Karl

0 Kudos
0 Replies