Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

After pushing off twice on hue dimmer tradfri bulb does not respond #25055

Closed
boerniee opened this issue Dec 4, 2024 · 1 comment
Closed

After pushing off twice on hue dimmer tradfri bulb does not respond #25055

boerniee opened this issue Dec 4, 2024 · 1 comment
Labels
problem Something isn't working stale Stale issues

Comments

@boerniee
Copy link

boerniee commented Dec 4, 2024

What happened?

I have added a Tradfri LED1934G3 bulb and a philips hue dimmer to the zigbee2MQTT network. Then I created a binding of the two devices.
image
It works all fine (turning on, turning off, dimming) until I turn the bulb off via the hue dimmer and press the off button a second time when the bulb if off. The lamp then reacts neither to inputs from the dimmer nor from the zigbee2MQTT frontend. After disconnecting and connecting the lamp from the power it is all working fine again until I hit the off button on the dimmer twice.

I have also read that someone had the same problem in this issue but there was no solution for this problem mentioned.
The problem also exists in the current development branch.

image image

What did you expect to happen?

I expected that I can hit the off button as many times as I want and still be able to turn on the bulb via the dimmer.

How to reproduce it (minimal and precise)

  • Attach the bulb to the power
  • Press off button on hue dimmer
  • Press off button on hue dimmer again

Zigbee2MQTT version

1.42.0

Adapter firmware version

7.4.4 [GA]

Adapter

SONOFF ZBDongle-E

Setup

Standalone Docker Installation

Debug log

before

{
"brightness": 106,
"linkquality": 124,
"power_on_behavior": "on",
"state": "OFF",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}

pressing on on hue dimmer

[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=2 frmNum=5 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=6
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=81 Len=37]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":90}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":136,"lastHopRssi":-66,"lastHopTimestamp":0}], [messageContents=1d0b102f000100003000210000]
[2024-12-04 14:01:24] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=136, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":47,"commandIdentifier":0},"payload":{"button":1,"unknown1":3145728,"type":0,"unknown2":0,"time":0},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:01:24] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":1,"time":0,"type":0,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:01:24] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"on_press","action_duration":null,"battery":84,"linkquality":136,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:01:24] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'on_press'
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=2 frmNum=6 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=7
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=81 Len=18]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ezspIncomingRouteRecordHandler(): callback called with: [source=45915], [sourceEui=0xe8e07efffe4b36c8], [lastHopLqi=120], [lastHopRssi=-70], [relayCount=0], [relayList=]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=2 frmNum=7 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=0
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=81 Len=32]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":251}], [packetInfo:{"senderShortId":45915,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":128,"lastHopRssi":-68,"lastHopTimestamp":0}], [messageContents=080a0a00001001]
[2024-12-04 14:01:24] debug: zh:controller: Received payload: clusterID=6, address=45915, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=128, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":10,"commandIdentifier":10},"payload":[{"attrId":0,"dataType":16,"attrData":1}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}}
[2024-12-04 14:01:24] debug: zh:controller:endpoint: ZCL command 0xe8e07efffe4b36c8/1 genOnOff.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":10,"writeUndiv":false})
[2024-12-04 14:01:24] debug: zh:ember: ~~~> [ZCL to=0xe8e07efffe4b36c8:45915 apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":10,"commandIdentifier":11}]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=82 Len=26]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=DATA frmTx=2 frmRx=0
[2024-12-04 14:01:24] debug: z2m: Received Zigbee message from 'schlafzimmer_decke', type 'attributeReport', cluster 'genOnOff', data '{"onOff":1}' from endpoint 1 with groupID 0
[2024-12-04 14:01:24] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/schlafzimmer_decke', payload '{"brightness":106,"linkquality":128,"power_on_behavior":"on","state":"ON","update":{"installed_version":16842756,"latest_version":16842756,"state":"idle"}}'
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=3)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=2 frmNum=0 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=1
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=81 Len=37]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":92}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":132,"lastHopRssi":-67,"lastHopTimestamp":0}], [messageContents=1d0b1031000100003002210000]
[2024-12-04 14:01:24] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=132, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":49,"commandIdentifier":0},"payload":{"button":1,"unknown1":3145728,"type":2,"unknown2":0,"time":0},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:01:24] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":1,"time":0,"type":2,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:01:24] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"on_press_release","action_duration":null,"battery":84,"linkquality":132,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:01:24] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'on_press_release'
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=2 frmTx=3)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=3 frmNum=1 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=2
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=82 Len=7]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=193 messageTag=49 status=OK]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=3 frmNum=2 Added to rxQueue
[2024-12-04 14:01:24] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=3
[2024-12-04 14:01:24] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=82 Len=22]
[2024-12-04 14:01:24] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=45915], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":193}], [messageTag=49]

{
"brightness": 106,
"linkquality": 128,
"power_on_behavior": "on",
"state": "ON",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}

pressing off on hue dimmer

[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=3 frmNum=3 Added to rxQueue
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=4
[2024-12-04 14:02:00] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=82 Len=37]
[2024-12-04 14:02:00] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":93}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":132,"lastHopRssi":-67,"lastHopTimestamp":0}], [messageContents=1d0b1032000400003000210000]
[2024-12-04 14:02:00] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=132, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":50,"commandIdentifier":0},"payload":{"button":4,"unknown1":3145728,"type":0,"unknown2":0,"time":0},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:02:00] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":4,"time":0,"type":0,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:02:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"off_press","action_duration":null,"battery":84,"linkquality":132,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:02:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'off_press'
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=3 frmNum=4 Added to rxQueue
[2024-12-04 14:02:00] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=5
[2024-12-04 14:02:00] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=82 Len=37]
[2024-12-04 14:02:00] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":95}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":132,"lastHopRssi":-67,"lastHopTimestamp":0}], [messageContents=1d0b1034000400003002210100]
[2024-12-04 14:02:00] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=132, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":52,"commandIdentifier":0},"payload":{"button":4,"unknown1":3145728,"type":2,"unknown2":0,"time":1},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:02:00] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":4,"time":1,"type":2,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:02:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"off_press_release","action_duration":null,"battery":84,"linkquality":132,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:02:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'off_press_release'
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=3 frmNum=5 Added to rxQueue
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=6
[2024-12-04 14:02:01] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=82 Len=32]
[2024-12-04 14:02:01] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":253}], [packetInfo:{"senderShortId":45915,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0}], [messageContents=080b0a00001000]
[2024-12-04 14:02:01] debug: zh:controller: Received payload: clusterID=6, address=45915, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":11,"commandIdentifier":10},"payload":[{"attrId":0,"dataType":16,"attrData":0}],"command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}}
[2024-12-04 14:02:01] debug: zh:controller:endpoint: ZCL command 0xe8e07efffe4b36c8/1 genOnOff.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":11,"writeUndiv":false})
[2024-12-04 14:02:01] debug: zh:ember: ~~~> [ZCL to=0xe8e07efffe4b36c8:45915 apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":11,"commandIdentifier":11}]
[2024-12-04 14:02:01] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=83 Len=26]
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: ---> FRAME type=DATA frmTx=3 frmRx=6
[2024-12-04 14:02:01] debug: z2m: Received Zigbee message from 'schlafzimmer_decke', type 'attributeReport', cluster 'genOnOff', data '{"onOff":0}' from endpoint 1 with groupID 0
[2024-12-04 14:02:01] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/schlafzimmer_decke', payload '{"brightness":106,"linkquality":120,"power_on_behavior":"on","state":"OFF","update":{"installed_version":16842756,"latest_version":16842756,"state":"idle"}}'
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=6 Added to rxQueue
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=7
[2024-12-04 14:02:01] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=83 Len=7]
[2024-12-04 14:02:01] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=194 messageTag=50 status=OK]
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=7 Added to rxQueue
[2024-12-04 14:02:01] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=0
[2024-12-04 14:02:01] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=83 Len=22]
[2024-12-04 14:02:01] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=45915], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":194}], [messageTag=50]

{
"brightness": 106,
"linkquality": 120,
"power_on_behavior": "on",
"state": "OFF",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}

pressing off second time on hue dimmer

[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=0 Added to rxQueue
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=1
[2024-12-04 14:02:31] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=83 Len=37]
[2024-12-04 14:02:31] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":96}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0}], [messageContents=1d0b1035000400003000210000]
[2024-12-04 14:02:31] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":53,"commandIdentifier":0},"payload":{"button":4,"unknown1":3145728,"type":0,"unknown2":0,"time":0},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:02:31] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":4,"time":0,"type":0,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:02:31] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"off_press","action_duration":null,"battery":84,"linkquality":120,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:02:31] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'off_press'
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=1 Added to rxQueue
[2024-12-04 14:02:31] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=2
[2024-12-04 14:02:31] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=83 Len=37]
[2024-12-04 14:02:31] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":98}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":132,"lastHopRssi":-67,"lastHopTimestamp":0}], [messageContents=1d0b1037000400003002210100]
[2024-12-04 14:02:31] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=132, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":55,"commandIdentifier":0},"payload":{"button":4,"unknown1":3145728,"type":2,"unknown2":0,"time":1},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:02:31] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":4,"time":1,"type":2,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:02:31] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"off_press_release","action_duration":null,"battery":84,"linkquality":132,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:02:31] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'off_press_release'

{
"brightness": 106,
"linkquality": 120,
"power_on_behavior": "on",
"state": "OFF",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}

pressing on on hue dimmer

[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=2 Added to rxQueue
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=3
[2024-12-04 14:03:00] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=83 Len=37]
[2024-12-04 14:03:00] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":99}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":140,"lastHopRssi":-65,"lastHopTimestamp":0}], [messageContents=1d0b1038000100003000210000]
[2024-12-04 14:03:00] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=140, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":56,"commandIdentifier":0},"payload":{"button":1,"unknown1":3145728,"type":0,"unknown2":0,"time":0},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:03:00] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":1,"time":0,"type":0,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:03:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"on_press","action_duration":null,"battery":84,"linkquality":140,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:03:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'on_press'
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=4 frmNum=3 Added to rxQueue
[2024-12-04 14:03:00] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=4
[2024-12-04 14:03:00] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=83 Len=37]
[2024-12-04 14:03:00] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":64512,"sourceEndpoint":2,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":101}], [packetInfo:{"senderShortId":21234,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":144,"lastHopRssi":-64,"lastHopTimestamp":0}], [messageContents=1d0b103a000100003002210100]
[2024-12-04 14:03:00] debug: zh:controller: Received payload: clusterID=64512, address=21234, groupID=0, endpoint=2, destinationEndpoint=1, wasBroadcast=false, linkQuality=144, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":true,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"manufacturerCode":4107,"transactionSequenceNumber":58,"commandIdentifier":0},"payload":{"button":1,"unknown1":3145728,"type":2,"unknown2":0,"time":1},"command":{"ID":0,"parameters":[{"name":"button","type":32},{"name":"unknown1","type":34},{"name":"type","type":32},{"name":"unknown2","type":32},{"name":"time","type":32},{"name":"unknown2","type":32}],"name":"hueNotification"}}
[2024-12-04 14:03:00] debug: z2m: Received Zigbee message from 'dimmer_schlafzimmer', type 'commandHueNotification', cluster 'manuSpecificPhilips', data '{"button":1,"time":1,"type":2,"unknown1":3145728,"unknown2":0}' from endpoint 2 with groupID 0
[2024-12-04 14:03:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer', payload '{"action":"on_press_release","action_duration":null,"battery":84,"linkquality":144,"update":{"installed_version":1107324829,"latest_version":1107324829,"state":"idle"}}'
[2024-12-04 14:03:00] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/dimmer_schlafzimmer/action', payload 'on_press_release'

{
"brightness": 106,
"linkquality": 120,
"power_on_behavior": "on",
"state": "OFF",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}

switch light on in zigbee2mqtt frontend (light is not on afterwards)

[2024-12-04 14:03:53] debug: z2m:mqtt: Received MQTT message on 'zigbee2mqtt/schlafzimmer_decke/set' with data '{"state":"ON"}'
[2024-12-04 14:03:53] debug: z2m: Publishing 'set' 'state' to 'schlafzimmer_decke'
[2024-12-04 14:03:53] debug: zh:controller:endpoint: ZCL command 0xe8e07efffe4b36c8/1 genOnOff.on({}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":false,"direction":0,"reservedBits":0,"writeUndiv":false})
[2024-12-04 14:03:53] debug: zh:ember: ~~~> [ZCL to=0xe8e07efffe4b36c8:45915 apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":false,"manufacturerSpecific":false},"transactionSequenceNumber":16,"commandIdentifier":1}]
[2024-12-04 14:03:53] debug: zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=84 Len=24]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: ---> FRAME type=DATA frmTx=4 frmRx=5
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=5 Added to rxQueue
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=6
[2024-12-04 14:03:53] debug: zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=84 Len=7]
[2024-12-04 14:03:53] debug: zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=195 messageTag=51 status=OK]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=6 Added to rxQueue
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=7
[2024-12-04 14:03:53] debug: zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=84 Len=18]
[2024-12-04 14:03:53] debug: zh:ember:ezsp: ezspIncomingRouteRecordHandler(): callback called with: [source=45915], [sourceEui=0xe8e07efffe4b36c8], [lastHopLqi=124], [lastHopRssi=-69], [relayCount=0], [relayList=]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=7 Added to rxQueue
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=0
[2024-12-04 14:03:53] debug: zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=84 Len=22]
[2024-12-04 14:03:53] debug: zh:ember:ezsp: ezspMessageSentHandler(): callback called with: [status=OK], [type=DIRECT], [indexOrDestination=45915], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":195}], [messageTag=51]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA]
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: <--- FRAME type=DATA ackNum=5 frmNum=0 Added to rxQueue
[2024-12-04 14:03:53] debug: zh:ember:uart:ash: ---> FRAME type=ACK frmRx=1
[2024-12-04 14:03:53] debug: zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=84 Len=30]
[2024-12-04 14:03:53] debug: zh:ember:ezsp: ezspIncomingMessageHandler(): callback called with: [type=UNICAST], [apsFrame={"profileId":260,"clusterId":6,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":0}], [packetInfo:{"senderShortId":45915,"senderLongId":"0xFFFFFFFFFFFFFFFF","bindingIndex":255,"addressIndex":255,"lastHopLqi":128,"lastHopRssi":-68,"lastHopTimestamp":0}], [messageContents=08100b0100]
[2024-12-04 14:03:53] debug: zh:controller: Received payload: clusterID=6, address=45915, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=128, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":16,"commandIdentifier":11},"payload":{"cmdId":1,"statusCode":0},"command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}}
[2024-12-04 14:03:53] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/schlafzimmer_decke', payload '{"brightness":106,"linkquality":128,"power_on_behavior":"on","state":"ON","update":{"installed_version":16842756,"latest_version":16842756,"state":"idle"}}'

{
"brightness": 106,
"linkquality": 128,
"power_on_behavior": "on",
"state": "ON",
"update": {
"installed_version": 16842756,
"latest_version": 16842756,
"state": "idle"
}
}
@boerniee boerniee added the problem Something isn't working label Dec 4, 2024
@github-actions GitHub Actions
Copy link
Contributor

github-actions bot commented Feb 3, 2025

This issue is stale because it has been open 60 days with no activity. Remove stale label or comment or this will be closed in 7 days

@github-actions github-actions bot added the stale Stale issues label Feb 3, 2025
@github-actions github-actions bot closed this as not planned Won't fix, can't repro, duplicate, stale Feb 10, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
problem Something isn't working stale Stale issues
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@boerniee