ZigBee / ZHA - error/situation

nickulaie · July 5, 2023, 12:44pm

Dear users,

I’m calling you because I’m facing a painful problem.
I use a windows computer and HA runs on a virtual machine, and as a ZigBee stick I use the Sonoff Zigbee 3.0 Dongle Plus.
3 days ago there was a power outage in my area with voltage fluctuations and all my logical devices were left without voltage. The whole operation lasted about 2 hours until the power came back. The computer + the network is connected to the battery with voltage stabilizer (all this time it worked without HA problems).
As added ZigBee devices I have:
Ikea outlet
Ikea bulb
Hue remote control
Sonoff remote control
Aqara switch without neutral
Aqara contact sensor
Lidl contact sensor
Aqara contact sensor
Lidl contact sensor
Sonoff ZigBee mini

After the voltage came back, my whole network was dead, I left it for about 1 hour, and I had to unplug all the ikea sockets, and they came back, slowly all the contacts came back, Aqara works OK, the only problem is with Sonoff Zigbee Mini that I use in the sockets from the switches and that are not reconnected + 1 Ikea outlet.

At home I still have a Hubitat Elevation, I took it and tried to connect the Ikea outlet, and it connected instantly, when I tried to connect the outlet, a Sonof appeared and it connected instantly and works perfectly… I deleted it , reset the devices from Hubitat and tried to connect them to HA, no chance, they don’t appear at all…some sonoff appear but disapear and appear again…mess
so, my guess is that there is something suspicious with my Sonoff Zigbee 3.0 Dongle Plus.

I roll back the HA a few days, before the voltage problem, same situation with my sonoff

Could anybody support me with this frustrating problem? I have 12 sonoff zigbee mini… in and around my house.

BR,
Nicu

FriedCheese · July 5, 2023, 1:52pm

I think I would start by unplugging the coordinator dongle for around half an hour. Chances are, your routing table is not healthy from the outage. Ideally, this will force the end devices to clear they’re routing tables and update them again once the coordinator is plugged back in.

nickulaie · July 5, 2023, 3:49pm

Hi,

Thanks for answer, after unplugged for 45m, unplugged all sonoff device, now I plugged 1 sonoff, is discoverer, working for 2 sec, the light is turned on, but after 2-3 sec is become unavailable , start the pairing mode, find again, and…same…

Nick

nickrout · July 5, 2023, 8:27pm

Try re-flashing the dongle firmware.

nickulaie · July 6, 2023, 5:53am

in this case I won’t lose the whole network? will I have to add all the devices manually?

dbs · July 6, 2023, 9:15am

IT does sound like something in the network routing got messed up. That would explain why a new router (the Hubitat) worked better.

If the devices will find new routes, then it should sort it self out over time. I do not know how long, though.

What I would try would be shutting everything down – HA and all the devices – then starting up HA and then the devices, and giving them some time to try and find a good network routing. I don’t know if that is 1 or 24 hours, though, or even if they will do it.

You can also try adding some more devices to the network to act as intermediate routers to build a stronger network, if routing is the problem.

But it does sound like an infuriating situation and I don’t have much concrete advice.
-David

nickulaie · July 6, 2023, 10:46am

dear David,

I will try also this, shoot down everything, also my HA, start HA, and after that, unplug all my Zigbee devices and I will come back with the answer.

thx,
nick

nickulaie · July 6, 2023, 12:16pm

and the log

Logger: homeassistant.components.zha.core.cluster_handlers
Source: components/zha/core/cluster_handlers/init.py:480
Integration: Zigbee Home Automation (documentation, issues)
First occurred: July 5, 2023 at 10:54:09 PM (46 occurrences)
Last logged: 2:52:53 PM

[0xECAB:1:0x0006]: async_initialize: all attempts have failed: [DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’)]
[0xA68F:1:0x0006]: async_initialize: all attempts have failed: [DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’)]
[0x0A96:1:0x0001]: async_initialize: all attempts have failed: [TimeoutError(), TimeoutError(), TimeoutError(), TimeoutError()]
[0x0A96:1:0x0500]: async_initialize: all attempts have failed: [TimeoutError(), TimeoutError(), TimeoutError(), TimeoutError()]
[0x7D19:1:0x0006]: async_initialize: all attempts have failed: [TimeoutError(), TimeoutError(), TimeoutError(), TimeoutError()]

FriedCheese · July 6, 2023, 12:36pm

You said some devices are good, right? I would find a repeater device that is working and try forcing the Ikea outlet to pair through it. If I’m not mistaken, that option for ZHA is on the device page. You may even want to fully delete the outlet from HA before trying to pairing, if you haven’t already.

One of your errors looks like the dongle thinks it has a route to device, but isn’t able to communicate with that device. The second one looks like the dongle has no route to the device (should see a similar error if the device is powered down).

nickulaie · July 6, 2023, 4:12pm

shut down the windows with HA, close all my enegy, waiting 30m, and power up…same error.
ogger: homeassistant.components.zha.core.cluster_handlers
Source: components/zha/core/cluster_handlers/init.py:480
Integration: Zigbee Home Automation (documentation, issues)
First occurred: 7:08:51 PM (21 occurrences)
Last logged: 7:09:47 PM

[0xBAD3:1:0x0006]: async_initialize: all attempts have failed: [DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’)]
[0xBAD3:1:0x0008]: async_initialize: all attempts have failed: [DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>’)]
[0x51C6:1:0x0008]: async_initialize: all attempts have failed: [TimeoutError(), TimeoutError(), TimeoutError(), TimeoutError()]
[0x48F5:1:0x0006]: async_initialize: all attempts have failed: [DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’), DeliveryError(‘Request failed after 5 attempts: <Status.NWK_NO_ROUTE: 205>’)]
[0x2BF7:1:0x1000]: Couldn’t get list of groups:

find 1 device but is not working,and 2 device remain on this stage:

remain with interview…

nickulaie · July 6, 2023, 4:15pm

I tray to connect via Ikea outlet, i have 8-10 for extend my ZigBee network, and is finding 1 device, but remain on Interne stage
part of the log - when is searching

x0b04] Received ZCL frame: b’\x18<\n\x08\x05!X\x01’
[0x59D9:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=60, command_id=10, *direction=<Direction.Client_to_Server: 1>)
[0x59D9:1:0x0b04] Decoded ZCL frame: TuyaZBElectricalMeasurement:Report_Attributes(attribute_reports=[Attribute(attrid=0x0508, value=TypeValue(type=uint16_t, value=344))])
[0x59D9:1:0x0b04] Received command 0x0A (TSN 60): Report_Attributes(attribute_reports=[Attribute(attrid=0x0508, value=TypeValue(type=uint16_t, value=344))])
[0x59D9:1:0x0b04] Attribute report received: rms_current=344
0x9B19: Device seen - marking the device available and resetting counter
0x9B19: Update device availability - device available: True - new availability: True - changed: False
[0x59D9:1:0x0702]: async_force_update
[0x59D9:1:0x0702]: Reading attributes in chunks: [‘current_summ_delivered’, ‘status’]
[0x59D9:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=25, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x59D9:1:0x0702] Sending request: Read_Attributes(attribute_ids=[0, 512])
[0x766B:1:0x0702]: async_force_update
[0x766B:1:0x0702]: Reading attributes in chunks: [‘current_summ_delivered’, ‘status’]
[0x766B:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=26, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x766B:1:0x0702] Sending request: Read_Attributes(attribute_ids=[0, 512])
[0x59D9:1:0x0b04]: async_update
[0x59D9:1:0x0b04]: Reading attributes in chunks: [‘active_power’, ‘rms_current’, ‘rms_voltage’]
[0x59D9:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=27, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x59D9:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291, 1288, 1285])
[0x766B:1:0x0b04]: async_update
[0x766B:1:0x0b04]: Reading attributes in chunks: [‘active_power’, ‘rms_current’, ‘rms_voltage’]
[0x766B:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=28, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x766B:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291, 1288, 1285])
[0x5472:1:0x0b04]: async_update
[0x5472:1:0x0b04]: Reading attributes in chunks: [‘active_power’, ‘rms_current’, ‘rms_voltage’]
[0x5472:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=29, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x5472:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291, 1288, 1285])
Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x59D9), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=1794, data=Serialized[b’\x18\x19\x01\x00\x00\x00%\x1c)\x00\x00\x00\x00\x00\x02\x00\x18\x00’], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=98, rssi=None)
[0x59D9:1:0x0702] Received ZCL frame: b’\x18\x19\x01\x00\x00\x00%\x1c)\x00\x00\x00\x00\x00\x02\x00\x18\x00’
[0x59D9:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=25, command_id=1, *direction=<Direction.Client_to_Server: 1>)
[0x59D9:1:0x0702] Decoded ZCL frame: TuyaZBMeteringCluster:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=<Status.SUCCESS: 0>, value=TypeValue(type=uint48_t, value=10524)), ReadAttributeRecord(attrid=0x0200, status=<Status.SUCCESS: 0>, value=TypeValue(type=bitmap8, value=<bitmap8: 0>))])
[0x5472:1:0x0702]: async_force_update
[0x5472:1:0x0702]: Reading attributes in chunks: [‘current_summ_delivered’, ‘status’]
[0x5472:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=30, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>)
[0x5472:1:0x0702] Sending request: Read_Attributes(attribute_ids=[0, 512])
Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x59D9), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=2820, data=Serialized[b’\x18\x1b\x01\x0b\x05\x00)G\x00\x08\x05\x00!Y\x01\x05\x05\x00!\xda\x00’], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=105, rssi=None)
[0x59D9:1:0x0b04] Received ZCL frame: b’\x18\x1b\x01\x0b\x05\x00)G\x00\x08\x05\x00!Y\x01\x05\x05\x00!\xda\x00’
[0x59D9:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=27, command_id=1, *direction=<Direction.Client_to_Server: 1>)
[0x59D9:1:0x0b04] Decoded ZCL frame: TuyaZBElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x050B, status=<Status.SUCCESS: 0>, value=TypeValue(type=int16s, value=71)), ReadAttributeRecord(attrid=0x0508, status=<Status.SUCCESS: 0>, value=TypeValue(type=uint16_t, value=345)), ReadAttributeRecord(attrid=0x0505, status=<Status.SUCCESS: 0>, value=TypeValue(type=uint16_t, value=218))])
0x6F87: Device seen - marking the device available and resetting counter
0x6F87: Update device availability - device available: True - new availability: True - changed: False
[0x880F](TRADFRI Signal Repeater): Device seen - marking the device available and resetting counter
[0x880F](TRADFRI Signal Repeater): Update device availability - device available: True - new availability: True - changed: False
[0x766B:1:0x0702]: failed to get attributes ‘[‘current_summ_delivered’, ‘status’]’ on ‘smartenergy_metering’ cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
[0x766B:1:0x0b04]: failed to get attributes ‘[‘active_power’, ‘rms_current’, ‘rms_voltage’]’ on ‘electrical_measurement’ cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
[0x5472:1:0x0b04]: failed to get attributes ‘[‘active_power’, ‘rms_current’, ‘rms_voltage’]’ on ‘electrical_measurement’ cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
[0x5472:1:0x0702]: failed to get attributes ‘[‘current_summ_delivered’, ‘status’]’ on ‘smartenergy_metering’ cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
0xD1A2: Device seen - marking the device available and resetting counter
0xD1A2: Update device availability - device available: True - new availability: True - changed: False

nickulaie · July 6, 2023, 5:56pm

Regarding the subject, how I wrote, 1 Ikea outlet I deleted from HA and cannot add to HA but in Hubitat is working well.

Today I buy another new Ikea outlet and instantly added to the HA, then I try with initial outlet, removed from Hubitat and is not finding in HA…strange…I’m pretty sure in my dongle remain something that is not allow to connect, same with sonoff.

How I could find and delete…maybe is in HA some old setup…

Thx for answer…

If I add new firmware I will lose my network?

BR,
Nick