All Devices Unavailable then Available again every x hours

[mjacks (Mat Jacks)]

Hello,

I’m trying to figure out what’s going on with my ZHA.
I’m running HAOS (latest version) on Virtual Machine on my Qnap.

I have around 30 devices connected to my zigbee network through Sonoff Dongle Plus E coordinator (EZSP)

Almost every 6 hours, all my devices become unavailable and available again.
I checked the logs but i’m not a expert to read correctly. I also checked on this forum but didn’t find any answer. I don’t even know what could I share on this post to make things easier for help.

[UPDATE] : it seems to be randomly every 2 or 3 hours.
On date on that post : 12h03 / 14h24 / 16h56 / 19h41

Did anyone already get that problem ?

Mathieu

[francisp (Francis)]

There is a similar topic here:

ZHA SNZB-02P unavailable for 6 hours every 6 hours

Hello, I’m relatively new to Home Assistant and smart home in general. I’ve got 3 SNZB-02P Sonoff ZigBee Temperature & Humidity Sensor. They’ve been working fine for some weeks since installation but recently one of them has started dropping out every 6 hours and stays unavailable for about 6 hours before coming back. I’ve been searching and trying to find a solution or explanation as to why this is happening but haven’t found anything that provides a solution. I’ve recently noticed by look…

[mjacks (Mat Jacks)]

Hello. Thanks for your reply. I did see that post, but it’s not exactly the same because my devices become available straight away after being unavailable. It’s like i lost connection for few seconds.

[NathanCu (Nathan Curtis)]

I’d still watch that other thread VERY closely - the trigger condition is too similar. You may have different exhibition of the issue but the triggers smell the same the other thread has some logs to compare against. What does your log say?

[Stiltjack]

@mjacks

I did see that post, but it’s not exactly the same because my devices become available straight away after being unavailable.

Are they sensors or routers? If the former, do they actually stop working?

Six hours is the default ZHA timeout for battery powered devices. You might try increasing that - if the interval between sensors becoming unavailable also increases, the issue may have something to do with devices not checking in often enough. Or the problem may even go away!

[mjacks (Mat Jacks)]

Literally all the devices become unavailable : sensors (battery powered), routers (like plug/siren/switch - continuously powered). I checked again today, I lost connection at 4:56pm then 7:41pm. It’s less than 6 hours then.

Here is the log for 4:56pm

2024-03-09 16:55:56.731 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame received getValue: [<EzspStatus.SUCCESS: 0>, b'\xf9']
2024-03-09 16:55:56.734 DEBUG (MainThread) [bellows.zigbee.application] Free buffers status EzspStatus.SUCCESS, value: 249
2024-03-09 16:55:56.735 DEBUG (MainThread) [bellows.zigbee.application] ezsp_counters: [MAC_RX_BROADCAST = 2901, MAC_TX_BROADCAST = 640, MAC_RX_UNICAST = 3911, MAC_TX_UNICAST_SUCCESS = 1494, MAC_TX_UNICAST_RETRY = 149, MAC_TX_UNICAST_FAILED = 31, APS_DATA_RX_BROADCAST = 2, APS_DATA_TX_BROADCAST = 2, APS_DATA_RX_UNICAST = 2636, APS_DATA_TX_UNICAST_SUCCESS = 1226, APS_DATA_TX_UNICAST_RETRY = 38, APS_DATA_TX_UNICAST_FAILED = 13, ROUTE_DISCOVERY_INITIATED = 24, NEIGHBOR_ADDED = 6, NEIGHBOR_REMOVED = 0, NEIGHBOR_STALE = 25, JOIN_INDICATION = 0, CHILD_REMOVED = 0, ASH_OVERFLOW_ERROR = 0, ASH_FRAMING_ERROR = 0, ASH_OVERRUN_ERROR = 0, NWK_FRAME_COUNTER_FAILURE = 0, APS_FRAME_COUNTER_FAILURE = 0, UTILITY = 0, APS_LINK_KEY_NOT_AUTHORIZED = 0, NWK_DECRYPTION_FAILURE = 0, APS_DECRYPTION_FAILURE = 0, ALLOCATE_PACKET_BUFFER_FAILURE = 0, RELAYED_UNICAST = 0, PHY_TO_MAC_QUEUE_LIMIT_REACHED = 0, PACKET_VALIDATE_LIBRARY_DROPPED_COUNT = 0, TYPE_NWK_RETRY_OVERFLOW = 0, PHY_CCA_FAIL_COUNT = 0, BROADCAST_TABLE_FULL = 0, PTA_LO_PRI_REQUESTED = 0, PTA_HI_PRI_REQUESTED = 0, PTA_LO_PRI_DENIED = 0, PTA_HI_PRI_DENIED = 0, PTA_LO_PRI_TX_ABORTED = 0, PTA_HI_PRI_TX_ABORTED = 0, ADDRESS_CONFLICT_SENT = 0, EZSP_FREE_BUFFERS = 249]
2024-03-09 16:56:23.358 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5541b1a9112a15b658964e24ab5592499cdf531210db9874f5de1583fc7e16e2ecd4e17e'
2024-03-09 16:56:23.359 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2024-03-09 16:56:23.369 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5d41b1a9112a15b658964e24ab5592499cdf531210db9874f5de1583fc7e16e2ecfa857e'
2024-03-09 16:56:23.369 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2024-03-09 16:56:23.370 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5d41b1a9112a15b658964e24ab5592499cdf531210db9874f5de1583fc7e16e2ecfa857e'
2024-03-09 16:56:23.370 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2024-03-09 16:56:23.370 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5d41b1a9112a15b658964e24ab5592499cdf531210db9874f5de1583fc7e16e2ecfa857e'
2024-03-09 16:56:23.371 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2024-03-09 16:56:23.380 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'6541b1a9112a15b658904124ab5593499c81431e26679874f5de8483f37b1ec7e255667e'
2024-03-09 16:56:23.381 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2024-03-09 16:56:23.383 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.384 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'7541b1a9112a15b658904124ab5593499c9e7f1926679874f5de6383f37b1ecde2a2bd7e'
2024-03-09 16:56:23.384 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2024-03-09 16:56:23.392 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.392 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.392 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.393 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.393 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.398 DEBUG (bellows.thread_0) [bellows.uart] Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
2024-03-09 16:56:23.420 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame received incomingMessageHandler: [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=1026, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_NONE: 0>, groupId=0, sequence=145), 116, -71, 0x15fd, 255, 255, b'\x18v\n\x00\x00)E\x07']
2024-03-09 16:56:23.420 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=1026, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_NONE: 0>, groupId=0, sequence=145), 116, -71, 0x15fd, 255, 255, b'\x18v\n\x00\x00)E\x07']
2024-03-09 16:56:23.421 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 3, 9, 15, 56, 23, 421413, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x15FD), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=145, profile_id=260, cluster_id=1026, data=Serialized[b'\x18v\n\x00\x00)E\x07'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=116, rssi=-71)
2024-03-09 16:56:23.423 DEBUG (MainThread) [zigpy.zcl] [0x15FD:1:0x0402] Received ZCL frame: b'\x18v\n\x00\x00)E\x07'
2024-03-09 16:56:23.424 DEBUG (MainThread) [zigpy.zcl] [0x15FD:1:0x0402] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=118, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2024-03-09 16:56:23.426 DEBUG (MainThread) [zigpy.zcl] [0x15FD:1:0x0402] Decoded ZCL frame: TemperatureMeasurementCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=1861))])
2024-03-09 16:56:23.426 DEBUG (MainThread) [zigpy.zcl] [0x15FD:1:0x0402] Received command 0x0A (TSN 118): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=1861))])
2024-03-09 16:56:23.427 DEBUG (MainThread) [zigpy.zcl] [0x15FD:1:0x0402] Attribute report received: measured_value=1861
2024-03-09 16:56:23.428 DEBUG (MainThread) [homeassistant.components.zha.core.cluster_handlers] [0x15FD:1:0x0402]: cluster_handler[temperature] attribute_updated - cluster[Temperature Measurement] attr[measured_value] value[1861]
2024-03-09 16:56:23.430 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame received incomingMessageHandler: [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=2820, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY: 256>, groupId=0, sequence=207), 100, -75, 0xa9cb, 255, 255, b'\x18\xe7\n\x0f\x05!`\t']
2024-03-09 16:56:23.430 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=2820, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY: 256>, groupId=0, sequence=207), 100, -75, 0xa9cb, 255, 255, b'\x18\xe7\n\x0f\x05!`\t']
2024-03-09 16:56:23.431 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 3, 9, 15, 56, 23, 431404, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xA9CB), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=207, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xe7\n\x0f\x05!`\t'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=100, rssi=-75)
2024-03-09 16:56:23.433 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Received ZCL frame: b'\x18\xe7\n\x0f\x05!`\t'
2024-03-09 16:56:23.435 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=231, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2024-03-09 16:56:23.437 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Report_Attributes(attribute_reports=[Attribute(attrid=0x050F, value=TypeValue(type=uint16_t, value=2400))])
2024-03-09 16:56:23.438 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Received command 0x0A (TSN 231): Report_Attributes(attribute_reports=[Attribute(attrid=0x050F, value=TypeValue(type=uint16_t, value=2400))])
2024-03-09 16:56:23.439 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Attribute report received: apparent_power=2400
2024-03-09 16:56:23.453 DEBUG (MainThread) [homeassistant.components.zha.core.cluster_handlers] [0xA9CB:1:0x0b04]: cluster_handler[electrical_measurement] attribute_updated - cluster[Electrical Measurement] attr[apparent_power] value[2400]
2024-03-09 16:56:23.457 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.457 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.458 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.468 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.469 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame received incomingMessageHandler: [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=2820, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY: 256>, groupId=0, sequence=208), 88, -78, 0xa9cb, 255, 255, b'\x18\x00\n\x0f\x05!j\t']
2024-03-09 16:56:23.469 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=2820, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY: 256>, groupId=0, sequence=208), 88, -78, 0xa9cb, 255, 255, b'\x18\x00\n\x0f\x05!j\t']
2024-03-09 16:56:23.470 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 3, 9, 15, 56, 23, 470249, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xA9CB), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=208, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\x00\n\x0f\x05!j\t'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=88, rssi=-78)
2024-03-09 16:56:23.471 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Received ZCL frame: b'\x18\x00\n\x0f\x05!j\t'
2024-03-09 16:56:23.476 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2024-03-09 16:56:23.478 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Report_Attributes(attribute_reports=[Attribute(attrid=0x050F, value=TypeValue(type=uint16_t, value=2410))])
2024-03-09 16:56:23.479 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x050F, value=TypeValue(type=uint16_t, value=2410))])
2024-03-09 16:56:23.479 DEBUG (MainThread) [zigpy.zcl] [0xA9CB:1:0x0b04] Attribute report received: apparent_power=2410
2024-03-09 16:56:23.480 DEBUG (MainThread) [homeassistant.components.zha.core.cluster_handlers] [0xA9CB:1:0x0b04]: cluster_handler[electrical_measurement] attribute_updated - cluster[Electrical Measurement] attr[apparent_power] value[2410]
2024-03-09 16:56:23.484 DEBUG (bellows.thread_0) [bellows.uart] Connection lost: None
2024-03-09 16:56:23.484 DEBUG (bellows.thread_0) [bellows.uart] Closed serial connection
2024-03-09 16:56:23.545 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.545 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.546 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.546 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.546 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.546 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.546 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.547 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.547 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.547 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.547 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.548 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.548 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.548 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.549 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.549 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.549 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.550 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.550 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.550 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.550 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.550 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.551 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.551 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.551 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.551 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-03-09 16:56:23.551 DEBUG (MainThread) [bellows.zigbee.application] Received _reset_controller_application frame with (<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>,)
2024-03-09 16:56:23.552 DEBUG (MainThread) [zigpy.application] Connection to the radio has been lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.552 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Connection to the radio was lost: <NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>
2024-03-09 16:56:23.552 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Ignoring reset, one is already running
2024-03-09 16:56:23.559 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x6857](Plug 01): last_seen is 4043085.28486681 seconds ago and ping attempts have been exhausted, marking the device unavailable
2024-03-09 16:56:23.559 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x6857](Plug 01): Update device availability -  device available: False - new availability: False - changed: False
2024-03-09 16:56:23.560 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x4340](01MINIZB): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.560 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x4340](01MINIZB): Update device availability -  device available: True - new availability: True - changed: False
2024-03-09 16:56:23.561 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x9153](FYRTUR block-out roller blind): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.561 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x9153](FYRTUR block-out roller blind): Update device availability -  device available: True - new availability: True - changed: False
2024-03-09 16:56:23.608 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA9CB](ZLinky_TIC): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.609 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA9CB](ZLinky_TIC): Update device availability -  device available: True - new availability: True - changed: False
2024-03-09 16:56:23.668 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xAD7B](lumi.sensor_wleak.aq1): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.669 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xAD7B](lumi.sensor_wleak.aq1): Update device availability -  device available: True - new availability: True - changed: False
2024-03-09 16:56:23.670 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x4274](lumi.vibration.aq1): last_seen is 4074561.704456806 seconds ago and ping attempts have been exhausted, marking the device unavailable
2024-03-09 16:56:23.670 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x4274](lumi.vibration.aq1): Update device availability -  device available: False - new availability: False - changed: False
2024-03-09 16:56:23.675 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x2F8D](lumi.vibration.aq1): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.675 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x2F8D](lumi.vibration.aq1): Update device availability -  device available: True - new availability: True - changed: False
2024-03-09 16:56:23.676 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x335B](lumi.sensor_magnet.aq2): Device seen - marking the device available and resetting counter
2024-03-09 16:56:23.677 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x335B](lumi.sensor_magnet.aq2): Update device availability -  device available: True - new availability: True - changed: False

[Stiltjack]

Does anything else in the house happen every 2-3 hours? Someone posted recently that their smart electricity meter was putting out a lot of interference…

[ShadowFist]

@mjacks

NCP entered failed state

Try googling that. You’ll get some pointers (some of which are unrelated because you’re not using a sonoff wifi to zigbee bridge). The ones that stand out is the database size not exceeding 300mb and a failing sd card. I’d start from there, then enable debug logging as the next step.

[mjacks (Mat Jacks)]

Thanks. I’m moving forward on your replies and will continue to post here

[Marabon]

I’ve added a reply to my thread, but thought I’d also check here in case they’re similar.
Does your devices function properly while they’re available?
My device which is experiencing issues has the same value (temperature) stuck until it goes offline for 6 hours and then has a new value when it comes back, but doesn’t update at all while available.

[mjacks (Mat Jacks)]

Hello @Marabon ,

As far as I know, my devices operate properly when they’re available.
Since I change radio channel on my Sonoff, problem occurs 1 or 2 times a day. I’m still looking where is the problem. Always getting this NCP entered failed state and quick reboot of all my devices.

Mathieu

[pipiche (Patrick)]

similar issue reported here raise ControllerError("ApplicationController is not running") · zigpy/zigpy · Discussion #1378 · GitHub