Tuya TS0207 IAS device leaves network every ~20s after successful enrollment on ember adapter

[TSparkas]

Environment

• zigbee-herdsman: 10.0.5
• Adapter: ember (SLZB-MR5U, EFR32MG24, EmberZNet 7.4.4 [GA], EZSP v13)
• Device: Tuya TS0207 water leak detector (_TZ3000_ww9i3e0y), Tuya TS0205 optical smoke sensor (TS0205_smoke_2), [Meian SW02] leak sensor.

Behaviour

Device joins, IAS Zone enrollment succeeds (zoneState:1 confirmed),
configure succeeds, then device goes completely silent for ~18-20 seconds
and performs a clean DEVICE_LEFT. Repeats indefinitely. water_leak
state is never published (stays null).

Tested with direct coordinator connection (LQI=228, parentOfNewNodeId=0)
— routing is not the cause.

Key log evidence

IAS enrollment confirmed:
zh:controller:device: Interview - IAS - after enrolling state (0): '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}'
zh:controller:device: Interview - IAS successfully enrolled '0xa4c138e388658fb0' endpoint '1'

20 seconds of silence after configure, then clean leave:

z2m: Successfully configured '0xa4c138e388658fb0' (definition v0.0.0)
[18-20 seconds, zero messages from device]
ezspTrustCenterJoinHandler: status=DEVICE_LEFT policyDecision=NO_ACTION

Also observed: enrollRsp is sent with options:4352 (missing
ENABLE_ROUTE_DISCOVERY bit) while all other ZCL commands use options:4416.

Note

Same device worked correctly on Z-Stack coordinator (SLZB-06/CC2652P)
before migration to EFR32MG24.

Also smilar problems with [Meian SW02] leak sensor (https://www.zigbee2mqtt.io/devices/SW02.html#meian-sw02) and Tuya TS0205 optical smoke sensor (TS0205_smoke_2) https://www.zigbee2mqtt.io/devices/TS0205_smoke_2.html

[Nerivec]

This is incorrect:

enrollRsp is sent with options:4352 (missing ENABLE_ROUTE_DISCOVERY bit) while all other ZCL commands use options:4416.

The RETRY option is not present when no response is expected, that's the difference in value.

As for the issue, would need debug logs and probably sniffing to see what is going on, and if the issue is with something we can fix (can't if it's the device that decides to leave because it doesn't like something...).

[TSparkas]

Debug logs from a full join cycle (debug level):

[2026-04-09 20:11:19] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=59859 newNodeEui64=0xa4c138e388658fb0 status=STANDARD_SECURITY_UNSECURED_JOIN policyDecision=USE_PRECONFIGURED_KEY parentOfNewNodeId=0
[2026-04-09 20:11:19] debug:    zh:controller: Device '0xa4c138e388658fb0' joined
[2026-04-09 20:11:19] debug:    zh:controller: Device '0xa4c138e388658fb0' accepted by handler
[2026-04-09 20:11:19] debug:    zh:controller: Deleted device '0xa4c138e388658fb0' joined, undeleting
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:19.207Z","linkquality":228,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:19] info:     zh:controller: Interview for '0xa4c138e388658fb0' started
[2026-04-09 20:11:19] debug:    zh:controller:device: Interview - start device '0xa4c138e388658fb0'
[2026-04-09 20:11:19] debug:    zh:controller:device: Interview - skip node descriptor request for '0xa4c138e388658fb0', already got it
[2026-04-09 20:11:19] debug:    zh:ember: ~~~> [ZDO ACTIVE_ENDPOINTS_REQUEST UNICAST to=0xa4c138e388658fb0:59859 messageTag=22 payload=16d3e9]
[2026-04-09 20:11:19] info:     z2m: Device '0xa4c138e388658fb0' joined
[2026-04-09 20:11:19] info:     z2m: Starting interview of '0xa4c138e388658fb0'
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_joined"}'
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"started"},"type":"device_interview"}'
[2026-04-09 20:11:19] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=true childId=59859 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-09 20:11:19] debug:    zh:controller: Received ZDO response: clusterId=END_DEVICE_ANNOUNCE, status=SUCCESS, payload={"nwkAddress":59859,"eui64":"0xa4c138e388658fb0","capabilities":{"alternatePANCoordinator":0,"deviceType":0,"powerSource":0,"rxOnWhenIdle":0,"reserved1":0,"reserved2":0,"securityCapability":0,"allocateAddress":1}}
[2026-04-09 20:11:19] debug:    zh:controller: Device announce from '0xa4c138e388658fb0:59859'
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:19.697Z","linkquality":228,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:19] debug:    z2m: Device '0xa4c138e388658fb0' announced itself
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_announce"}'
[2026-04-09 20:11:19] debug:    zh:controller:device: Interview - got active endpoints for device '0xa4c138e388658fb0'
[2026-04-09 20:11:19] debug:    zh:ember: ~~~> [ZDO SIMPLE_DESCRIPTOR_REQUEST UNICAST to=0xa4c138e388658fb0:59859 messageTag=23 payload=17d3e901]
[2026-04-09 20:11:19] debug:    zh:controller:device: Interview - got simple descriptor for endpoint '1' device '0xa4c138e388658fb0'
[2026-04-09 20:11:19] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["stackVersion"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-09 20:11:19] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":56,"commandIdentifier":0}]
[2026-04-09 20:11:19] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"stackVersion":0}' from endpoint 1 with groupID 0
[2026-04-09 20:11:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:19.945Z","linkquality":224,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:19] debug:    zh:controller:device: Interview - got 'stackVersion' for device '0xa4c138e388658fb0'
[2026-04-09 20:11:19] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["dateCode"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-09 20:11:19] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":57,"commandIdentifier":0}]
[2026-04-09 20:11:20] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"dateCode":""}' from endpoint 1 with groupID 0
[2026-04-09 20:11:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:20.066Z","linkquality":224,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - got 'dateCode' for device '0xa4c138e388658fb0'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-09 20:11:20] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":58,"commandIdentifier":0}]
[2026-04-09 20:11:20] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{}' from endpoint 1 with groupID 0
[2026-04-09 20:11:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:20.193Z","linkquality":228,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE')
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - failed to read attribute 'swBuildId' from endpoint '1' (Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE'))
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - IAS - enrolling '0xa4c138e388658fb0' endpoint '1'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.read(["iasCieAddr","zoneState"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-09 20:11:20] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":59,"commandIdentifier":0}]
[2026-04-09 20:11:20] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'ssIasZone', data '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}' from endpoint 1 with groupID 0
[2026-04-09 20:11:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:20.319Z","linkquality":228,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - IAS - before enrolling state: '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}'
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - IAS - already enrolled, skipping enroll
[2026-04-09 20:11:20] debug:    zh:controller:device: Interview - completed for device '0xa4c138e388658fb0'
[2026-04-09 20:11:20] info:     zh:controller: Succesfully interviewed '0xa4c138e388658fb0'
[2026-04-09 20:11:20] info:     z2m: Successfully interviewed '0xa4c138e388658fb0', device has successfully been paired
[2026-04-09 20:11:20] info:     z2m: Device '0xa4c138e388658fb0' is supported, identified as: Tuya Water leak detector (TS0207_water_leak_detector)
[2026-04-09 20:11:20] info:     z2m: Configuring '0xa4c138e388658fb0'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: Bind 0xa4c138e388658fb0/1 genPowerCfg from '0x00124b001ca5eaaa/1'
[2026-04-09 20:11:20] debug:    zh:ember: ~~~> [ZDO BIND_REQUEST UNICAST to=0xa4c138e388658fb0:59859 messageTag=24 payload=18b08f6588e338c1a401010003aaeaa51c004b120001]
[2026-04-09 20:11:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"definition":{"description":"Water leak detector","exposes":[{"access":1,"description":"Indicates whether the device detected a water leak","label":"Water leak","name":"water_leak","property":"water_leak","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Indicates if the battery of this device is almost empty","label":"Battery low","name":"battery_low","property":"battery_low","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Remaining battery in %, can take up to 24 hours before reported","label":"Battery","name":"battery","property":"battery","type":"numeric","unit":"%","value_max":100,"value_min":0},{"access":1,"description":"Indicates whether the device is tampered","label":"Tamper","name":"tamper","property":"tamper","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Link quality (signal strength)","label":"Linkquality","name":"linkquality","property":"linkquality","type":"numeric","unit":"lqi","value_max":255,"value_min":0}],"model":"TS0207_water_leak_detector","options":[],"source":"native","supports_ota":false,"vendor":"Tuya","version":"0.0.0"},"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"successful","supported":true},"type":"device_interview"}'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.configReport([{"attribute":"batteryPercentageRemaining","minimumReportInterval":3600,"maximumReportInterval":65000,"reportableChange":0}], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-09 20:11:20] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":60,"commandIdentifier":6}]
[2026-04-09 20:11:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:20.675Z","linkquality":224,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:20] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.read(["batteryPercentageRemaining"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-09 20:11:20] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:59859 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":61,"commandIdentifier":0}]
[2026-04-09 20:11:21] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genPowerCfg', data '{"batteryPercentageRemaining":200}' from endpoint 1 with groupID 0
[2026-04-09 20:11:21] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-09T17:11:21.007Z","linkquality":228,"tamper":null,"water_leak":null}'
[2026-04-09 20:11:21] info:     z2m: Successfully configured '0xa4c138e388658fb0' (definition v0.0.0)
[2026-04-09 20:11:40] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=false childId=59859 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-09 20:11:40] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=59859 newNodeEui64=0xa4c138e388658fb0 status=DEVICE_LEFT policyDecision=NO_ACTION parentOfNewNodeId=65535
[2026-04-09 20:11:40] debug:    zh:controller: Device leave '0xa4c138e388658fb0'
[2026-04-09 20:11:40] debug:    zh:controller: Removing device from database '0xa4c138e388658fb0'

Key observations from the logs:

IAS enrollment completes successfully — zoneState:1 confirmed
Configure succeeds
Device goes completely silent (zero messages in either direction) for 18-20 seconds
Clean DEVICE_LEFT — not a timeout/drop, the device actively leaves

Most important point — this worked on Z-Stack:

These devices (TS0207 _TZ3000_ww9i3e0y and TS0205) functioned correctly on a CC2652P coordinator (SLZB-06) with Z-Stack before migrating to EFR32MG24 (SLZB-MR5U) with ember adapter. Same devices, same network key, same channel — only the coordinator changed. So if the devices are "deciding to leave because they don't like something", what they don't like is specific to the ember adapter's behaviour, not an inherent device firmware problem.

Affected devices (all Tuya IAS Zone):

TS0207_water_leak_detector (_TZ3000_ww9i3e0y)
TS0205_smoke_2
Meian SW02

[Nerivec]

You appear to have some kind of filter on the logs, these are incomplete.
Also, do a clean pair so we have a clean log => remove device from Z2M (if still there), restart Z2M, pair device.

Could be zstack vs ember, could be an issue from the migration, could be a mesh change, could be a key exchange problem, or many other things.

Can you do a sniff of the clean pair?
https://www.zigbee2mqtt.io/advanced/zigbee/04_sniff_zigbee_traffic.html

Also try to update your coordinator, lots of bugfixes in the stack since 7.4.

[TSparkas]

OK, tried to capture full log below. It appears to be a duplicate enrollRsp being sent for each enrollReq?

[07:29:16] enrollReq received from device (TSN 71)
[07:29:16] zh:controller:device: IAS - responding to enroll response → enrollRsp TSN 52 sent
[07:29:16] zh:controller:device: IAS - sending enroll response (auto enroll) → enrollRsp TSN 53 sent

How can I update the coordinator? I am on latest offered OTA firmware.

Will see if I can setup a sniffer during weekend (if it's really needed).

[2026-04-10 07:29:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=36:"TRUST_CENTER_JOIN_HANDLER" Seq=18 Len=19]
[2026-04-10 07:29:14] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=34203 newNodeEui64=0xa4c138e388658fb0 status=STANDARD_SECURITY_UNSECURED_JOIN policyDecision=USE_PRECONFIGURED_KEY parentOfNewNodeId=0
[2026-04-10 07:29:14] debug:    zh:controller: Device '0xa4c138e388658fb0' joined
[2026-04-10 07:29:14] debug:    zh:controller: Device '0xa4c138e388658fb0' accepted by handler
[2026-04-10 07:29:14] debug:    zh:controller: Deleted device '0xa4c138e388658fb0' joined, undeleting
[2026-04-10 07:29:14] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:14.938Z","linkquality":120}'
[2026-04-10 07:29:14] info:     zh:controller: Interview for '0xa4c138e388658fb0' started
[2026-04-10 07:29:14] debug:    zh:controller:device: Interview - start device '0xa4c138e388658fb0'
[2026-04-10 07:29:14] debug:    zh:controller:device: Interview - skip node descriptor request for '0xa4c138e388658fb0', already got it
[2026-04-10 07:29:14] debug:    zh:ember: ~~~> [ZDO ACTIVE_ENDPOINTS_REQUEST UNICAST to=0xa4c138e388658fb0:34203 messageTag=81 payload=519b85]
[2026-04-10 07:29:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=19 Len=24]
[2026-04-10 07:29:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=0](ackRx=3)
[2026-04-10 07:29:14] info:     z2m: Device '0xa4c138e388658fb0' joined
[2026-04-10 07:29:14] info:     z2m: Starting interview of '0xa4c138e388658fb0'
[2026-04-10 07:29:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_joined"}'
[2026-04-10 07:29:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"started"},"type":"device_interview"}'
[2026-04-10 07:29:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2026-04-10 07:29:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=4)
[2026-04-10 07:29:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=19 Len=7]
[2026-04-10 07:29:14] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=81 apsSequence=254 status=OK]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=4)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=35:"CHILD_JOIN_HANDLER" Seq=19 Len=18]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=true childId=34203 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=4)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=19 Len=37]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=BROADCAST apsFrame={"profileId":0,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":213} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=009b85b08f6588e338c1a480
[2026-04-10 07:29:15] debug:    zh:controller: Received ZDO response: clusterId=END_DEVICE_ANNOUNCE, status=SUCCESS, payload={"nwkAddress":34203,"eui64":"0xa4c138e388658fb0","capabilities":{"alternatePANCoordinator":0,"deviceType":0,"powerSource":0,"rxOnWhenIdle":0,"reserved1":0,"reserved2":0,"securityCapability":0,"allocateAddress":1}}
[2026-04-10 07:29:15] debug:    zh:controller: Device announce from '0xa4c138e388658fb0:34203'
[2026-04-10 07:29:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:15.455Z","linkquality":120}'
[2026-04-10 07:29:15] debug:    z2m: Device '0xa4c138e388658fb0' announced itself
[2026-04-10 07:29:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_announce"}'
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=4)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=19 Len=22]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":0,"clusterId":5,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":254} messageTag=81
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=4)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=19 Len=31]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32773,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":214} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=51009b850101
[2026-04-10 07:29:15] debug:    zh:controller: Received ZDO response: clusterId=ACTIVE_ENDPOINTS_RESPONSE, status=SUCCESS, payload={"nwkAddress":34203,"endpointList":[1]}
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - got active endpoints for device '0xa4c138e388658fb0'
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [ZDO SIMPLE_DESCRIPTOR_REQUEST UNICAST to=0xa4c138e388658fb0:34203 messageTag=82 payload=529b8501]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=20 Len=25]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=5](ackRx=4)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=5)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=20 Len=7]
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=82 apsSequence=255 status=OK]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=5)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=20 Len=22]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":0,"clusterId":4,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":255} messageTag=82
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=5)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=20 Len=50]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32772,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":215} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=52009b85140104010204010401000300000500000219000a00
[2026-04-10 07:29:15] debug:    zh:controller: Received ZDO response: clusterId=SIMPLE_DESCRIPTOR_RESPONSE, status=SUCCESS, payload={"nwkAddress":34203,"length":20,"endpoint":1,"profileId":260,"deviceId":1026,"deviceVersion":1,"inClusterList":[1,3,1280,0],"outClusterList":[25,10]}
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - got simple descriptor for endpoint '1' device '0xa4c138e388658fb0'
[2026-04-10 07:29:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["stackVersion"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":47,"commandIdentifier":0}]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=21 Len=26]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=0](ackRx=5)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=6)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=21 Len=7]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=0 messageTag=5 status=OK]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=6)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=21 Len=22]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} messageTag=5
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=6)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=21 Len=33]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":216} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=182f010200002000
[2026-04-10 07:29:15] debug:    zh:controller: Received payload: clusterID=0, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":47,"commandIdentifier":1},"payload":[{"attrId":2,"status":0,"dataType":32,"attrData":0}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"stackVersion":0}' from endpoint 1 with groupID 0
[2026-04-10 07:29:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:15.716Z","linkquality":108}'
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - got 'stackVersion' for device '0xa4c138e388658fb0'
[2026-04-10 07:29:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["dateCode"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":48,"commandIdentifier":0}]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=22 Len=26]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=3](ackRx=6)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=6 frmTx=7)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=7)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=22 Len=7]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=1 messageTag=6 status=OK]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=7)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=22 Len=22]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":1} messageTag=6
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=7)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=22 Len=33]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":217} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":104,"lastHopRssi":-74,"lastHopTimestamp":0} messageContents=1830010600004200
[2026-04-10 07:29:15] debug:    zh:controller: Received payload: clusterID=0, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=104, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":48,"commandIdentifier":1},"payload":[{"attrId":6,"status":0,"dataType":66,"attrData":""}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"dateCode":""}' from endpoint 1 with groupID 0
[2026-04-10 07:29:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:15.833Z","linkquality":104}'
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - got 'dateCode' for device '0xa4c138e388658fb0'
[2026-04-10 07:29:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":49,"commandIdentifier":0}]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=23 Len=26]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=6](ackRx=7)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=7 frmTx=0)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=0)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=23 Len=7]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=2 messageTag=7 status=OK]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=0)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=23 Len=22]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":2} messageTag=7
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=0)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=23 Len=31]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":218} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=183101004086
[2026-04-10 07:29:15] debug:    zh:controller: Received payload: clusterID=0, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":49,"commandIdentifier":1},"payload":[{"attrId":16384,"status":134}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{}' from endpoint 1 with groupID 0
[2026-04-10 07:29:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:15.946Z","linkquality":108}'
[2026-04-10 07:29:15] debug:    zh:controller:endpoint: Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE')
    at Endpoint.checkStatus (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:458:28)
    at Endpoint.zclCommand (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:1164:26)
    at processTicksAndRejections (node:internal/process/task_queues:105:5)
    at runNextTicks (node:internal/process/task_queues:69:3)
    at processImmediate (node:internal/timers:473:9)
    at Endpoint.read (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:597:29)
    at Device.interviewInternal (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/model/device.ts:970:42)
    at Device.interview (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/model/device.ts:787:13)
    at Controller.onDeviceJoined (/opt/zigbee2mqtt/node_modules/.pnpm/zigbee-herdsman@10.0.5/node_modules/zigbee-herdsman/src/controller/controller.ts:890:17)
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - failed to read attribute 'swBuildId' from endpoint '1' (Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE'))
[2026-04-10 07:29:15] debug:    zh:controller:device: Interview - IAS - enrolling '0xa4c138e388658fb0' endpoint '1'
[2026-04-10 07:29:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.read(["iasCieAddr","zoneState"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":50,"commandIdentifier":0}]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=24 Len=28]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=1](ackRx=0)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=0 frmTx=1)
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=1)
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=24 Len=7]
[2026-04-10 07:29:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=3 messageTag=8 status=OK]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=1)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=24 Len=22]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":3} messageTag=8
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=1)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=24 Len=45]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":219} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=183201100000f0aaeaa51c004b12000000003000
[2026-04-10 07:29:16] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":50,"commandIdentifier":1},"payload":[{"attrId":16,"status":0,"dataType":240,"attrData":"0x00124b001ca5eaaa"},{"attrId":0,"status":0,"dataType":48,"attrData":0}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:16] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'ssIasZone', data '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":0}' from endpoint 1 with groupID 0
[2026-04-10 07:29:16] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:16.073Z","linkquality":108}'
[2026-04-10 07:29:16] debug:    zh:controller:device: Interview - IAS - before enrolling state: '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":0}'
[2026-04-10 07:29:16] debug:    zh:controller:device: Interview - IAS - not enrolled, enrolling
[2026-04-10 07:29:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.write({"iasCieAddr":"0x00124b001ca5eaaa"}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":51,"commandIdentifier":2}]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=25 Len=35]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=4](ackRx=1)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=1 frmTx=2)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=2)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=25 Len=7]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=4 messageTag=9 status=OK]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=2)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=25 Len=22]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":4} messageTag=9
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=25 Len=29]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":220} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":100,"lastHopRssi":-75,"lastHopTimestamp":0} messageContents=18330400
[2026-04-10 07:29:16] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=100, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":51,"commandIdentifier":4},"payload":[{"status":0}],"command":{"name":"writeRsp","ID":4}}
[2026-04-10 07:29:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:16.197Z","linkquality":100}'
[2026-04-10 07:29:16] debug:    zh:controller:device: Interview - IAS - wrote iasCieAddr
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=2)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=25 Len=32]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":221} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":104,"lastHopRssi":-74,"lastHopTimestamp":0} messageContents=0947012a000210
[2026-04-10 07:29:16] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=104, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":71,"commandIdentifier":1},"payload":{"zonetype":42,"manucode":4098},"command":{"name":"enrollReq","ID":1,"parameters":[{"name":"zonetype","type":49},{"name":"manucode","type":33}],"required":true}}
[2026-04-10 07:29:16] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' responding to enroll response
[2026-04-10 07:29:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 07:29:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":52,"commandIdentifier":0}]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=26 Len=26]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=0](ackRx=2)
[2026-04-10 07:29:16] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'commandEnrollReq', cluster 'ssIasZone', data '{"manucode":4098,"zonetype":42}' from endpoint 1 with groupID 0
[2026-04-10 07:29:16] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:16.204Z","linkquality":104}'
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=2 frmTx=3)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=3)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=26 Len=7]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=5 messageTag=10 status=OK]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=3)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=26 Len=22]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":5} messageTag=10
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=3)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=26 Len=22]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65533 apsFrame={"profileId":0,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":213} messageTag=255
[2026-04-10 07:29:16] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' sending enroll response (auto enroll)
[2026-04-10 07:29:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":53,"commandIdentifier":0}]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=27 Len=26]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=3](ackRx=3)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=4)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=27 Len=7]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=7 messageTag=11 status=OK]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=4)
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=27 Len=22]
[2026-04-10 07:29:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":7} messageTag=11
[2026-04-10 07:29:17] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.read(["iasCieAddr","zoneState"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":54,"commandIdentifier":0}]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=28 Len=28]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=5](ackRx=4)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=5)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=28 Len=7]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=8 messageTag=12 status=OK]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=5)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=28 Len=32]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":225} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=0947012a000210
[2026-04-10 07:29:17] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=116, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":71,"commandIdentifier":1},"payload":{"zonetype":42,"manucode":4098},"command":{"name":"enrollReq","ID":1,"parameters":[{"name":"zonetype","type":49},{"name":"manucode","type":33}],"required":true}}
[2026-04-10 07:29:17] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' responding to enroll response
[2026-04-10 07:29:17] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 07:29:17] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'commandEnrollReq', cluster 'ssIasZone', data '{"manucode":4098,"zonetype":42}' from endpoint 1 with groupID 0
[2026-04-10 07:29:17] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:17.399Z","linkquality":116}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=5)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=28 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":8} messageTag=12
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=5)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=28 Len=45]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":226} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=183601100000f0aaeaa51c004b12000000003001
[2026-04-10 07:29:17] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=116, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":54,"commandIdentifier":1},"payload":[{"attrId":16,"status":0,"dataType":240,"attrData":"0x00124b001ca5eaaa"},{"attrId":0,"status":0,"dataType":48,"attrData":1}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:17] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'ssIasZone', data '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}' from endpoint 1 with groupID 0
[2026-04-10 07:29:17] debug:    z2m: Skipping message, still interviewing
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T04:29:17.440Z","linkquality":116}'
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":55,"commandIdentifier":0}]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=29 Len=26]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=1](ackRx=5)
[2026-04-10 07:29:17] debug:    zh:controller:device: Interview - IAS - after enrolling state (0): '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}'
[2026-04-10 07:29:17] debug:    zh:controller:device: Interview - IAS successfully enrolled '0xa4c138e388658fb0' endpoint '1'
[2026-04-10 07:29:17] debug:    zh:controller:device: Interview - completed for device '0xa4c138e388658fb0'
[2026-04-10 07:29:17] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:17] info:     zh:controller: Succesfully interviewed '0xa4c138e388658fb0'
[2026-04-10 07:29:17] info:     z2m: Successfully interviewed '0xa4c138e388658fb0', device has successfully been paired
[2026-04-10 07:29:17] info:     z2m: Device '0xa4c138e388658fb0' is supported, identified as: Tuya Water leak detector (TS0207_water_leak_detector)
[2026-04-10 07:29:17] info:     z2m: Configuring '0xa4c138e388658fb0'
[2026-04-10 07:29:17] debug:    zh:controller:endpoint: Bind 0xa4c138e388658fb0/1 genPowerCfg from '0x00124b001ca5eaaa/1'
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/water_leak/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_water_leak","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"moisture","object_id":"0xa4c138e388658fb0_water_leak","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_water_leak_zigbee2mqtt","value_template":"{{ value_json.water_leak }}"}'
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"definition":{"description":"Water leak detector","exposes":[{"access":1,"description":"Indicates whether the device detected a water leak","label":"Water leak","name":"water_leak","property":"water_leak","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Indicates if the battery of this device is almost empty","label":"Battery low","name":"battery_low","property":"battery_low","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Remaining battery in %, can take up to 24 hours before reported","label":"Battery","name":"battery","property":"battery","type":"numeric","unit":"%","value_max":100,"value_min":0},{"access":1,"description":"Indicates whether the device is tampered","label":"Tamper","name":"tamper","property":"tamper","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Link quality (signal strength)","label":"Linkquality","name":"linkquality","property":"linkquality","type":"numeric","unit":"lqi","value_max":255,"value_min":0}],"model":"TS0207_water_leak_detector","options":[],"source":"native","supports_ota":false,"vendor":"Tuya","version":"0.0.0"},"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"successful","supported":true},"type":"device_interview"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=6)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=29 Len=7]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=9 messageTag=13 status=OK]
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [ZDO BIND_REQUEST UNICAST to=0xa4c138e388658fb0:34203 messageTag=83 payload=53b08f6588e338c1a401010003aaeaa51c004b120001]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=30 Len=43]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=2](ackRx=6)
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/battery_low/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_battery_low","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"battery","entity_category":"diagnostic","object_id":"0xa4c138e388658fb0_battery_low","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_battery_low_zigbee2mqtt","value_template":"{{ value_json.battery_low }}"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=6 frmTx=7)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=7)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=30 Len=7]
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=83 apsSequence=10 status=OK]
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/battery/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_battery","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"battery","enabled_by_default":true,"entity_category":"diagnostic","object_id":"0xa4c138e388658fb0_battery","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"state_class":"measurement","state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_battery_zigbee2mqtt","unit_of_measurement":"%","value_template":"{{ value_json.battery }}"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=7)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=30 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":9} messageTag=13
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/tamper/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_tamper","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"tamper","object_id":"0xa4c138e388658fb0_tamper","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_tamper_zigbee2mqtt","value_template":"{{ value_json.tamper }}"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=7)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=30 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":0,"clusterId":33,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":10} messageTag=83
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=7)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=30 Len=27]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32801,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":227} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=5300
[2026-04-10 07:29:17] debug:    zh:controller: Received ZDO response: clusterId=BIND_RESPONSE, status=SUCCESS, payload=undefined
[2026-04-10 07:29:17] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:17] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.configReport([{"attribute":"batteryPercentageRemaining","minimumReportInterval":3600,"maximumReportInterval":65000,"reportableChange":0}], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":56,"commandIdentifier":6}]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=31 Len=33]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=6](ackRx=7)
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/linkquality/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_linkquality","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"enabled_by_default":false,"entity_category":"diagnostic","icon":"mdi:signal","name":"Linkquality","object_id":"0xa4c138e388658fb0_linkquality","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"state_class":"measurement","state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_linkquality_zigbee2mqtt","unit_of_measurement":"lqi","value_template":"{{ value_json.linkquality }}"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=7 frmTx=0)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=0)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=31 Len=7]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=11 messageTag=14 status=OK]
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/last_seen/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_last_seen","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"timestamp","enabled_by_default":false,"entity_category":"diagnostic","icon":"mdi:clock","name":"Last seen","object_id":"0xa4c138e388658fb0_last_seen","origin":{"name":"Zigbee2MQTT","sw":"2.9.2","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_last_seen_zigbee2mqtt","value_template":"{{ value_json.last_seen }}"}'
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=0)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=31 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65532 apsFrame={"profileId":0,"clusterId":0,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":224} messageTag=255
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=0)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=31 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":11} messageTag=14
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=0)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=31 Len=32]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":228} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":112,"lastHopRssi":-72,"lastHopTimestamp":0} messageContents=18380700002100
[2026-04-10 07:29:17] debug:    zh:controller: Received payload: clusterID=1, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=112, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":56,"commandIdentifier":7},"payload":[{"status":0}],"command":{"name":"configReportRsp","ID":7}}
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":null,"battery_low":null,"last_seen":"2026-04-10T04:29:17.705Z","linkquality":112,"tamper":null,"water_leak":null}'
[2026-04-10 07:29:17] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:17] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.read(["batteryPercentageRemaining"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 07:29:17] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":57,"commandIdentifier":0}]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=32 Len=26]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=2](ackRx=0)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=0 frmTx=1)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=1)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=32 Len=7]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=12 messageTag=15 status=OK]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=1)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=32 Len=22]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":12} messageTag=15
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:17] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=1)
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=32 Len=33]
[2026-04-10 07:29:17] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":229} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":112,"lastHopRssi":-72,"lastHopTimestamp":0} messageContents=18390121000020c8
[2026-04-10 07:29:17] debug:    zh:controller: Received payload: clusterID=1, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=112, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":57,"commandIdentifier":1},"payload":[{"attrId":33,"status":0,"dataType":32,"attrData":200}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 07:29:17] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genPowerCfg', data '{"batteryPercentageRemaining":200}' from endpoint 1 with groupID 0
[2026-04-10 07:29:17] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-10T04:29:17.819Z","linkquality":112,"tamper":null,"water_leak":null}'
[2026-04-10 07:29:17] info:     z2m: Successfully configured '0xa4c138e388658fb0' (definition v0.0.0)
[2026-04-10 07:29:17] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=1)
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=32 Len=32]
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":230} packetInfo:{"senderShortId":34203,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=0947012a000210
[2026-04-10 07:29:18] debug:    zh:controller: Received payload: clusterID=1280, address=34203, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=116, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":71,"commandIdentifier":1},"payload":{"zonetype":42,"manucode":4098},"command":{"name":"enrollReq","ID":1,"parameters":[{"name":"zonetype","type":49},{"name":"manucode","type":33}],"required":true}}
[2026-04-10 07:29:18] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' responding to enroll response
[2026-04-10 07:29:18] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 07:29:18] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":58,"commandIdentifier":0}]
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=33 Len=26]
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=6](ackRx=1)
[2026-04-10 07:29:18] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'commandEnrollReq', cluster 'ssIasZone', data '{"manucode":4098,"zonetype":42}' from endpoint 1 with groupID 0
[2026-04-10 07:29:18] debug:    z2m: No converter available for 'TS0207_water_leak_detector' with cluster 'ssIasZone' and type 'commandEnrollReq' and data '{"manucode":4098,"zonetype":42}'
[2026-04-10 07:29:18] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-10T04:29:18.600Z","linkquality":116,"tamper":null,"water_leak":null}'
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=1 frmTx=2)
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2)
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=33 Len=7]
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=13 messageTag=16 status=OK]
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:18] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=2)
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=33 Len=22]
[2026-04-10 07:29:18] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=34203 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":13} messageTag=16
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=2)
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=33 Len=18]
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=9524 sourceEui=0xa4c138ddace780ac lastHopLqi=112 lastHopRssi=-72 relayCount=0 relayList=
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=2)
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":198} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":112,"lastHopRssi":-72,"lastHopTimestamp":0} messageContents=188b0a0805216a02
[2026-04-10 07:29:20] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=112, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":139,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":618}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:20] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":618}' from endpoint 1 with groupID 0
[2026-04-10 07:29:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.62,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:20.901Z","linkquality":112,"power":74,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:20] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=2)
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:20] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":199} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":112,"lastHopRssi":-72,"lastHopTimestamp":0} messageContents=188c0a0b05296900
[2026-04-10 07:29:20] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=112, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":140,"commandIdentifier":10},"payload":[{"attrId":1291,"dataType":41,"attrData":105}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:20] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":105}' from endpoint 1 with groupID 0
[2026-04-10 07:29:20] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.62,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:20.909Z","linkquality":112,"power":105,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:22] debug:    z2m: Saving state to file /opt/zigbee2mqtt/data/state.json
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=2)
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=33 Len=20]
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=11293 sourceEui=0xa4c138b653567266 lastHopLqi=132 lastHopRssi=-67 relayCount=1 relayList=46193
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=2)
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":35} packetInfo:{"senderShortId":11293,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":136,"lastHopRssi":-66,"lastHopTimestamp":0} messageContents=18810a0805217319
[2026-04-10 07:29:23] debug:    zh:controller: Received payload: clusterID=2820, address=11293, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=136, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":129,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":6515}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:23] debug:    z2m: Received Zigbee message from 'Dishwasher', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":6515}' from endpoint 1 with groupID 0
[2026-04-10 07:29:23] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Dishwasher', payload '{"child_lock":null,"countdown":0,"current":6.52,"energy":843.06,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:23.347Z","linkquality":136,"power":1469,"power_outage_memory":null,"state":"ON","switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":231}'
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=2)
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=33 Len=18]
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=214 sourceEui=0xa4c138627a9b0ac3 lastHopLqi=88 lastHopRssi=-78 relayCount=0 relayList=
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:23] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2)
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:23] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":168} packetInfo:{"senderShortId":214,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":84,"lastHopRssi":-79,"lastHopTimestamp":0} messageContents=18c60a080521a300
[2026-04-10 07:29:23] debug:    zh:controller: Received payload: clusterID=2820, address=214, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=84, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":198,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":163}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:23] debug:    z2m: Received Zigbee message from '3D printer', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":163}' from endpoint 1 with groupID 0
[2026-04-10 07:29:23] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/3D printer', payload '{"child_lock":null,"countdown":null,"current":0.16,"energy":220.92,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:23.490Z","linkquality":84,"power":6,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":227}'
[2026-04-10 07:29:24] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=2)
[2026-04-10 07:29:25] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:25] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":200} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":104,"lastHopRssi":-74,"lastHopTimestamp":0} messageContents=188d0a0805212702
[2026-04-10 07:29:25] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=104, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":141,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":551}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:25] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":551}' from endpoint 1 with groupID 0
[2026-04-10 07:29:25] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.55,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:25.895Z","linkquality":104,"power":105,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:25] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=2)
[2026-04-10 07:29:25] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=33]
[2026-04-10 07:29:25] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":201} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=188e0a0b05295600
[2026-04-10 07:29:25] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":142,"commandIdentifier":10},"payload":[{"attrId":1291,"dataType":41,"attrData":86}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:25] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":86}' from endpoint 1 with groupID 0
[2026-04-10 07:29:25] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.55,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:25.902Z","linkquality":108,"power":86,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=2)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=33 Len=18]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=1870 sourceEui=0xa4c138942612eda9 lastHopLqi=156 lastHopRssi=-61 relayCount=0 relayList=
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=2)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=33 Len=43]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":255} packetInfo:{"senderShortId":1870,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":156,"lastHopRssi":-61,"lastHopTimestamp":0} messageContents=08f60a050521ed0008052100000b05290000
[2026-04-10 07:29:27] debug:    zh:controller: Received payload: clusterID=2820, address=1870, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=156, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":246,"commandIdentifier":10},"payload":[{"attrId":1285,"dataType":33,"attrData":237},{"attrId":1288,"dataType":33,"attrData":0},{"attrId":1291,"dataType":41,"attrData":0}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:27] debug:    zh:controller:endpoint: ZCL command 0xa4c138942612eda9/1 haElectricalMeasurement.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":246,"writeUndiv":false})
[2026-04-10 07:29:27] debug:    zh:ember: ~~~> [ZCL to=0xa4c138942612eda9:1870 apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":246,"commandIdentifier":11}]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=34 Len=26]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=3](ackRx=2)
[2026-04-10 07:29:27] debug:    z2m: Received Zigbee message from 'Closet', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":0,"rmsCurrent":0,"rmsVoltage":237}' from endpoint 1 with groupID 0
[2026-04-10 07:29:27] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Closet', payload '{"child_lock":null,"countdown":null,"current":0,"energy":257.96,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:27.203Z","linkquality":156,"power":0,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":237}'
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=2 frmTx=3)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=3)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=34 Len=7]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=16 messageTag=17 status=OK]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=3)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=34 Len=22]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=1870 apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":16} messageTag=17
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=3)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=34 Len=37]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":0} packetInfo:{"senderShortId":1870,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":156,"lastHopRssi":-61,"lastHopTimestamp":0} messageContents=08f70a000025c46400000000
[2026-04-10 07:29:27] debug:    zh:controller: Received payload: clusterID=1794, address=1870, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=156, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":247,"commandIdentifier":10},"payload":[{"attrId":0,"dataType":37,"attrData":25796}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:27] debug:    zh:controller:endpoint: ZCL command 0xa4c138942612eda9/1 seMetering.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":247,"writeUndiv":false})
[2026-04-10 07:29:27] debug:    zh:ember: ~~~> [ZCL to=0xa4c138942612eda9:1870 apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":247,"commandIdentifier":11}]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=35 Len=26]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=6](ackRx=3)
[2026-04-10 07:29:27] debug:    z2m: Received Zigbee message from 'Closet', type 'attributeReport', cluster 'seMetering', data '{"currentSummDelivered":25796}' from endpoint 1 with groupID 0
[2026-04-10 07:29:27] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Closet', payload '{"child_lock":null,"countdown":null,"current":0,"energy":257.96,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:27.254Z","linkquality":156,"power":0,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":237}'
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=4)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=35 Len=7]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=17 messageTag=18 status=OK]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=4)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=35 Len=22]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=1870 apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":17} messageTag=18
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:27] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=4)
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=35 Len=22]
[2026-04-10 07:29:27] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65532 apsFrame={"profileId":0,"clusterId":0,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":235} messageTag=255
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=4)
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=35 Len=37]
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":36} packetInfo:{"senderShortId":11293,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":136,"lastHopRssi":-66,"lastHopTimestamp":0} messageContents=08820a000025534901000000
[2026-04-10 07:29:29] debug:    zh:controller: Received payload: clusterID=1794, address=11293, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=136, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":130,"commandIdentifier":10},"payload":[{"attrId":0,"dataType":37,"attrData":84307}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:29] debug:    zh:controller:endpoint: ZCL command 0xa4c138b653567266/1 seMetering.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":130,"writeUndiv":false})
[2026-04-10 07:29:29] debug:    zh:ember: ~~~> [ZCL to=0xa4c138b653567266:11293 apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":1,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":130,"commandIdentifier":11}]
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=36 Len=26]
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=2](ackRx=4)
[2026-04-10 07:29:29] debug:    z2m: Received Zigbee message from 'Dishwasher', type 'attributeReport', cluster 'seMetering', data '{"currentSummDelivered":84307}' from endpoint 1 with groupID 0
[2026-04-10 07:29:29] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Dishwasher', payload '{"child_lock":null,"countdown":0,"current":6.52,"energy":843.07,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:29.549Z","linkquality":136,"power":1469,"power_outage_memory":null,"state":"ON","switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":231}'
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=5)
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=36 Len=7]
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=18 messageTag=19 status=OK]
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 07:29:29] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=5)
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=36 Len=22]
[2026-04-10 07:29:29] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=11293 apsFrame={"profileId":260,"clusterId":1794,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":18} messageTag=19
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=5)
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=36 Len=39]
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":253} packetInfo:{"senderShortId":18272,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":84,"lastHopRssi":-79,"lastHopTimestamp":0} messageContents=08360a01002046e2ff201fe4ff2000
[2026-04-10 07:29:30] debug:    zh:controller: Received payload: clusterID=0, address=18272, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=84, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":54,"commandIdentifier":10},"payload":[{"attrId":1,"dataType":32,"attrData":70},{"attrId":65506,"dataType":32,"attrData":31},{"attrId":65508,"dataType":32,"attrData":0}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:30] debug:    zh:controller:endpoint: ZCL command 0x187a3efffefadb86/1 genBasic.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"reservedBits":0,"transactionSequenceNumber":54,"writeUndiv":false})
[2026-04-10 07:29:30] debug:    zh:ember: ~~~> [ZCL to=0x187a3efffefadb86:18272 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":54,"commandIdentifier":11}]
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=37 Len=26]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=5](ackRx=5)
[2026-04-10 07:29:30] debug:    z2m: Received Zigbee message from 'Storage room presence', type 'attributeReport', cluster 'genBasic', data '{"65506":31,"65508":0,"appVersion":70}' from endpoint 1 with groupID 0
[2026-04-10 07:29:30] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Storage room presence', payload '{"block_time":null,"breaker_mode":null,"breaker_status":null,"departure_delay":null,"detection_range":null,"entry_distance_indentation":null,"entry_filter_time":null,"entry_sensitivity":null,"illuminance":0,"illuminance_threshold":null,"last_seen":"2026-04-10T04:29:30.251Z","linkquality":84,"presence":false,"radar_sensitivity":null,"sensor":null,"shield_range":null,"status_indication":null,"target_distance":0}'
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6)
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=6)
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=37 Len=7]
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=19 messageTag=20 status=OK]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=6)
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=37 Len=22]
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=18272 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":19} messageTag=20
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 07:29:30] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=6)
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=37 Len=33]
[2026-04-10 07:29:30] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":202} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=188f0a0b05294800
[2026-04-10 07:29:30] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=116, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":143,"commandIdentifier":10},"payload":[{"attrId":1291,"dataType":41,"attrData":72}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:30] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":72}' from endpoint 1 with groupID 0
[2026-04-10 07:29:30] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.55,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:30.894Z","linkquality":116,"power":72,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:32] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:32] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:32] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 07:29:32] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=6)
[2026-04-10 07:29:32] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=37 Len=33]
[2026-04-10 07:29:32] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":203} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":116,"lastHopRssi":-71,"lastHopTimestamp":0} messageContents=18900a080521f301
[2026-04-10 07:29:32] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=116, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":144,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":499}],"command":{"name":"report","ID":10}}
[2026-04-10 07:29:32] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":499}' from endpoint 1 with groupID 0
[2026-04-10 07:29:32] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.5,"energy":1155.41,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T04:29:32.894Z","linkquality":116,"power":72,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":225}'
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=6)
[2026-04-10 07:29:36] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=35:"CHILD_JOIN_HANDLER" Seq=37 Len=18]
[2026-04-10 07:29:36] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=false childId=34203 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 07:29:36] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=6)
[2026-04-10 07:29:36] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=36:"TRUST_CENTER_JOIN_HANDLER" Seq=37 Len=19]
[2026-04-10 07:29:36] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=34203 newNodeEui64=0xa4c138e388658fb0 status=DEVICE_LEFT policyDecision=NO_ACTION parentOfNewNodeId=65535
[2026-04-10 07:29:36] debug:    zh:controller: Device leave '0xa4c138e388658fb0'
[2026-04-10 07:29:36] debug:    zh:controller: Removing device from database '0xa4c138e388658fb0'
[2026-04-10 07:29:36] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 07:29:36] warning:  z2m: Device '0xa4c138e388658fb0' left the network
[2026-04-10 07:29:36] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_leave"}'

[Nerivec]

The flow in the logs goes like this:

• device requests enroll
• Z2M sends enroll response
• Z2M sends unsolicited enroll response as part of interview
• device requests enroll <= this should not happen

The TSN mismatch was fixed in #1716, so that device-initiated retry might be fixed in current dev branch, any chance you can try it, and get a fresh log like this again?
https://www.zigbee2mqtt.io/advanced/more/switch-to-dev-branch.html

How can I update the coordinator? I am on latest offered OTA firmware.

Last from SMLight is 8.x.x as far as I known, unless they're behind on the MRU series...

[TSparkas]

Installed 2.9.2-dev and took log again. Behavior is a bit different, but as I understand, the duplicate enrollRsp is still present. Yes, looks like SMLight is behind on the MRU series with firmware.

[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=9425 newNodeEui64=0xa4c138e388658fb0 status=STANDARD_SECURITY_UNSECURED_JOIN policyDecision=USE_PRECONFIGURED_KEY parentOfNewNodeId=0
[2026-04-10 15:31:14] debug:    zh:controller: Device '0xa4c138e388658fb0' joined
[2026-04-10 15:31:14] debug:    zh:controller: Device '0xa4c138e388658fb0' accepted by handler
[2026-04-10 15:31:14] debug:    zh:controller: Deleted device '0xa4c138e388658fb0' joined, undeleting
[2026-04-10 15:31:14] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:14.011Z","linkquality":80}'
[2026-04-10 15:31:14] info:     zh:controller: Interview for '0xa4c138e388658fb0' started
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - start device '0xa4c138e388658fb0'
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - skip node descriptor request for '0xa4c138e388658fb0', already got it
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [ZDO ACTIVE_ENDPOINTS_REQUEST UNICAST to=0xa4c138e388658fb0:9425 messageTag=35 payload=23d124]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=206 Len=24]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=1](ackRx=6)
[2026-04-10 15:31:14] info:     z2m: Device '0xa4c138e388658fb0' joined
[2026-04-10 15:31:14] info:     z2m: Starting interview of '0xa4c138e388658fb0'
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_joined"}'
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"started"},"type":"device_interview"}'
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=6 frmTx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=206 Len=7]
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=35 apsSequence=209 status=OK]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=35:"CHILD_JOIN_HANDLER" Seq=206 Len=18]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=true childId=9425 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=206 Len=37]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=BROADCAST apsFrame={"profileId":0,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":27} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=00d124b08f6588e338c1a480
[2026-04-10 15:31:14] debug:    zh:controller: Received ZDO response: clusterId=END_DEVICE_ANNOUNCE, status=SUCCESS, payload={"nwkAddress":9425,"eui64":"0xa4c138e388658fb0","capabilities":{"alternatePANCoordinator":0,"deviceType":0,"powerSource":0,"rxOnWhenIdle":0,"reserved1":0,"reserved2":0,"securityCapability":0,"allocateAddress":1}}
[2026-04-10 15:31:14] debug:    zh:controller: Device announce from '0xa4c138e388658fb0:9425'
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:14.540Z","linkquality":80}'
[2026-04-10 15:31:14] debug:    z2m: Device '0xa4c138e388658fb0' announced itself
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0"},"type":"device_announce"}'
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=206 Len=22]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":0,"clusterId":5,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":209} messageTag=35
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=206 Len=31]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32773,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":28} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=2300d1240101
[2026-04-10 15:31:14] debug:    zh:controller: Received ZDO response: clusterId=ACTIVE_ENDPOINTS_RESPONSE, status=SUCCESS, payload={"nwkAddress":9425,"endpointList":[1]}
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - got active endpoints for device '0xa4c138e388658fb0'
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [ZDO SIMPLE_DESCRIPTOR_REQUEST UNICAST to=0xa4c138e388658fb0:9425 messageTag=36 payload=24d12401]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=207 Len=25]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=6](ackRx=7)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=7 frmTx=0)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=0)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=207 Len=7]
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=36 apsSequence=210 status=OK]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=0)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=207 Len=22]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":0,"clusterId":4,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":210} messageTag=36
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=0)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=207 Len=50]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32772,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":29} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=2400d124140104010204010401000300000500000219000a00
[2026-04-10 15:31:14] debug:    zh:controller: Received ZDO response: clusterId=SIMPLE_DESCRIPTOR_RESPONSE, status=SUCCESS, payload={"nwkAddress":9425,"length":20,"endpoint":1,"profileId":260,"deviceId":1026,"deviceVersion":1,"inClusterList":[1,3,1280,0],"outClusterList":[25,10]}
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - got simple descriptor for endpoint '1' device '0xa4c138e388658fb0'
[2026-04-10 15:31:14] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["stackVersion"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":77,"commandIdentifier":0}]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=208 Len=26]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=1](ackRx=0)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=0 frmTx=1)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=1)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=208 Len=7]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=211 messageTag=2 status=OK]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=1)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=208 Len=22]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":211} messageTag=2
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=1)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=208 Len=33]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":30} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=184d010200002000
[2026-04-10 15:31:14] debug:    zh:controller: Received payload: clusterID=0, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":77,"commandIdentifier":1},"payload":[{"attrId":2,"status":0,"dataType":32,"attrData":0}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:14] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"stackVersion":0}' from endpoint 1 with groupID 0
[2026-04-10 15:31:14] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:14.787Z","linkquality":120}'
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - got 'stackVersion' for device '0xa4c138e388658fb0'
[2026-04-10 15:31:14] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["dateCode"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":78,"commandIdentifier":0}]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=209 Len=26]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=4](ackRx=1)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=1 frmTx=2)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=2)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=209 Len=7]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=212 messageTag=3 status=OK]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=2)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=209 Len=22]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":212} messageTag=3
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=209 Len=33]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":31} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=184e010600004200
[2026-04-10 15:31:14] debug:    zh:controller: Received payload: clusterID=0, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":78,"commandIdentifier":1},"payload":[{"attrId":6,"status":0,"dataType":66,"attrData":""}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:14] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{"dateCode":""}' from endpoint 1 with groupID 0
[2026-04-10 15:31:14] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:14] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:14.926Z","linkquality":120}'
[2026-04-10 15:31:14] debug:    zh:controller:device: Interview - got 'dateCode' for device '0xa4c138e388658fb0'
[2026-04-10 15:31:14] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:14] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":79,"commandIdentifier":0}]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=210 Len=26]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=7](ackRx=2)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=2 frmTx=3)
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:14] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=3)
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=210 Len=7]
[2026-04-10 15:31:14] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=213 messageTag=4 status=OK]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=3)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=210 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":213} messageTag=4
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=3)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=210 Len=31]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":32} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=184f01004086
[2026-04-10 15:31:15] debug:    zh:controller: Received payload: clusterID=0, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":79,"commandIdentifier":1},"payload":[{"attrId":16384,"status":134}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genBasic', data '{}' from endpoint 1 with groupID 0
[2026-04-10 15:31:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:15.034Z","linkquality":120}'
[2026-04-10 15:31:15] debug:    zh:controller:endpoint: Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE')
    at Endpoint.checkStatus (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:458:28)
    at Endpoint.zclCommand (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:1179:26)
    at processTicksAndRejections (node:internal/process/task_queues:105:5)
    at runNextTicks (node:internal/process/task_queues:69:3)
    at processImmediate (node:internal/timers:473:9)
    at Endpoint.read (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/model/endpoint.ts:597:29)
    at Device.interviewInternal (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/model/device.ts:1025:42)
    at Device.interview (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/model/device.ts:842:13)
    at Controller.onDeviceJoined (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/controller/controller.ts:894:17)
[2026-04-10 15:31:15] debug:    zh:controller:device: Interview - failed to read attribute 'swBuildId' from endpoint '1' (Error: ZCL command 0xa4c138e388658fb0/1 genBasic.read(["swBuildId"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"}) failed (Status 'UNSUPPORTED_ATTRIBUTE'))
[2026-04-10 15:31:15] debug:    zh:controller:device: Interview - IAS - enrolling '0xa4c138e388658fb0' endpoint '1'
[2026-04-10 15:31:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.read(["iasCieAddr","zoneState"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":80,"commandIdentifier":0}]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=211 Len=28]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=2](ackRx=3)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=4)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=211 Len=7]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=214 messageTag=5 status=OK]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=4)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=211 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":214} messageTag=5
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=4)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=211 Len=45]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":33} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=185001100000f0aaeaa51c004b12000000003000
[2026-04-10 15:31:15] debug:    zh:controller: Received payload: clusterID=1280, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":80,"commandIdentifier":1},"payload":[{"attrId":16,"status":0,"dataType":240,"attrData":"0x00124b001ca5eaaa"},{"attrId":0,"status":0,"dataType":48,"attrData":0}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'ssIasZone', data '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":0}' from endpoint 1 with groupID 0
[2026-04-10 15:31:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:15.152Z","linkquality":120}'
[2026-04-10 15:31:15] debug:    zh:controller:device: Interview - IAS - before enrolling state: '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":0}'
[2026-04-10 15:31:15] debug:    zh:controller:device: Interview - IAS - not enrolled, enrolling
[2026-04-10 15:31:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.write({"iasCieAddr":"0x00124b001ca5eaaa"}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":81,"commandIdentifier":2}]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=212 Len=35]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=5](ackRx=4)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=5)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=212 Len=7]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=215 messageTag=6 status=OK]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=5)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=212 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":215} messageTag=6
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=5)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=212 Len=29]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":34} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=18510400
[2026-04-10 15:31:15] debug:    zh:controller: Received payload: clusterID=1280, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":81,"commandIdentifier":4},"payload":[{"status":0}],"command":{"name":"writeRsp","ID":4}}
[2026-04-10 15:31:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:15.286Z","linkquality":120}'
[2026-04-10 15:31:15] debug:    zh:controller:device: Interview - IAS - wrote iasCieAddr
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=5)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=212 Len=32]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":35} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=092a012a000210
[2026-04-10 15:31:15] debug:    zh:controller: Received payload: clusterID=1280, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":42,"commandIdentifier":1},"payload":{"zonetype":42,"manucode":4098},"command":{"name":"enrollReq","ID":1,"parameters":[{"name":"zonetype","type":49},{"name":"manucode","type":33}],"required":true}}
[2026-04-10 15:31:15] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' responding to enroll response
[2026-04-10 15:31:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"transactionSequenceNumber":42,"writeUndiv":false})
[2026-04-10 15:31:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":42,"commandIdentifier":0}]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=213 Len=26]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=1](ackRx=5)
[2026-04-10 15:31:15] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'commandEnrollReq', cluster 'ssIasZone', data '{"manucode":4098,"zonetype":42}' from endpoint 1 with groupID 0
[2026-04-10 15:31:15] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:15] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:15.293Z","linkquality":120}'
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=5 frmTx=6)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=6)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=213 Len=7]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=216 messageTag=7 status=OK]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=6)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=213 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":216} messageTag=7
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6](ackRx=6 frmTx=6)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=6)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=213 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65533 apsFrame={"profileId":0,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":27} messageTag=255
[2026-04-10 15:31:15] debug:    zh:controller:device: IAS - '0xa4c138e388658fb0' sending enroll response (auto enroll)
[2026-04-10 15:31:15] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.enrollRsp({"enrollrspcode":0,"zoneid":23}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:15] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":1,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":82,"commandIdentifier":0}]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=214 Len=26]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=4](ackRx=6)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=6 frmTx=7)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=7)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=214 Len=7]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=218 messageTag=8 status=OK]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7](ackRx=7 frmTx=7)
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:15] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=7)
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=214 Len=22]
[2026-04-10 15:31:15] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":218} messageTag=8
[2026-04-10 15:31:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 ssIasZone.read(["iasCieAddr","zoneState"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false,"sendPolicy":"immediate"})
[2026-04-10 15:31:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":83,"commandIdentifier":0}]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=215 Len=28]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=6](ackRx=7)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=7 frmTx=0)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=0)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=215 Len=7]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=219 messageTag=9 status=OK]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=0)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=215 Len=33]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":246} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=186b0a0805215f03
[2026-04-10 15:31:16] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":107,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":863}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:16] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":863}' from endpoint 1 with groupID 0
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.86,"energy":1155.71,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:16.327Z","linkquality":108,"power":131,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":233}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=0)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=215 Len=33]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":247} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":112,"lastHopRssi":-72,"lastHopTimestamp":0} messageContents=186c0a0b05299d00
[2026-04-10 15:31:16] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=112, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":108,"commandIdentifier":10},"payload":[{"attrId":1291,"dataType":41,"attrData":157}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:16] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":157}' from endpoint 1 with groupID 0
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.86,"energy":1155.71,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:16.334Z","linkquality":112,"power":157,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":233}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=0)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=215 Len=22]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":219} messageTag=9
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0](ackRx=0 frmTx=0)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=0)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=215 Len=45]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1280,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":39} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=185301100000f0aaeaa51c004b12000000003001
[2026-04-10 15:31:16] debug:    zh:controller: Received payload: clusterID=1280, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":83,"commandIdentifier":1},"payload":[{"attrId":16,"status":0,"dataType":240,"attrData":"0x00124b001ca5eaaa"},{"attrId":0,"status":0,"dataType":48,"attrData":1}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:16] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'ssIasZone', data '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}' from endpoint 1 with groupID 0
[2026-04-10 15:31:16] debug:    z2m: Skipping message, still interviewing
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"last_seen":"2026-04-10T12:31:16.524Z","linkquality":120}'
[2026-04-10 15:31:16] debug:    zh:controller:device: Interview - IAS - after enrolling state (0): '{"iasCieAddr":"0x00124b001ca5eaaa","zoneState":1}'
[2026-04-10 15:31:16] debug:    zh:controller:device: Interview - IAS successfully enrolled '0xa4c138e388658fb0' endpoint '1'
[2026-04-10 15:31:16] debug:    zh:controller:device: Interview - completed for device '0xa4c138e388658fb0'
[2026-04-10 15:31:16] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:16] info:     zh:controller: Succesfully interviewed '0xa4c138e388658fb0'
[2026-04-10 15:31:16] info:     z2m: Successfully interviewed '0xa4c138e388658fb0', device has successfully been paired
[2026-04-10 15:31:16] info:     z2m: Device '0xa4c138e388658fb0' is supported, identified as: Tuya Water leak detector (TS0207_water_leak_detector)
[2026-04-10 15:31:16] info:     z2m: Configuring '0xa4c138e388658fb0'
[2026-04-10 15:31:16] debug:    zh:controller:endpoint: Bind 0xa4c138e388658fb0/1 genPowerCfg from '0x00124b001ca5eaaa/1'
[2026-04-10 15:31:16] debug:    zh:ember: ~~~> [ZDO BIND_REQUEST UNICAST to=0xa4c138e388658fb0:9425 messageTag=37 payload=25b08f6588e338c1a401010003aaeaa51c004b120001]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=216 Len=43]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=3](ackRx=0)
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/water_leak/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_water_leak","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"moisture","object_id":"0xa4c138e388658fb0_water_leak","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_water_leak_zigbee2mqtt","value_template":"{{ value_json.water_leak }}"}'
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"definition":{"description":"Water leak detector","exposes":[{"access":1,"description":"Indicates whether the device detected a water leak","label":"Water leak","name":"water_leak","property":"water_leak","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Indicates if the battery of this device is almost empty","label":"Battery low","name":"battery_low","property":"battery_low","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Remaining battery in %, can take up to 24 hours before reported","label":"Battery","name":"battery","property":"battery","type":"numeric","unit":"%","value_max":100,"value_min":0},{"access":1,"description":"Indicates whether the device is tampered","label":"Tamper","name":"tamper","property":"tamper","type":"binary","value_off":false,"value_on":true},{"access":1,"category":"diagnostic","description":"Link quality (signal strength)","label":"Linkquality","name":"linkquality","property":"linkquality","type":"numeric","unit":"lqi","value_max":255,"value_min":0}],"model":"TS0207_water_leak_detector","options":[],"source":"native","supports_ota":false,"vendor":"Tuya","version":"0.0.0"},"friendly_name":"0xa4c138e388658fb0","ieee_address":"0xa4c138e388658fb0","status":"successful","supported":true},"type":"device_interview"}'
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/battery_low/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_battery_low","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"battery","entity_category":"diagnostic","object_id":"0xa4c138e388658fb0_battery_low","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_battery_low_zigbee2mqtt","value_template":"{{ value_json.battery_low }}"}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=0 frmTx=1)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=1)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=216 Len=7]
[2026-04-10 15:31:16] debug:    zh:ember: ~~~> [SENT ZDO UNICAST messageTag=37 apsSequence=220 status=OK]
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/battery/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_battery","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"battery","enabled_by_default":true,"entity_category":"diagnostic","object_id":"0xa4c138e388658fb0_battery","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"state_class":"measurement","state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_battery_zigbee2mqtt","unit_of_measurement":"%","value_template":"{{ value_json.battery }}"}'
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/0xa4c138e388658fb0/tamper/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"binary_sensor.0xa4c138e388658fb0_tamper","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"tamper","object_id":"0xa4c138e388658fb0_tamper","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_tamper_zigbee2mqtt","value_template":"{{ value_json.tamper }}"}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=1)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=216 Len=22]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":0,"clusterId":33,"sourceEndpoint":0,"destinationEndpoint":0,"options":4416,"groupId":0,"sequence":220} messageTag=37
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1](ackRx=1 frmTx=1)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=1)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=216 Len=27]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":0,"clusterId":32801,"sourceEndpoint":0,"destinationEndpoint":0,"options":320,"groupId":0,"sequence":40} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=2500
[2026-04-10 15:31:16] debug:    zh:controller: Received ZDO response: clusterId=BIND_RESPONSE, status=SUCCESS, payload=undefined
[2026-04-10 15:31:16] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.configReport([{"attribute":"batteryPercentageRemaining","minimumReportInterval":3600,"maximumReportInterval":65000,"reportableChange":0}], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 15:31:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":84,"commandIdentifier":6}]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=217 Len=33]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=6](ackRx=1)
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/linkquality/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_linkquality","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"enabled_by_default":false,"entity_category":"diagnostic","icon":"mdi:signal","name":"Linkquality","object_id":"0xa4c138e388658fb0_linkquality","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"state_class":"measurement","state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_linkquality_zigbee2mqtt","unit_of_measurement":"lqi","value_template":"{{ value_json.linkquality }}"}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=1 frmTx=2)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=2)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=217 Len=7]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=221 messageTag=10 status=OK]
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'homeassistant/sensor/0xa4c138e388658fb0/last_seen/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"},{"topic":"zigbee2mqtt/0xa4c138e388658fb0/availability","value_template":"{{ value_json.state }}"}],"availability_mode":"all","default_entity_id":"sensor.0xa4c138e388658fb0_last_seen","device":{"hw_version":1,"identifiers":["zigbee2mqtt_0xa4c138e388658fb0"],"manufacturer":"Tuya","model":"Water leak detector","model_id":"TS0207_water_leak_detector","name":"0xa4c138e388658fb0","via_device":"zigbee2mqtt_bridge_0x00124b001ca5eaaa"},"device_class":"timestamp","enabled_by_default":false,"entity_category":"diagnostic","icon":"mdi:clock","name":"Last seen","object_id":"0xa4c138e388658fb0_last_seen","origin":{"name":"Zigbee2MQTT","sw":"2.9.2-dev","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/0xa4c138e388658fb0","unique_id":"0xa4c138e388658fb0_last_seen_zigbee2mqtt","value_template":"{{ value_json.last_seen }}"}'
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=2)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=217 Len=22]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":221} messageTag=10
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2](ackRx=2 frmTx=2)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=2)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=217 Len=32]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":41} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=18540700002100
[2026-04-10 15:31:16] debug:    zh:controller: Received payload: clusterID=1, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":84,"commandIdentifier":7},"payload":[{"status":0}],"command":{"name":"configReportRsp","ID":7}}
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":null,"battery_low":null,"last_seen":"2026-04-10T12:31:16.774Z","linkquality":120,"tamper":null,"water_leak":null}'
[2026-04-10 15:31:16] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:16] debug:    zh:controller:endpoint: ZCL command 0xa4c138e388658fb0/1 genPowerCfg.read(["batteryPercentageRemaining"], {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"writeUndiv":false})
[2026-04-10 15:31:16] debug:    zh:ember: ~~~> [ZCL to=0xa4c138e388658fb0:9425 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":85,"commandIdentifier":0}]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=218 Len=26]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=1](ackRx=2)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=2 frmTx=3)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=3)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=218 Len=7]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=222 messageTag=11 status=OK]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=3)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=218 Len=22]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65532 apsFrame={"profileId":0,"clusterId":0,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":38} messageTag=255
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=3)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=218 Len=22]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=9425 apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":4416,"groupId":0,"sequence":222} messageTag=11
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:16] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=3)
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=218 Len=33]
[2026-04-10 15:31:16] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":42} packetInfo:{"senderShortId":9425,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":120,"lastHopRssi":-70,"lastHopTimestamp":0} messageContents=18550121000020c8
[2026-04-10 15:31:16] debug:    zh:controller: Received payload: clusterID=1, address=9425, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=120, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":85,"commandIdentifier":1},"payload":[{"attrId":33,"status":0,"dataType":32,"attrData":200}],"command":{"name":"readRsp","ID":1}}
[2026-04-10 15:31:16] debug:    z2m: Received Zigbee message from '0xa4c138e388658fb0', type 'readResponse', cluster 'genPowerCfg', data '{"batteryPercentageRemaining":200}' from endpoint 1 with groupID 0
[2026-04-10 15:31:16] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/0xa4c138e388658fb0', payload '{"battery":100,"battery_low":null,"last_seen":"2026-04-10T12:31:16.889Z","linkquality":120,"tamper":null,"water_leak":null}'
[2026-04-10 15:31:16] info:     z2m: Successfully configured '0xa4c138e388658fb0' (definition v0.0.0)
[2026-04-10 15:31:16] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=3)
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=218 Len=18]
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=64300 sourceEui=0xa4c13871db8b612e lastHopLqi=128 lastHopRssi=-68 relayCount=0 relayList=
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3](ackRx=3 frmTx=3)
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=3)
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=218 Len=40]
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":249} packetInfo:{"senderShortId":64300,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":128,"lastHopRssi":-68,"lastHopTimestamp":0} messageContents=08110a010020c0e2ff2036e4ff2000
[2026-04-10 15:31:19] debug:    zh:controller: Received payload: clusterID=0, address=64300, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=128, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":17,"commandIdentifier":10},"payload":[{"attrId":1,"dataType":32,"attrData":192},{"attrId":65506,"dataType":32,"attrData":54},{"attrId":65508,"dataType":32,"attrData":0}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:19] debug:    zh:controller:endpoint: ZCL command 0xa4c13871db8b612e/1 genBasic.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"transactionSequenceNumber":17,"writeUndiv":false})
[2026-04-10 15:31:19] debug:    zh:ember: ~~~> [ZCL to=0xa4c13871db8b612e:64300 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":17,"commandIdentifier":11}]
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=219 Len=26]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=7](ackRx=3)
[2026-04-10 15:31:19] debug:    z2m: Received Zigbee message from 'Bedroom-tv-PM', type 'attributeReport', cluster 'genBasic', data '{"65506":54,"65508":0,"appVersion":192}' from endpoint 1 with groupID 0
[2026-04-10 15:31:19] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Bedroom-tv-PM', payload '{"child_lock":null,"countdown":null,"current":0.29,"energy":41.61,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:19.080Z","linkquality":128,"power":62,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":237}'
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=3 frmTx=4)
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=4)
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=219 Len=7]
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=223 messageTag=12 status=OK]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:19] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=4)
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=219 Len=22]
[2026-04-10 15:31:19] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=64300 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":223} messageTag=12
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=4)
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=219 Len=18]
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=9524 sourceEui=0xa4c138ddace780ac lastHopLqi=108 lastHopRssi=-73 relayCount=0 relayList=
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=4)
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=219 Len=33]
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":248} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=186d0a080521f402
[2026-04-10 15:31:21] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":109,"commandIdentifier":10},"payload":[{"attrId":1288,"dataType":33,"attrData":756}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:21] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsCurrent":756}' from endpoint 1 with groupID 0
[2026-04-10 15:31:21] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.76,"energy":1155.71,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:21.332Z","linkquality":108,"power":157,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":233}'
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:21] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=4)
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=219 Len=33]
[2026-04-10 15:31:21] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":2820,"sourceEndpoint":1,"destinationEndpoint":1,"options":320,"groupId":0,"sequence":249} packetInfo:{"senderShortId":9524,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":108,"lastHopRssi":-73,"lastHopTimestamp":0} messageContents=186e0a0b05298200
[2026-04-10 15:31:21] debug:    zh:controller: Received payload: clusterID=2820, address=9524, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=108, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":110,"commandIdentifier":10},"payload":[{"attrId":1291,"dataType":41,"attrData":130}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:21] debug:    z2m: Received Zigbee message from 'Tomas-desk-PM', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":130}' from endpoint 1 with groupID 0
[2026-04-10 15:31:21] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Tomas-desk-PM', payload '{"child_lock":null,"countdown":null,"current":0.76,"energy":1155.71,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:21.340Z","linkquality":108,"power":130,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":233}'
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=4)
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=219 Len=18]
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=214 sourceEui=0xa4c138627a9b0ac3 lastHopLqi=76 lastHopRssi=-81 relayCount=0 relayList=
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4](ackRx=4 frmTx=4)
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=5](frmRx=5) Added to rxQueue
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6](ackRx=4)
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=219 Len=40]
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":159} packetInfo:{"senderShortId":214,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":76,"lastHopRssi":-81,"lastHopTimestamp":0} messageContents=08680a010020c0e2ff2036e4ff2000
[2026-04-10 15:31:24] debug:    zh:controller: Received payload: clusterID=0, address=214, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=76, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":104,"commandIdentifier":10},"payload":[{"attrId":1,"dataType":32,"attrData":192},{"attrId":65506,"dataType":32,"attrData":54},{"attrId":65508,"dataType":32,"attrData":0}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:24] debug:    zh:controller:endpoint: ZCL command 0xa4c138627a9b0ac3/1 genBasic.defaultRsp({"cmdId":10,"statusCode":0}, {"timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"reservedBits":0,"transactionSequenceNumber":104,"writeUndiv":false})
[2026-04-10 15:31:24] debug:    zh:ember: ~~~> [ZCL to=0xa4c138627a9b0ac3:214 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":0} header={"frameControl":{"reservedBits":0,"frameType":0,"direction":0,"disableDefaultResponse":true,"manufacturerSpecific":false},"transactionSequenceNumber":104,"commandIdentifier":11}]
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: ===> [FRAME: ID=52:"SEND_UNICAST" Seq=220 Len=26]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=6](ackRx=4)
[2026-04-10 15:31:24] debug:    z2m: Received Zigbee message from '3D printer', type 'attributeReport', cluster 'genBasic', data '{"65506":54,"65508":0,"appVersion":192}' from endpoint 1 with groupID 0
[2026-04-10 15:31:24] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/3D printer', payload '{"child_lock":null,"countdown":null,"current":0.18,"energy":220.98,"identify":null,"indicator_mode":null,"last_seen":"2026-04-10T12:31:24.120Z","linkquality":76,"power":6,"power_outage_memory":null,"state":null,"switch_type_button":null,"update":{"installed_version":-1,"latest_version":-1,"state":null},"voltage":235}'
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=4 frmTx=5)
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=6](frmRx=6) Added to rxQueue
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7](ackRx=5)
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: <=== [FRAME: ID=52:"SEND_UNICAST" Seq=220 Len=7]
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: ~~~> [SENT type=DIRECT apsSequence=225 messageTag=13 status=OK]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=7](frmRx=7) Added to rxQueue
[2026-04-10 15:31:24] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0](ackRx=5)
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=220 Len=22]
[2026-04-10 15:31:24] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=DIRECT indexOrDestination=214 apsFrame={"profileId":260,"clusterId":0,"sourceEndpoint":1,"destinationEndpoint":1,"options":4352,"groupId":0,"sequence":225} messageTag=13
[2026-04-10 15:31:26] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:26] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:26] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=0](frmRx=0) Added to rxQueue
[2026-04-10 15:31:26] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1](ackRx=5)
[2026-04-10 15:31:26] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=63:"MESSAGE_SENT_HANDLER" Seq=220 Len=22]
[2026-04-10 15:31:26] debug:    zh:ember:ezsp: ezspMessageSentHandler: status=OK type=BROADCAST indexOrDestination=65532 apsFrame={"profileId":0,"clusterId":0,"sourceEndpoint":0,"destinationEndpoint":0,"options":0,"groupId":0,"sequence":47} messageTag=255
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=1](frmRx=1) Added to rxQueue
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2](ackRx=5)
[2026-04-10 15:31:34] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=89:"INCOMING_ROUTE_RECORD_HANDLER" Seq=220 Len=20]
[2026-04-10 15:31:34] debug:    zh:ember:ezsp: ezspIncomingRouteRecordHandler: source=8131 sourceEui=0xa4c1382879617c91 lastHopLqi=88 lastHopRssi=-78 relayCount=1 relayList=3081
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=2](frmRx=2) Added to rxQueue
[2026-04-10 15:31:34] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3](ackRx=5)
[2026-04-10 15:31:34] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=69:"INCOMING_MESSAGE_HANDLER" Seq=220 Len=33]
[2026-04-10 15:31:34] debug:    zh:ember:ezsp: ezspIncomingMessageHandler: type=UNICAST apsFrame={"profileId":260,"clusterId":1026,"sourceEndpoint":1,"destinationEndpoint":1,"options":256,"groupId":0,"sequence":196} packetInfo:{"senderShortId":8131,"senderLongId":"0xffffffffffffffff","bindingIndex":255,"addressIndex":255,"lastHopLqi":88,"lastHopRssi":-78,"lastHopTimestamp":0} messageContents=183b0a0000298e06
[2026-04-10 15:31:34] debug:    zh:controller: Received payload: clusterID=1026, address=8131, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=88, frame={"header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":59,"commandIdentifier":10},"payload":[{"attrId":0,"dataType":41,"attrData":1678}],"command":{"name":"report","ID":10}}
[2026-04-10 15:31:34] debug:    z2m: Received Zigbee message from 'Outdoor temperature sensor', type 'attributeReport', cluster 'msTemperatureMeasurement', data '{"measuredValue":1678}' from endpoint 1 with groupID 0
[2026-04-10 15:31:34] info:     z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Outdoor temperature sensor', payload '{"battery":45,"comfort_humidity_max":null,"comfort_humidity_min":null,"comfort_smiley":null,"comfort_temperature_max":null,"comfort_temperature_min":null,"enable_display":null,"humidity":87.09,"humidity_calibration":null,"last_seen":"2026-04-10T12:31:34.165Z","linkquality":88,"measurement_interval":null,"temperature":16.78,"temperature_calibration":null,"temperature_display_mode":null,"update":{"installed_version":20262913,"latest_release_notes":null,"latest_source":"https://raw.githubusercontent.com/Koenkk/zigbee-OTA/master/images/pvvx/1141-020a-01353001-Z03MMC.zigbee","latest_version":20262913,"state":"idle"},"voltage":2600}'
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=3](frmRx=3) Added to rxQueue
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4](ackRx=5)
[2026-04-10 15:31:35] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=35:"CHILD_JOIN_HANDLER" Seq=220 Len=18]
[2026-04-10 15:31:35] debug:    zh:ember:ezsp: ezspChildJoinHandler: index=2 joining=false childId=9425 childEui64=0xa4c138e388658fb0 childType=4
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA]
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5](ackRx=5 frmTx=5)
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=4](frmRx=4) Added to rxQueue
[2026-04-10 15:31:35] debug:    zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5](ackRx=5)
[2026-04-10 15:31:35] debug:    zh:ember:ezsp: <=== [CBFRAME: ID=36:"TRUST_CENTER_JOIN_HANDLER" Seq=220 Len=19]
[2026-04-10 15:31:35] debug:    zh:ember:ezsp: ezspTrustCenterJoinHandler: newNodeId=9425 newNodeEui64=0xa4c138e388658fb0 status=DEVICE_LEFT policyDecision=NO_ACTION parentOfNewNodeId=65535
[2026-04-10 15:31:35] debug:    zh:controller: Device leave '0xa4c138e388658fb0'
[2026-04-10 15:31:35] debug:    zh:controller: Removing device from database '0xa4c138e388658fb0'
[2026-04-10 15:31:35] debug:    zh:controller:database: Writing database to '/opt/zigbee2mqtt/data/database.db'
[2026-04-10 15:31:35] warning:  z2m: Device '0xa4c138e388658fb0' left the network

[Nerivec]

Right, so the duplicate was indeed because of the mismatching TSN, now there's no duplicate (it's expected to have 2 since one is from request, one is unsolicited).
But I guess it wasn't what was triggering the leave anyway...

I'm not seeing any key exchange taking place, so, that'll be the next step. Though that requires sniffing so we can see the whole network traffic and where it is going wrong. If you have a spare EmberZNet-based adapter, it's easier than with a Z-Stack one - no custom firmware flashing necessary (see the docs I linked before).
EmberZNet is stricter than Z-Stack from what I've seen in the past on misbehaving devices regarding security, so, quite possible that it gets kicked if it doesn't properly join.

[TSparkas]

capture.zip

Please see attached sniff.

Asked AI what could be the issue, response below (might be wrong , I am not Zigbee expert :) ):

The coordinator never responds to the device's Network Address Requests.

After interview completes, the device sends a flood of Network Address Request broadcasts looking for SiliconLabor_ff:fe:d5:ae:61 — that's the coordinator's own EUI64. The coordinator never responds. After ~21 seconds of retrying, the device gives up and leaves.

This happens because during IAS Zone enrollment, Z2M writes the coordinator's EUI64 as iasCieAddr. The device then tries to look up the coordinator's short address (0x0000) by broadcasting NWK Address Requests for that EUI64 — this is standard Zigbee ZDO behavior for CIE address verification. On Z-Stack this worked because the coordinator responded to its own NWK_addr_req. EmberZNet NCP does not.

Timeline summary:

123.158s — Transport Key sent ✅ (security works fine, not the issue)
123.171s — Device Announcement (device joined OK)
124.x–126.x — Full interview + IAS enrollment complete ✅
124.5s–135s — Device broadcasts 30+ NWK Address Requests for coordinator EUI64 → zero responses
129s, 134s, 139s — Device retries Node Descriptor Requests every 5s (checking if coordinator still reachable)
144.365s — Device sends Leave
This is the root cause. The fix is that zigbee-herdsman's ember adapter needs to handle ZDO NWK_addr_req for the coordinator's own EUI64 and respond with 0x0000.

[Nerivec]

ZDO to the coordinator is handled (& absorbed) by the EmberZNet stack, so, not something Herdsman ever sees.

I don't see why the device would request the network address though, since it's already communicating with that device, it obviously already has it (and double-weird, because coordinator is always 0x0000 anyway).
Though I suppose if it expects a response and doesn't properly continue without it, that could be the cause, and the difference with zstack indeed. It doesn't appear to be doing the key exchange procedure either.

This is something that needs fixing in-firmware though, unfortunately...

[TSparkas]

Thanks, will try looking at fixes in firmware then.

[Nerivec]

I'll try to take a look at the firmware side when I have some time.

You should look into updating firmware to 8.2.x or even 9.x.x, loads of bugfixes since 7.4.x, could be "fixed" by Silabs already. Though I'm not sure if your adapter variant is compatible with the regular variant that uses the same chip (the ones I currently build). Seems smlight made some pinout changes for some U variants, we don't have that mapping yet...
https://github.com/Nerivec/silabs-firmware-builder/releases

[TSparkas]

Managed to solve it - flashed other EFR32MG24 module on the unit as Zigbee Coordinator, instead of Thread and all works fine on second module. Not sure if first one is defective, or some other issue is involved.

[WhimsySpoon]

@TSparkas you mention a migration from zstack in your op, did you migrate your network by cloning your IEEE address? There are several of us on the linked issue above with the same problem that you mention who have done the same and have the same issue.

[TSparkas]

@WhimsySpoon - yes, I have also cloned IEEE address to the new adapter and still had same issue. The only workaround was to use other chip on same adapter.