Domoticz

I get these type of errors from z4d "Error: Z4D: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req 00:17:88:01:08:3c:63:e3/0x3402 0x104 0x8 payload: b'\x10\x08\x00\x00\x00' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)"

and now the controller is unable to turn on or off switches:

Spoiler: show

2024-12-22 11:34:12.047 Z4D: UpdateDevice - ( Julgran) 2:99
2024-12-22 11:34:12.082 Error: Z4D: _send_and_retry - Unexpected Exception - raw_zcl_zcl_onoff bc:33:ac:ff:fe:7a:70:6d/0xf17d 0x104 0x6 payload: b'\x11\x14\x01' AckIsDisable: False RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)

Edit: A restart fixed the issue (at least for now).

can you check what this device is : 3402 , f17d

the message simply indicates that we try to read an attribute on that device, and it failed - mostlekly because the device is not reachable or not responding

3402 is a Phillips Hue LWG004
f17d is an IKEA TRADFRI control outlet

Hello,
I'm getting similar issue since a few hours, from 3 devices:
0xa2d7 0x3d46 0x1d9c : All 3 being same "TS011F-plug" devices (so all 3 in use!) working correctly since months...

Versions:
Plugin: 7.1.018 [5.353]
Firmware: Ezsp - 6.10.3.0 build 297

Last logs grep'ed since this morning at 8h00:
Let me know if more data/logs needed...

EDIT: A few hours after a plugin restart (no devices side action), no more errors & plugs OK as usual: can be controlled again & sends measurements...

Check the serial line between the host and the zigbee controller. Strongly recommand to use a good quality USB cable.
you can also do a Power Off/On of the Coordinator

lost wrote: ↑Friday 10 January 2025 8:57 Hello,
I'm getting similar issue since a few hours, from 3 devices:
0xa2d7 0x3d46 0x1d9c : All 3 being same "TS011F-plug" devices (so all 3 in use!) working correctly since months...

Versions:
Plugin: 7.1.018 [5.353]
Firmware: Ezsp - 6.10.3.0 build 297

Last logs grep'ed since this morning at 8h00:

Code: Select all

2025-01-10 08:00:04.117  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10\x1e\x00\x05\x05\
x08\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:00:09.179  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10g\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:01:09.193  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x101\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:05:04.211  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10\x1f\x00\x05\x05\
x08\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:05:09.170  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10h\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:06:09.183  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x102\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:10:04.169  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10 \x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:10:09.165  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10i\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:11:09.195  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x103\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:15:04.139  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10!\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:15:09.190  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10j\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:16:09.085  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x104\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:20:04.159  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10"\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:20:09.435  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10k\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:21:09.170  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x105\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:24:44.134  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0x0 payload: b'\x10#\x00\x00\x00' AckI
sDisable: False RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:24:49.188  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0x0 payload: b'\x106\x00\x00\x00' AckI
sDisable: False RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:24:54.150  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x0 payload: b'\x10l\x00\x00\x00' AckI
sDisable: False RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:25:04.128  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10$\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:25:09.179  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10m\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:26:09.205  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x107\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:30:04.113  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10%\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:30:09.197  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10n\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:31:09.150  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x108\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:35:04.187  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10&\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:35:09.140  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10o\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:36:09.112  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x109\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:40:04.181  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b"\x10'\x00\x05\x05\x08
\x05\x0b\x05" AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:40:09.175  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10p\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:41:09.125  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x10:\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:45:04.114  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:6a:e7:b3:58:da/0x1d9c 0x104 0xB04 payload: b'\x10(\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:45:09.164  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\x10q\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)
2025-01-10 08:46:09.148  Error: Zi-Stick: _send_and_retry - Unexpected Exception - rawaps_read_attribute_req a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\x10;\x00\x05\x05\x08
\x05\x0b\x05' AckIsDisable: True RETRY: 1/1 (NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT)

Let me know if more data/logs needed...

EDIT: A few hours after a plugin restart (no devices side action), no more errors & plugs OK as usual: can be controlled again & sends measurements...

Do you still have this issue time to time ?

Do you have Domoticz automatic backup enabled ?

Hello,

Sorry, did not noticed your previous answer/question: IMO, cable is not the culprit there & IMO quite good in ext diameter (so, I believe, internal cables) with ferrite.

For 2nd question: No more issue since the single I had reported hereupper & Yes, Domoticz backup is enabled (not sure this can be completely disabled, saw messages about hacks in the forums but I do not use them) on my system.

Still on same 7.1.018 version for now.

Ok, keep me posted if it comes back, working on a solution. It looks like we have an issue when Domoticz backup is triggered, this get the python threads stuck and the SiliconLabs zigbee chipset doesn't like that.

Makes sense, this log was at 08:00:04.117, so when hourly backup was done... If this only happens with this exact coordinator, this may not be plugin issue: If that's a coordinator side timeout that happens when there is, unfortunately, some serial-usb exchanges on-going at hourly boundaries, must be quite rare issue.

FYI, already experienced such issues (other side stuck after some delay during data exchange, especially running Linux RT patched kernels where kernel can be preempted by applicative SW so much more often than vanilla ones) on usb linked hardware & less intrusive WA I found was using linux kernel usb reset ioctl before HW reinit. Original tip is from this LKML post I believe (C code, here):
https://marc.info/?l=linux-usb&m=121459435621262&w=2

Using this from python is quite straightforward, for instance (only 'device path' retrieval is not so common):
https://gist.github.com/PaulFurtado/fce ... 0469f34d51

I'll let you know if I experience this again. If needing some specific logs, let me know, I'll ensure they'll not be erased over time.

@lost let me know if you get this error again, I have created a special branch so the plugin restart when getting such error, and do not stay in this faulty situation