Tuya TS0601_dimmer_2 switches that dont exist.

[bronzeblood]

Having issues with this https://www.zigbee2mqtt.io/devices/TS0601_dimmer_2.html

When i toggle a switch on or off from either z2m or hass nothing happens, its because the wrong state is being changed.

In the states it shows extra states with _l1 or _l2 added to the end, these are being toggled which is wrong because if i manually turn the switch on the state without the extra _l1 or _l2 is toggled.

Incorrect states highlighted.

[Koenkk]

• Is this with z2m 1.40.2?
• could you provide the debug log when the state is updated?

See this on how to enable debug logging.

[bronzeblood]

Yes its the current 1.40.2
Debug log attached, switch is called "Lounge Lights"

Toggled first with physical switches, then from the Z2M dashboard.

2024-10-26 101137 info z2m Loggi.txt

[Koenkk]

Pushed a fix!

Changes will be available in the dev branch in a few hours from now.

[bronzeblood]

Thank you, do you have link to the change? I'm interested in the code. Thanks again , ill test the fix next chance i get.

[bronzeblood]

OK i have tried the fix, the correct states now get updated and i can turn the light on and off and dim them with the physical button and the states get updated in z2m , but changing anything with z2m or hassio doesn't result in the switch doing anything, however the states do change. Its like the switch is ignoring the commands.

Any ideas? the switch did work for a few days properly when i first set it up. I have tried deleting config, reinstalling z2m and repairing but same issue.

[bronzeblood]

OK i enabled debugging and got this...

[2024-10-28 14:22:14] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=43 Len=31] [2024-10-28 14:22:14] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=1](ackRx=3) [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4) [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=1](frmRx=1) Added to rxQueue [2024-10-28 14:22:14] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=4) [2024-10-28 14:22:14] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=43 Len=7] [2024-10-28 14:22:14] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=43 messageTag=6 status=OK] [2024-10-28 14:22:14] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Lounge Light', payload '{"backlight_mode":"normal","brightness_l1":24,"brightness_l2":98,"color_mode":"xy","countdown_l1":0,"countdown_l2":0,"linkquality":160,"max_brightness_l1":254,"max_brightness_l2":254,"min_brightness_l1":10,"min_brightness_l2":10,"power_on_behavior":"previous","state_l1":"ON","state_l2":"ON"}' [2024-10-28 14:22:14] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Lounge Light/l1', payload '{"brightness":24,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-28 14:22:14] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Lounge Light/l2', payload '{"brightness":98,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4) [2024-10-28 14:22:14] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=2](frmRx=2) Added to rxQueue [2024-10-28 14:22:14] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=4) [2024-10-28 14:22:14] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=43 Len=22] [2024-10-28 14:22:14] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=ZIGBEE_DELIVERY_FAILED], [type=DIRECT], [indexOrDestination=5159], [apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":41}], [messageTag=4] [2024-10-28 14:22:14] debug: zh:ember: ~x~> DELIVERY_FAILED [indexOrDestination=5159 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":41} messageTag=4] [2024-10-28 14:22:15] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-28 14:22:15] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4) [2024-10-28 14:22:15] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3](frmRx=3) Added to rxQueue [2024-10-28 14:22:15] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=4) [2024-10-28 14:22:15] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=43 Len=22] [2024-10-28 14:22:15] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=ZIGBEE_DELIVERY_FAILED], [type=DIRECT], [indexOrDestination=5159], [apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":42}], [messageTag=5] [2024-10-28 14:22:15] debug: zh:ember: ~x~> DELIVERY_FAILED [indexOrDestination=5159 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":42} messageTag=5] [2024-10-28 14:22:16] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-28 14:22:16] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4) [2024-10-28 14:22:16] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=4](frmRx=4) Added to rxQueue [2024-10-28 14:22:16] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=4) [2024-10-28 14:22:16] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=43 Len=22] [2024-10-28 14:22:16] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=ZIGBEE_DELIVERY_FAILED], [type=DIRECT], [indexOrDestination=5159], [apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":43}], [messageTag=6] [2024-10-28 14:22:16] debug: zh:ember: ~x~> DELIVERY_FAILED [indexOrDestination=5159 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":43} messageTag=6]

Looks like the message fails to deliver, any ideas why?

[Koenkk]

Can you try to re-pair the device?

[bronzeblood]

If i remove the device and re-pair then immediately issue a command via the exposes tab i can control it for for maybe 2-3 seconds then it stops responding.

[bronzeblood]

Heres a log of re-pairing the device and toggling switches until the message delivery fails. About 3 seconds....

[2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5) [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=3](frmRx=3) Added to rxQueue [2024-10-29 20:49:44] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=5) [2024-10-29 20:49:44] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=76 Len=91] [2024-10-29 20:49:44] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":172}], [packetInfo:{"senderShortId":549,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":200,"lastHopRssi":-50,"lastHopTimestamp":0}], [messageContents=08750adfff423c96fdb32e1397fdb32e6597fdb32e12aefdb32e695cfeb32e135dfeb32e655dfeb32e1220ffb32e6920ffb32e6921ffb32e6921ffb32e6922ffb32e69] [2024-10-29 20:49:44] debug: zh:controller: Received payload: clusterID=0, address=549, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=200, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":117,"commandIdentifier":10},"payload":[{"attrId":65503,"dataType":66,"attrData":"���.\u0013���.e���.\u0012���.i\\��.\u0013]��.e]��.\u0012 ��.i ��.i!��.i!��.i\"��.i"}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}} [2024-10-29 20:49:44] debug: zh:controller:endpoint: ZCL command 0xa4c13884bffd52f1/1 genBasic.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":117,"writeUndiv":false}) [2024-10-29 20:49:44] debug: zh:ember: ~~~> [ZCL to=0xa4c13884bffd52f1:549 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":117,"commandIdentifier":11}] [2024-10-29 20:49:44] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=77 Len=26] [2024-10-29 20:49:44] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=4](ackRx=5) [2024-10-29 20:49:44] debug: z2m: Received Zigbee message from '0xa4c13884bffd52f1', type 'attributeReport', cluster 'genBasic', data '{"65503":"���.\u0013���.e���.\u0012���.i\\��.\u0013]��.e]��.\u0012 ��.i ��.i!��.i!��.i\"��.i"}' from endpoint 1 with groupID 0 [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6) [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=4](frmRx=4) Added to rxQueue [2024-10-29 20:49:44] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=6) [2024-10-29 20:49:44] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=77 Len=7] [2024-10-29 20:49:44] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=146 messageTag=32 status=OK] [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6) [2024-10-29 20:49:44] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=5](frmRx=5) Added to rxQueue [2024-10-29 20:49:44] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=6) [2024-10-29 20:49:44] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=77 Len=22] [2024-10-29 20:49:44] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=549], [apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":146}], [messageTag=32] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6) [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=6](frmRx=6) Added to rxQueue [2024-10-29 20:49:45] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=6) [2024-10-29 20:49:45] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=77 Len=61] [2024-10-29 20:49:45] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":173}], [packetInfo:{"senderShortId":549,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":196,"lastHopRssi":-51,"lastHopTimestamp":0}], [messageContents=08760adfff421e24ffb32e6624ffb32e123effb32e69d306b42e13d406b42e65d406b42e12] [2024-10-29 20:49:45] debug: zh:controller: Received payload: clusterID=0, address=549, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=196, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":118,"commandIdentifier":10},"payload":[{"attrId":65503,"dataType":66,"attrData":"$��.f$��.\u0012>��.i�\u0006�.\u0013�\u0006�.e�\u0006�.\u0012"}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}} [2024-10-29 20:49:45] debug: zh:controller:endpoint: ZCL command 0xa4c13884bffd52f1/1 genBasic.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":118,"writeUndiv":false}) [2024-10-29 20:49:45] debug: zh:ember: ~~~> [ZCL to=0xa4c13884bffd52f1:549 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":118,"commandIdentifier":11}] [2024-10-29 20:49:45] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=78 Len=26] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=7](ackRx=6) [2024-10-29 20:49:45] debug: z2m: Received Zigbee message from '0xa4c13884bffd52f1', type 'attributeReport', cluster 'genBasic', data '{"65503":"$��.f$��.\u0012>��.i�\u0006�.\u0013�\u0006�.e�\u0006�.\u0012"}' from endpoint 1 with groupID 0 [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=6 frmTx=7) [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=7](frmRx=7) Added to rxQueue [2024-10-29 20:49:45] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=7) [2024-10-29 20:49:45] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=78 Len=7] [2024-10-29 20:49:45] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=147 messageTag=33 status=OK] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7) [2024-10-29 20:49:45] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=0](frmRx=0) Added to rxQueue [2024-10-29 20:49:45] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=7) [2024-10-29 20:49:45] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=78 Len=22] [2024-10-29 20:49:45] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=549], [apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":147}], [messageTag=33] [2024-10-29 20:49:46] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/0xa4c13884bffd52f1/set' with data '{"state_l1":"ON"}' [2024-10-29 20:49:46] debug: z2m: Publishing 'set' 'state' to '0xa4c13884bffd52f1' [2024-10-29 20:49:46] debug: zh:controller:endpoint: ZCL command 0xa4c13884bffd52f1/1 manuSpecificTuya.dataRequest({"seq":1,"dpValues":[{"dp":1,"datatype":1,"data":[1]}]}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false}) [2024-10-29 20:49:46] debug: zh:ember: ~~~> [ZCL to=0xa4c13884bffd52f1:549 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":12,"commandIdentifier":0}] [2024-10-29 20:49:46] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=79 Len=31] [2024-10-29 20:49:46] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=1](ackRx=7) [2024-10-29 20:49:46] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:46] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=7 frmTx=0) [2024-10-29 20:49:46] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=1](frmRx=1) Added to rxQueue [2024-10-29 20:49:46] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=0) [2024-10-29 20:49:46] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=79 Len=7] [2024-10-29 20:49:46] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=148 messageTag=34 status=OK] [2024-10-29 20:49:46] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1', payload '{"backlight_mode":"normal","brightness_l1":173,"brightness_l2":69,"countdown_l1":0,"countdown_l2":0,"linkquality":196,"max_brightness_l1":254,"max_brightness_l2":254,"min_brightness_l1":10,"min_brightness_l2":10,"power_on_behavior":"previous","state_l1":"ON","state_l2":"OFF"}' [2024-10-29 20:49:46] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l1', payload '{"brightness":173,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-29 20:49:46] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l2', payload '{"brightness":69,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"OFF"}' [2024-10-29 20:49:47] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/0xa4c13884bffd52f1/set' with data '{"state_l2":"ON"}' [2024-10-29 20:49:47] debug: z2m: Publishing 'set' 'state' to '0xa4c13884bffd52f1' [2024-10-29 20:49:47] debug: zh:controller:endpoint: ZCL command 0xa4c13884bffd52f1/1 manuSpecificTuya.dataRequest({"seq":1,"dpValues":[{"dp":7,"datatype":1,"data":[1]}]}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false}) [2024-10-29 20:49:47] debug: zh:ember: ~~~> [ZCL to=0xa4c13884bffd52f1:549 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":13,"commandIdentifier":0}] [2024-10-29 20:49:47] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=80 Len=31] [2024-10-29 20:49:47] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=2](ackRx=0) [2024-10-29 20:49:47] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:49:47] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=0 frmTx=1) [2024-10-29 20:49:47] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=2](frmRx=2) Added to rxQueue [2024-10-29 20:49:47] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=1) [2024-10-29 20:49:47] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=80 Len=7] [2024-10-29 20:49:47] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=149 messageTag=35 status=OK] [2024-10-29 20:49:47] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1', payload '{"backlight_mode":"normal","brightness_l1":173,"brightness_l2":69,"countdown_l1":0,"countdown_l2":0,"linkquality":196,"max_brightness_l1":254,"max_brightness_l2":254,"min_brightness_l1":10,"min_brightness_l2":10,"power_on_behavior":"previous","state_l1":"ON","state_l2":"ON"}' [2024-10-29 20:49:47] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l1', payload '{"brightness":173,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-29 20:49:47] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l2', payload '{"brightness":69,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-29 20:51:09] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/0xa4c13884bffd52f1/set' with data '{"state_l1":"OFF"}' [2024-10-29 20:51:09] debug: z2m: Publishing 'set' 'state' to '0xa4c13884bffd52f1' [2024-10-29 20:51:09] debug: zh:controller:endpoint: ZCL command 0xa4c13884bffd52f1/1 manuSpecificTuya.dataRequest({"seq":1,"dpValues":[{"dp":1,"datatype":1,"data":[0]}]}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false}) [2024-10-29 20:51:09] debug: zh:ember: ~~~> [ZCL to=0xa4c13884bffd52f1:549 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":14,"commandIdentifier":0}] [2024-10-29 20:51:09] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=81 Len=31] [2024-10-29 20:51:09] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=5](ackRx=1) [2024-10-29 20:51:09] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:51:09] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=1 frmTx=2) [2024-10-29 20:51:09] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=5](frmRx=5) Added to rxQueue [2024-10-29 20:51:09] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=2) [2024-10-29 20:51:09] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=81 Len=7] [2024-10-29 20:51:09] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=150 messageTag=36 status=OK] [2024-10-29 20:51:09] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1', payload '{"backlight_mode":"normal","brightness_l1":173,"brightness_l2":69,"countdown_l1":0,"countdown_l2":0,"linkquality":196,"max_brightness_l1":254,"max_brightness_l2":254,"min_brightness_l1":10,"min_brightness_l2":10,"power_on_behavior":"previous","state_l1":"OFF","state_l2":"ON"}' [2024-10-29 20:51:09] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l1', payload '{"brightness":173,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"OFF"}' [2024-10-29 20:51:09] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c13884bffd52f1/l2', payload '{"brightness":69,"countdown":0,"max_brightness":254,"min_brightness":10,"state":"ON"}' [2024-10-29 20:51:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-29 20:51:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2) [2024-10-29 20:51:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue [2024-10-29 20:51:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2) [2024-10-29 20:51:10] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=81 Len=22] [2024-10-29 20:51:10] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=ZIGBEE_DELIVERY_FAILED], [type=DIRECT], [indexOrDestination=549], [apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":150}], [messageTag=36] [2024-10-29 20:51:10] debug: zh:ember: ~x~> DELIVERY_FAILED [indexOrDestination=549 apsFrame={"profileId":260,"clusterId":61184,"sourceEndpoint":1,"destinationEndpoint":1,"options":4096,"groupId":0,"sequence":150} messageTag=36]

[Koenkk]

Was this also the case before the fix? It really looks to be a connection issue

[bronzeblood]

No it worked somewhat reliably before the fix, but one day stopped responding that's what made me look into what the issue could be. I agree it looks like a connection issue . I'm using a slzb-06m. Been though every core and zigbee firmware possible same result. the only other device on the network, a water valve works fine.