Koenkk / zigbee2mqtt

Zigbee 🐝 to MQTT bridge 🌉, get rid of your proprietary Zigbee bridges 🔨
https://www.zigbee2mqtt.io
GNU General Public License v3.0
12.08k stars 1.68k forks source link

Aqara Dual Relay T2 (LLKZMK12LM ) Configuration Failure #21676

Open morhimi opened 8 months ago

morhimi commented 8 months ago

What happened?

I get configuration failure message after adding the device to the network today.

What did you expect to happen?

configuration should succeed

How to reproduce it (minimal and precise)

add the device to zigbee network

Zigbee2MQTT version

1.36.0-dev commit: aaed8ab

Adapter firmware version

7.4.1 [GA]

Adapter

SLZB-07

Setup

Add-on on HAOS running on Mini PC (Intel)

Debug log

Debug 2024-03-04 22:44:26Received MQTT message on 'z2medge/bridge/request/device/configure' with data '{"id":"Aqara T2","transaction":"yhw5r-1"}'
Info 2024-03-04 22:44:26Configuring 'Aqara T2'
Debug 2024-03-04 22:44:26Configure reporting: false, read: true for 0x54ef4410009b3f3b/1 manuSpecificLumi [{"attribute":{"ID":10,"type":32},"min":-1,"max":-1,"change":-1}]
Debug 2024-03-04 22:44:26Received Zigbee message from 'Aqara T2', type 'readResponse', cluster 'manuSpecificLumi', data '{"10":3}' from endpoint 1 with groupID 0
Debug 2024-03-04 22:44:26LLKZMK12LM: Processed data into payload {}
Debug 2024-03-04 22:44:26Configure reporting: false, read: true for 0x54ef4410009b3f3b/2 manuSpecificLumi [{"attribute":{"ID":10,"type":32},"min":-1,"max":-1,"change":-1}]
Info 2024-03-04 22:44:26MQTT publish: topic 'z2medge/Aqara T2', payload '{"action":null,"consumption":0.09999999403953552,"current":0,"device_temperature":34,"energy":0.1,"interlock":"OFF","led_disabled_night":false,"linkquality":200,"mode":"power","operation_mode_l1":"decoupled","operation_mode_l2":"decoupled","power":0,"power_on_behavior":"off","power_on_behavior_l1":"off","power_outage_count":6,"pulse_length":200,"state":"OFF","state_l1":"OFF","state_l2":"OFF","switch_type":"none","switch_type_l1":"none","update":{"installed_version":-1,"latest_version":-1,"state":null},"update_available":null,"voltage":213.2}'
Debug 2024-03-04 22:44:26Received Zigbee message from 'Aqara T2', type 'readResponse', cluster 'manuSpecificLumi', data '{}' from endpoint 2 with groupID 0
Debug 2024-03-04 22:44:26LLKZMK12LM: Processed data into payload {}
Error 2024-03-04 22:44:26Exception while calling fromZigbee converter: Expected one of: 1, 2, 3, got: 'undefined'}
Debug 2024-03-04 22:44:26Error: Expected one of: 1, 2, 3, got: 'undefined' at getFromLookupByValue (/app/node_modules/zigbee-herdsman-converters/src/lib/utils.ts:592:15) at Object.convert (/app/node_modules/zigbee-herdsman-converters/src/lib/modernExtend.ts:386:64) at Receive.onDeviceMessage (/app/lib/extension/receive.ts:153:51) at processTicksAndRejections (node:internal/process/task_queues:95:5) at EventEmitter.wrappedCallback (/app/lib/eventBus.ts:174:17)
Error 2024-03-04 22:44:26Failed to configure 'Aqara T2', attempt 5 (Error: Read 0x54ef4410009b3f3b/2 manuSpecificLumi([10], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Status 'UNSUPPORTED_ATTRIBUTE') at Endpoint.checkStatus (/app/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:319:28) at Endpoint.read (/app/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:469:22) at processTicksAndRejections (node:internal/process/task_queues:95:5) at setupAttributes (/app/node_modules/zigbee-herdsman-converters/src/lib/modernExtend.ts:65:13) at configure (/app/node_modules/zigbee-herdsman-converters/src/lib/modernExtend.ts:86:17) at Object.configure (/app/node_modules/zigbee-herdsman-converters/src/index.ts:141:25) at Configure.configure (/app/lib/extension/configure.ts:122:13) at Configure.onMQTTMessage (/app/lib/extension/configure.ts:55:21) at EventEmitter.wrappedCallback (/app/lib/eventBus.ts:174:17))
Info 2024-03-04 22:44:26MQTT publish: topic 'z2medge/bridge/response/device/configure', payload '{"data":{"id":"Aqara T2"},"error":"Failed to configure (Read 0x54ef4410009b3f3b/2 manuSpecificLumi([10], {\"timeout\":10000,\"disableResponse\":false,\"disableRecovery\":false,\"disableDefaultResponse\":true,\"direction\":0,\"srcEndpoint\":null,\"reservedBits\":0,\"manufacturerCode\":4447,\"transactionSequenceNumber\":null,\"writeUndiv\":false}) failed (Status 'UNSUPPORTED_ATTRIBUTE'))","status":"error","transaction":"yhw5r-1"}'
morhimi commented 8 months ago

forgot to mention that I'm running ember

morhimi commented 7 months ago

Anything I can do to assist in debugging this?

morhimi commented 6 months ago

any assistance will be appreciated...

Koenkk commented 6 months ago

Can you go to the exposes tab and change the switch_type, does this work?

BeFygo commented 2 months ago

I'm having a simular problem.

error 2024-08-06 06:44:51z2m: Exception while calling fromZigbee converter: Expected one of: 1, 2, 3, got: 'undefined'} error 2024-08-06 06:44:51z2m: Exception while calling fromZigbee converter: Expected one of: 0, 1, 2, 3, got: 'undefined'} error 2024-08-06 06:44:52z2m: Exception while calling fromZigbee converter: Expected one of: 0, 1, 3, got: 'undefined'} error 2024-08-06 06:44:52z2m: Exception while calling fromZigbee converter: Value is not a number, got undefined (undefined)}

changing the switch_type doesn't seem to resolve the issue

SanderDevCode commented 3 weeks ago

I've the same problem,

Switching the switch_type seems to work (it's changed in the state json of the device), but for me the switch_type seems to work incorrectly (I don't know if it its related, a firmware issue of aqara or maybe its a user error). When I've set the switch_type to momentary it acts like a toggle switch (even when the state page tell me the switch_type is set tot momentary).

I've enabled debug logging and found this in the logs:

[2024-10-07 20:18:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-07 20:18:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1) [2024-10-07 20:18:53] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=1 frmNum=4 Added to rxQueue [2024-10-07 20:18:53] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=5 [2024-10-07 20:18:53] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=40 Len=59] [2024-10-07 20:18:53] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":127}], [packetInfo:{"senderShortId":54035,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":180,"lastHopRssi":-55,"lastHopTimestamp":0}], [messageContents=1c5f117e0af2ff4119aa751384bd8d0741000f0c23010100040a2308000c640b2003] [2024-10-07 20:18:53] debug: zh:controller: Received payload: clusterID=64704, address=54035, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=180, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4447,"transactionSequenceNumber":126,"commandIdentifier":10},"payload":[{"attrId":65522,"dataType":65,"attrData":{"type":"Buffer","data":[170,117,19,132,189,141,7,65,0,15,12,35,1,1,0,4,10,35,8,0,12,100,11,32,3]}}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}} [2024-10-07 20:18:53] debug: z2m: Received Zigbee message from 'werkkamer_rolluik', type 'attributeReport', cluster 'manuSpecificLumi', data '{"65522":{"data":[170,117,19,132,189,141,7,65,0,15,12,35,1,1,0,4,10,35,8,0,12,100,11,32,3],"type":"Buffer"}}' from endpoint 1 with groupID 0 [2024-10-07 20:18:53] debug: zhc:lumi: LLKZMK12LM: unknown key 65522 with value �u���A� #�

� d 

[2024-10-07 20:18:53] debug: zhc:lumi: LLKZMK12LM: Processed data into payload {}

If this isn't helping, is there anything else I can do to provide some help?

[Edit] I've did some other debugging and setting the switch type seems to work correctly :

[2024-10-08 07:17:11] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/werkkamer_rolluik/set' with data '{"switch_type":"momentary"}' [2024-10-08 07:17:11] debug: z2m: Publishing 'set' 'switch_type' to 'werkkamer_rolluik' [2024-10-08 07:17:11] debug: zh:controller:endpoint: ZCL command 0x54ef441000d6ddc1/1 manuSpecificLumi.write({"10":{"value":2,"type":32}}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"manufacturerCode":4447,"writeUndiv":false}) [2024-10-08 07:17:11] debug: zh:ember: ~~~> [ZCL to=0x54ef441000d6ddc1:54035 apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":true},"manufacturerCode":4447,"transactionSequenceNumber":6,"commandIdentifier":2}] [2024-10-08 07:17:11] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=44 Len=30] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: ---> FRAME type=DATA frmTx=4 frmRx=3 [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5) [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=3 Added to rxQueue [2024-10-08 07:17:11] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=4 [2024-10-08 07:17:11] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=44 Len=7] [2024-10-08 07:17:11] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=18 messageTag=7 status=OK] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5) [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=4 Added to rxQueue [2024-10-08 07:17:11] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=5 [2024-10-08 07:17:11] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=44 Len=22] [2024-10-08 07:17:11] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=54035], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":18}], [messageTag=7] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5) [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=5 Added to rxQueue [2024-10-08 07:17:11] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=6 [2024-10-08 07:17:11] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=44 Len=31] [2024-10-08 07:17:11] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":0,"groupId":0,"sequence":32}], [packetInfo:{"senderShortId":54035,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":172,"lastHopRssi":-57,"lastHopTimestamp":0}], [messageContents=1c5f11060400] [2024-10-08 07:17:11] debug: zh:controller: Received payload: clusterID=64704, address=54035, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=172, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4447,"transactionSequenceNumber":6,"commandIdentifier":4},"payload":[{"status":0}],"command":{"ID":4,"name":"writeRsp","parameters":[{"name":"status","type":32},{"name":"attrId","type":33,"conditions":[{"type":"statusNotEquals","value":0}]}]}} [2024-10-08 07:17:11] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/werkkamer_rolluik', payload '{"action":null,"consumption":0.001399999737739563,"current":0,"device_temperature":30,"energy":0,"interlock":"ON","led_disabled_night":false,"linkquality":172,"mode":"power","operation_mode_l1":"control_relay","operation_mode_l2":"control_relay","power":0,"power_on_behavior":"off","power_outage_count":9,"pulse_length":200,"state":"OFF","state_l1":"OFF","state_l2":"OFF","switch_type":"momentary","update":{"installed_version":30,"latest_version":30,"state":"idle"},"update_available":null,"voltage":221.32}' [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5) [2024-10-08 07:17:11] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=6 Added to rxQueue [2024-10-08 07:17:11] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=7 [2024-10-08 07:17:11] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=44 Len=34] [2024-10-08 07:17:11] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":33}], [packetInfo:{"senderShortId":54035,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":172,"lastHopRssi":-57,"lastHopTimestamp":0}], [messageContents=1c5f11060a0a002002] [2024-10-08 07:17:11] debug: zh:controller: Received payload: clusterID=64704, address=54035, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=172, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4447,"transactionSequenceNumber":6,"commandIdentifier":10},"payload":[{"attrId":10,"dataType":32,"attrData":2}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}} [2024-10-08 07:17:11] debug: z2m: Received Zigbee message from 'werkkamer_rolluik', type 'attributeReport', cluster 'manuSpecificLumi', data '{"10":2}' from endpoint 1 with groupID 0 [2024-10-08 07:17:11] debug: zhc:lumi: LLKZMK12LM: Processed data into payload {} [2024-10-08 07:17:11] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/werkkamer_rolluik', payload '{"action":null,"consumption":0.001399999737739563,"current":0,"device_temperature":30,"energy":0,"interlock":"ON","led_disabled_night":false,"linkquality":172,"mode":"power","operation_mode_l1":"control_relay","operation_mode_l2":"control_relay","power":0,"power_on_behavior":"off","power_outage_count":9,"pulse_length":200,"state":"OFF","state_l1":"OFF","state_l2":"OFF","switch_type":"momentary","update":{"installed_version":30,"latest_version":30,"state":"idle"},"update_available":null,"voltage":221.32}' [2024-10-08 07:17:18] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/werkkamer_rolluik/get' with data '{"switch_type":""}' [2024-10-08 07:17:18] debug: z2m: Publishing get 'get' 'switch_type' to 'werkkamer_rolluik' [2024-10-08 07:17:18] debug: zh:controller:endpoint: ZCL command 0x54ef441000d6ddc1/1 manuSpecificLumi.read([10], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"manufacturerCode":4447,"writeUndiv":false}) [2024-10-08 07:17:18] debug: zh:ember: ~~~> [ZCL to=0x54ef441000d6ddc1:54035 apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":true},"manufacturerCode":4447,"transactionSequenceNumber":7,"commandIdentifier":0}] [2024-10-08 07:17:18] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=45 Len=28] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: ---> FRAME type=DATA frmTx=5 frmRx=7 [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6) [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=6 frmNum=7 Added to rxQueue [2024-10-08 07:17:18] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=0 [2024-10-08 07:17:18] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=45 Len=7] [2024-10-08 07:17:18] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=19 messageTag=8 status=OK] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6) [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=6 frmNum=0 Added to rxQueue [2024-10-08 07:17:18] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=1 [2024-10-08 07:17:18] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=45 Len=22] [2024-10-08 07:17:18] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=54035], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":19}], [messageTag=8] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6) [2024-10-08 07:17:18] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=6 frmNum=1 Added to rxQueue [2024-10-08 07:17:18] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=2 [2024-10-08 07:17:18] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=45 Len=35] [2024-10-08 07:17:18] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64704,"sourceEndpoint":1,"destinationEndpoint":1,"options":0,"groupId":0,"sequence":34}], [packetInfo:{"senderShortId":54035,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":172,"lastHopRssi":-57,"lastHopTimestamp":0}], [messageContents=1c5f1107010a00002002] [2024-10-08 07:17:18] debug: zh:controller: Received payload: clusterID=64704, address=54035, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=172, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4447,"transactionSequenceNumber":7,"commandIdentifier":1},"payload":[{"attrId":10,"status":0,"dataType":32,"attrData":2}],"command":{"ID":1,"name":"readRsp","parameters":[{"name":"attrId","type":33},{"name":"status","type":32},{"name":"dataType","type":32,"conditions":[{"type":"statusEquals","value":0}]},{"name":"attrData","type":1000,"conditions":[{"type":"statusEquals","value":0}]}]}} [2024-10-08 07:17:18] debug: z2m: Received Zigbee message from 'werkkamer_rolluik', type 'readResponse', cluster 'manuSpecificLumi', data '{"10":2}' from endpoint 1 with groupID 0 [2024-10-08 07:17:18] debug: zhc:lumi: LLKZMK12LM: Processed data into payload {}