search

madchicken / homebridge-zigbee-nt

A standalone ZigBee plugin that works with CC2531 USB dongle or Deconz
Apache License 2.0
75 stars 38 forks source link

IKEA BADRING appears but doesn't display monitors #291

Open davidhenco opened 1 week ago

davidhenco commented 1 week ago

Hello, using a SONOFF Zigbee-E Key as router, the IKEA BADRING Water Leakage Sensor doesn't display the water sensor or battery monitor in the Homebridge panel. I tried adding some meta keys in the custom JSON but the result is the same. Here is the current plugin config:

{
    "name": "ZigBee",
    "port": "/dev/tty.SLAB_USBtoUART",
    "channel": 11,
    "secondaryChannel": "25",
    "adapter": "ezsp",
    "routerPollingInterval": 30,
    "disableRouterPolling": false,
    "disableHttpServer": false,
    "httpPort": 9092,
    "disableLed": false,
    "preferAutoDiscover": false,
    "platform": "ZigbeeHomebridgeNTPlatform",
    "devices": [
        {
            "manufacturer": "IKEA of Sweden",
            "models": [
                "BADRING Water Leakage Sensor"
            ],
            "services": [
                {
                    "type": "leak-sensor",
                    "meta": {}
                }
            ]
        }
    ],
    "customDeviceSettings": [
        {
            "ieeeAddr": "0x94b216fffeb77ead",
            "friendlyName": "E2202"
        }
    ],
    "_bridge": {
        "username": "0E:DB:15:A5:A4:F8",
        "port": 51645
    }
}

And here is an extract from the Homebridge logs:

[9/21/2024, 9:58:20 AM] [ZigBee] Successfully started ZigBee service
[9/21/2024, 9:58:20 AM] [ZigBee] ZigBee platform initialized @ 0x8c65a3fffe512652
[9/21/2024, 9:58:20 AM] [ZigBee] Reuse accessory from cache with uuid 6895c160-ba25-497f-b805-38071c751c56 and name zigbee:permit-join
[9/21/2024, 9:58:20 AM] [ZigBee] Zigbee: disabling joining new devices.
zh:controller: Disable joining
zh:ezsp:ezsp: ==> sendMulticast: {"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:ezsp: ==> {"_cls_":"sendMulticast","_id_":56,"_isRequest_":true,"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:uart: --> DATA (6,3,0): 2e00013800e0a12100f2f20001fdff06000307061902020a0000
zh:ezsp:uart: --> [636c21a96c2af57d337894b8d7aa546fb69a4e24acebd76589f7c66380e77e]
zh:ezsp:uart: -?- waiting (7)
[9/21/2024, 9:58:20 AM] [ZigBee] PermitJoin accessory successfully registered
[9/21/2024, 9:58:20 AM] [ZigBee] Reuse accessory from cache with uuid 4994893c-ea77-4292-a4ad-09e1f36f7099 and name zigbee:touchlink
[9/21/2024, 9:58:20 AM] [ZigBee] TouchLink accessory successfully registered
[9/21/2024, 9:58:20 AM] [ZigBee] Initializing ZigBee device: E2202 - BADRING Water Leakage Sensor - IKEA of Sweden
[9/21/2024, 9:58:20 AM] [ZigBee] Reuse accessory from cache with uuid c2be5e5e-e0d3-47ef-a3ea-369bb8d59695 and name 0x94b216fffeb77ead
[9/21/2024, 9:58:20 AM] [ZigBee] Registered device: E2202 IKEA of Sweden BADRING Water Leakage Sensor
[9/21/2024, 9:58:20 AM] [ZigBee] Mounting device E2202...
[9/21/2024, 9:58:20 AM] [ZigBee] Configuring device E2202
[Sat Sep 21 2024] [ZigBee-UI] Starting WEB UI on port 9092, host is set to 0.0.0.0
[9/21/2024, 9:58:20 AM] [ZigBee] Cannot read property 'configure' of null
[Sat Sep 21 2024] [ZigBee-UI] WebSocket server started @ null
[Sat Sep 21 2024] [ZigBee-UI] WEB UI Listening on port 9092
zh:ezsp:uart: <-- [376ca1a96c2a1534aaad7e]
zh:ezsp:uart: <-- DATA (3,7,0): 376ca1a96c2a1534aaad7e
zh:ezsp:uart: --> ACK  (4)
zh:ezsp:uart: --> [8430fc7e]
zh:ezsp:uart: <-- ACK (7): 376ca1a96c2a1534aaad7e
zh:ezsp:ezsp: <== Frame: 2e800138000086
zh:ezsp:ezsp: <== 0x38: {"_cls_":"sendMulticast","_id_":56,"_isRequest_":false,"status":0,"sequence":134}
zh:ezsp:uart: -+- waiting (7) success
zh:ezsp:ezsp: ==> clearTransientLinkKeys: null
zh:ezsp:ezsp: ==> {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":true}
zh:ezsp:uart: --> DATA (7,4,0): 2f00016b00
zh:ezsp:uart: --> [746d21a93f2a87ff7e]
zh:ezsp:uart: -?- waiting (0)
zh:ezsp:uart: <-- [406da1a93f2a73ea7e]
zh:ezsp:uart: <-- DATA (4,0,0): 406da1a93f2a73ea7e
zh:ezsp:uart: --> ACK  (5)
zh:ezsp:uart: --> [8520dd7e]
zh:ezsp:uart: <-- ACK (0): 406da1a93f2a73ea7e
zh:ezsp:ezsp: <== Frame: 2f80016b00
zh:ezsp:ezsp: <== 0x6b: {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (0) success
zh:ezsp:ezsp: ==> permitJoining: {"duration":0}
zh:ezsp:ezsp: ==> {"_cls_":"permitJoining","_id_":34,"_isRequest_":true,"duration":0}
zh:ezsp:uart: --> DATA (0,5,0): 300001220000
zh:ezsp:uart: --> [057221a9762a153c407e]
zh:ezsp:uart: -?- waiting (1)
zh:ezsp:uart: <-- [5172a1a9762a1535c17e]
zh:ezsp:uart: <-- DATA (5,1,0): 5172a1a9762a1535c17e
zh:ezsp:uart: --> ACK  (6)
zh:ezsp:uart: --> [8610be7e]
zh:ezsp:uart: <-- ACK (1): 5172a1a9762a1535c17e
zh:ezsp:ezsp: <== Frame: 308001220000
zh:ezsp:ezsp: <== 0x22: {"_cls_":"permitJoining","_id_":34,"_isRequest_":false,"status":0}
zh:ezsp:uart: -+- waiting (1) success
[9/21/2024, 9:58:20 AM] [ZigBee] Permit join disabled
zh:ezsp:uart: <-- [6172b1a96b2a164fa674eb04aaa76d499db3d82deace67f79b7e]
zh:ezsp:uart: <-- DATA (6,1,0): 6172b1a96b2a164fa674eb04aaa76d499db3d82deace67f79b7e
zh:ezsp:uart: --> ACK  (7)
zh:ezsp:uart: --> [87009f7e]
zh:ezsp:uart: <-- ACK (1): 6172b1a96b2a164fa674eb04aaa76d499db3d82deace67f79b7e
zh:ezsp:ezsp: <== Frame: 3090013f0003fdffe0a12100f2ff0001fdff86070000
zh:ezsp:ezsp: <== 0x3f: {"_cls_":"messageSentHandler","_id_":63,"_isRequest_":false,"type":3,"indexOrDestination":65533,"apsFrame":{"profileId":41440,"sequence":134,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":255,"groupId":65533,"options":256},"messageTag":7,"status":0,"message":{"type":"Buffer","data":[]}}
zh:ezsp:ezsp: ==> setMulticastTableEntry: {"index":6,"value":{"multicastId":65533,"endpoint":1,"networkIndex":0}}
zh:ezsp:ezsp: ==> {"_cls_":"setMulticastTableEntry","_id_":100,"_isRequest_":true,"index":6,"value":{"multicastId":65533,"endpoint":1,"networkIndex"
madchicken commented 6 days ago

Battery is not supported at the moment for the leak sensor, it can be added easily. For the water leak service you nee to add waterLeak: true in the meta section

davidhenco commented 6 days ago

Thanks for the reply. I updated my config to this:

{
    "name": "ZigBee",
    "port": "/dev/tty.SLAB_USBtoUART",
    "channel": 11,
    "secondaryChannel": "25",
    "adapter": "ezsp",
    "routerPollingInterval": 30,
    "disableRouterPolling": false,
    "disableHttpServer": false,
    "httpPort": 9092,
    "disableLed": false,
    "preferAutoDiscover": false,
    "platform": "ZigbeeHomebridgeNTPlatform",
    "devices": [
        {
            "manufacturer": "IKEA of Sweden",
            "models": [
                "BADRING Water Leakage Sensor"
            ],
            "services": [
                {
                    "type": "leak-sensor",
                    "meta": {
                        "waterLeak": true
                    }
                }
            ]
        }
    ],
    "customDeviceSettings": [
        {
            "ieeeAddr": "0x94b216fffeb77ead",
            "friendlyName": "E2202"
        }
    ],
    "_bridge": {
        "username": "0E:DB:15:A5:A4:F8",
        "port": 51645
    }
}

But the problem persists. I'm not sure, but the log seems to show the plugin crashing and restarting in a loop:

homebridge.log

madchicken commented 6 days ago

Could you try removing the accessory from the Homebridge cache? It seems the Zigbee descriptor is missing during the mount phase of the accessory

davidhenco commented 6 days ago

I tried removing the accessory from cache but the result is the same.

For testing purposes, I assembled a Homebridge instance in a VM on the same machine. In this case, the accessory is mounted but is not reporting water-leak state changes:

[9/22/2024, 2:52:08 PM] [ZigBee] Successfully started ZigBee service
[9/22/2024, 2:52:08 PM] [ZigBee] ZigBee platform initialized @ 0x8c65a3fffe512652
[9/22/2024, 2:52:08 PM] [ZigBee] Reuse accessory from cache with uuid 6895c160-ba25-497f-b805-38071c751c56 and name zigbee:permit-join
[9/22/2024, 2:52:08 PM] [ZigBee] Zigbee: disabling joining new devices.
zh:controller: Disable joining
zh:ezsp:ezsp: ==> sendMulticast: {"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:ezsp: ==> {"_cls_":"sendMulticast","_id_":56,"_isRequest_":true,"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:uart: --> DATA (6,3,0): 2e00013800e0a12100f2f20001fdff06000307061902020a0000
zh:ezsp:uart: --> [636c21a96c2af57d337894b8d7aa546fb69a4e24acebd76589f7c66380e77e]
zh:ezsp:uart: -?- waiting (7)
[9/22/2024, 2:52:08 PM] [ZigBee] PermitJoin accessory successfully registered
[9/22/2024, 2:52:08 PM] [ZigBee] Reuse accessory from cache with uuid 4994893c-ea77-4292-a4ad-09e1f36f7099 and name zigbee:touchlink
[9/22/2024, 2:52:08 PM] [ZigBee] TouchLink accessory successfully registered
[9/22/2024, 2:52:08 PM] [ZigBee] Initializing ZigBee device: 0x94b216fffeb77ead - BADRING Water Leakage Sensor - IKEA of Sweden
[9/22/2024, 2:52:08 PM] [ZigBee] Reuse accessory from cache with uuid c2be5e5e-e0d3-47ef-a3ea-369bb8d59695 and name 0x94b216fffeb77ead
[9/22/2024, 2:52:08 PM] [ZigBee] Registered device: 0x94b216fffeb77ead IKEA of Sweden BADRING Water Leakage Sensor
[9/22/2024, 2:52:08 PM] [ZigBee] Mounting device 0x94b216fffeb77ead...
[9/22/2024, 2:52:08 PM] [ZigBee] Configuring device 0x94b216fffeb77ead
[9/22/2024, 2:52:08 PM] [ZigBee] Cannot read properties of null (reading 'configure')
[Sun Sep 22 2024] [ZigBee-UI] Starting WEB UI on port 9092, host is set to 0.0.0.0
[Sun Sep 22 2024] [ZigBee-UI] WebSocket server started @ null
[Sun Sep 22 2024] [ZigBee-UI] WEB UI Listening on port 9092
zh:ezsp:uart: <-- [1e6fb5a96b2a15b259944a21aa5592499d4e2709ebce677a097e2e6fb1a97d312a15b25990ca25aa5593499cedd8abedce9874f2c36389fc74cd474aacde6f8ffee6dba3717e]
zh:ezsp:uart: <-- DATA (1,6,1): 1e6fb5a96b2a15b259944a21aa5592499d4e2709ebce677a097e
zh:ezsp:uart: Unexpected DATA packet sequence 1 | 3: packet replay
zh:ezsp:uart: --> ACK  (2)
zh:ezsp:uart: --> [82503a7e]
zh:ezsp:uart: <-- ACK (6): 1e6fb5a96b2a15b259944a21aa5592499d4e2709ebce677a097e
zh:ezsp:uart: Unexpected packet sequence 6 | 7
zh:ezsp:uart: Skipping the packet as repeated (2)
zh:ezsp:uart: <-- DATA (2,6,1): 2e6fb1a9112a15b25990ca25aa5593499cedd8abedce9874f2c36389fc74cd474aacde6f8ffee6dba3717e
zh:ezsp:uart: --> ACK  (3)
zh:ezsp:uart: --> [83401b7e]
zh:ezsp:uart: <-- ACK (6): 2e6fb1a9112a15b25990ca25aa5593499cedd8abedce9874f2c36389fc74cd474aacde6f8ffee6dba3717e
zh:ezsp:uart: Unexpected packet sequence 6 | 7
zh:ezsp:uart: Skipping the packet as repeated (3)
zh:ezsp:uart: <-- [376ca1a96c2a1516ae8d7e]
zh:ezsp:uart: <-- DATA (3,7,0): 376ca1a96c2a1516ae8d7e
zh:ezsp:uart: --> ACK  (4)
zh:ezsp:uart: --> [8430fc7e]
zh:ezsp:uart: <-- ACK (7): 376ca1a96c2a1516ae8d7e
zh:ezsp:ezsp: <== Frame: 2e8001380000a4
zh:ezsp:ezsp: <== 0x38: {"_cls_":"sendMulticast","_id_":56,"_isRequest_":false,"status":0,"sequence":164}
zh:ezsp:uart: -+- waiting (7) success
zh:ezsp:ezsp: ==> clearTransientLinkKeys: null
zh:ezsp:ezsp: ==> {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":true}
zh:ezsp:uart: --> DATA (7,4,0): 2f00016b00
zh:ezsp:uart: --> [746d21a93f2a87ff7e]
zh:ezsp:uart: -?- waiting (0)
zh:ezsp:uart: <-- [406da1a93f2a73ea7e]
zh:ezsp:uart: <-- DATA (4,0,0): 406da1a93f2a73ea7e
zh:ezsp:uart: --> ACK  (5)
zh:ezsp:uart: --> [8520dd7e]
zh:ezsp:uart: <-- ACK (0): 406da1a93f2a73ea7e
zh:ezsp:ezsp: <== Frame: 2f80016b00
zh:ezsp:ezsp: <== 0x6b: {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (0) success
zh:ezsp:ezsp: ==> permitJoining: {"duration":0}
zh:ezsp:ezsp: ==> {"_cls_":"permitJoining","_id_":34,"_isRequest_":true,"duration":0}
zh:ezsp:uart: --> DATA (0,5,0): 300001220000
zh:ezsp:uart: --> [057221a9762a153c407e]
zh:ezsp:uart: -?- waiting (1)
zh:ezsp:uart: <-- [5172a1a9762a1535c17e]
zh:ezsp:uart: <-- DATA (5,1,0): 5172a1a9762a1535c17e
zh:ezsp:uart: --> ACK  (6)
zh:ezsp:uart: --> [8610be7e]
zh:ezsp:uart: <-- ACK (1): 5172a1a9762a1535c17e
zh:ezsp:ezsp: <== Frame: 308001220000
zh:ezsp:ezsp: <== 0x22: {"_cls_":"permitJoining","_id_":34,"_isRequest_":false,"status":0}
zh:ezsp:uart: -+- waiting (1) success
davidhenco commented 6 days ago

I have a feeling "Cannot read properties of null (reading 'configure')" should not be there.

madchicken commented 6 days ago

Yes, this is why I asked to remove the cache. That error is really weird...

madchicken commented 5 days ago

I need the log after you deleted the accessory from the cache to understand what is going on

davidhenco commented 5 days ago

I need the log after you deleted the accessory from the cache to understand what is going on

[9/23/2024, 1:13:11 PM] [ZigBee] Successfully started ZigBee service
[9/23/2024, 1:13:11 PM] [ZigBee] ZigBee platform initialized @ 0x8c65a3fffe512652
[9/23/2024, 1:13:11 PM] [ZigBee] Registering new accessory with uuid 6895c160-ba25-497f-b805-38071c751c56 and name zigbee:permit-join
[9/23/2024, 1:13:11 PM] [ZigBee] Zigbee: disabling joining new devices.
zh:controller: Disable joining
zh:ezsp:ezsp: ==> sendMulticast: {"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:ezsp: ==> {"_cls_":"sendMulticast","_id_":56,"_isRequest_":true,"apsFrame":{"profileId":41440,"sequence":6,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":242,"groupId":65533,"options":256},"hops":0,"nonmemberRadius":3,"messageTag":7,"message":{"type":"Buffer","data":[25,2,2,10,0,0]}}
zh:ezsp:uart: --> DATA (6,3,0): 2e00013800e0a12100f2f20001fdff06000307061902020a0000
zh:ezsp:uart: --> [636c21a96c2af57d337894b8d7aa546fb69a4e24acebd76589f7c66380e77e]
zh:ezsp:uart: -?- waiting (7)
[9/23/2024, 1:13:11 PM] [ZigBee] PermitJoin accessory successfully registered
[9/23/2024, 1:13:11 PM] [ZigBee] Registering new accessory with uuid 4994893c-ea77-4292-a4ad-09e1f36f7099 and name zigbee:touchlink
[9/23/2024, 1:13:11 PM] [ZigBee] TouchLink accessory successfully registered
[9/23/2024, 1:13:11 PM] [ZigBee] Initializing ZigBee device: E2202 - BADRING Water Leakage Sensor - IKEA of Sweden
[9/23/2024, 1:13:11 PM] [ZigBee] Registering new accessory with uuid c2be5e5e-e0d3-47ef-a3ea-369bb8d59695 and name 0x94b216fffeb77ead
[9/23/2024, 1:13:11 PM] [ZigBee] Registered device: E2202 IKEA of Sweden BADRING Water Leakage Sensor
[9/23/2024, 1:13:11 PM] [ZigBee] Mounting device E2202...
[9/23/2024, 1:13:11 PM] [ZigBee] Configuring device E2202
[9/23/2024, 1:13:11 PM] [ZigBee] Cannot read properties of null (reading 'configure')
[Mon Sep 23 2024] [ZigBee-UI] Starting WEB UI on port 9092, host is set to 0.0.0.0
[Mon Sep 23 2024] [ZigBee-UI] WebSocket server started @ null
[Mon Sep 23 2024] [ZigBee-UI] WEB UI Listening on port 9092
zh:ezsp:uart: <-- [376ca1a96c2a152879107e]
zh:ezsp:uart: <-- DATA (3,7,0): 376ca1a96c2a152879107e
zh:ezsp:uart: --> ACK  (4)
zh:ezsp:uart: --> [8430fc7e]
zh:ezsp:uart: <-- ACK (7): 376ca1a96c2a152879107e
zh:ezsp:ezsp: <== Frame: 2e80013800009a
zh:ezsp:ezsp: <== 0x38: {"_cls_":"sendMulticast","_id_":56,"_isRequest_":false,"status":0,"sequence":154}
zh:ezsp:uart: -+- waiting (7) success
zh:ezsp:ezsp: ==> clearTransientLinkKeys: null
zh:ezsp:ezsp: ==> {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":true}
zh:ezsp:uart: --> DATA (7,4,0): 2f00016b00
zh:ezsp:uart: --> [746d21a93f2a87ff7e]
zh:ezsp:uart: -?- waiting (0)
zh:ezsp:uart: <-- [406da1a93f2a73ea7e]
zh:ezsp:uart: <-- DATA (4,0,0): 406da1a93f2a73ea7e
zh:ezsp:uart: --> ACK  (5)
zh:ezsp:uart: --> [8520dd7e]
zh:ezsp:uart: <-- ACK (0): 406da1a93f2a73ea7e
zh:ezsp:ezsp: <== Frame: 2f80016b00
zh:ezsp:ezsp: <== 0x6b: {"_cls_":"clearTransientLinkKeys","_id_":107,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (0) success
zh:ezsp:ezsp: ==> permitJoining: {"duration":0}
zh:ezsp:ezsp: ==> {"_cls_":"permitJoining","_id_":34,"_isRequest_":true,"duration":0}
zh:ezsp:uart: --> DATA (0,5,0): 300001220000
zh:ezsp:uart: --> [057221a9762a153c407e]
zh:ezsp:uart: -?- waiting (1)
zh:ezsp:uart: <-- [5172a1a9762a1535c17e]
zh:ezsp:uart: <-- DATA (5,1,0): 5172a1a9762a1535c17e
zh:ezsp:uart: --> ACK  (6)
zh:ezsp:uart: --> [8610be7e]
zh:ezsp:uart: <-- ACK (1): 5172a1a9762a1535c17e
zh:ezsp:ezsp: <== Frame: 308001220000
zh:ezsp:ezsp: <== 0x22: {"_cls_":"permitJoining","_id_":34,"_isRequest_":false,"status":0}
zh:ezsp:uart: -+- waiting (1) success
[9/23/2024, 1:13:11 PM] [ZigBee] Permit join disabled
zh:ezsp:uart: <-- [6172b1a96b2a164fa674eb04aaa76d499db3d831eace67a30e7e]
zh:ezsp:uart: <-- DATA (6,1,0): 6172b1a96b2a164fa674eb04aaa76d499db3d831eace67a30e7e
zh:ezsp:uart: --> ACK  (7)
zh:ezsp:uart: --> [87009f7e]
zh:ezsp:uart: <-- ACK (1): 6172b1a96b2a164fa674eb04aaa76d499db3d831eace67a30e7e
zh:ezsp:ezsp: <== Frame: 3090013f0003fdffe0a12100f2ff0001fdff9a070000
zh:ezsp:ezsp: <== 0x3f: {"_cls_":"messageSentHandler","_id_":63,"_isRequest_":false,"type":3,"indexOrDestination":65533,"apsFrame":{"profileId":41440,"sequence":154,"clusterId":33,"sourceEndpoint":242,"destinationEndpoint":255,"groupId":65533,"options":256},"messageTag":7,"status":0,"message":{"type":"Buffer","data":[]}}
zh:ezsp:ezsp: ==> setMulticastTableEntry: {"index":6,"value":{"multicastId":65533,"endpoint":1,"networkIndex":0}}
zh:ezsp:ezsp: ==> {"_cls_":"setMulticastTableEntry","_id_":100,"_isRequest_":true,"index":6,"value":{"multicastId":65533,"endpoint":1,"networkIndex":0}}
zh:ezsp:uart: --> DATA (1,7,0): 310001640006fdff0100
zh:ezsp:uart: --> [177321a9302a7d334fa6954aee2f7e]
zh:ezsp:uart: -?- waiting (2)
zh:ezsp:uart: <-- [7273a1a9302a15697d387e]
zh:ezsp:uart: <-- DATA (7,2,0): 7273a1a9302a1569187e
zh:ezsp:uart: --> ACK  (0)
zh:ezsp:uart: --> [8070787e]
zh:ezsp:uart: <-- ACK (2): 7273a1a9302a1569187e
zh:ezsp:ezsp: <== Frame: 318001640000
zh:ezsp:ezsp: <== 0x64: {"_cls_":"setMulticastTableEntry","_id_":100,"_isRequest_":false,"status":0}
zh:ezsp:uart: -+- waiting (2) success
zh:ezsp:cast: Set MulticastTableEntry #6 for 65533 multicast id: 0
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (2,0,0): 3200010500
zh:ezsp:uart: --> [207021a9512afccf7e]
zh:ezsp:uart: -?- waiting (3)
zh:ezsp:uart: <-- [0370a1a9512ada1f7e]
zh:ezsp:uart: <-- DATA (0,3,0): 0370a1a9512ada1f7e
zh:ezsp:uart: --> ACK  (1)
zh:ezsp:uart: --> [8160597e]
zh:ezsp:uart: <-- ACK (3): 0370a1a9512ada1f7e
zh:ezsp:ezsp: <== Frame: 3280010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (3) success
zh:ezsp:uart: <-- [7d3370b1a97d312a10b2598b4a25aa5592499c4fd8abedce9874f747622482c9c158fd7f4af7c67e]
zh:ezsp:uart: <-- DATA (1,3,0): 1370b1a9112a10b2598b4a25aa5592499c4fd8abedce9874f747622482c9c158fd7f4af7c67e
zh:ezsp:uart: --> ACK  (2)
zh:ezsp:uart: --> [82503a7e]
zh:ezsp:uart: <-- ACK (3): 1370b1a9112a10b2598b4a25aa5592499c4fd8abedce9874f747622482c9c158fd7f4af7c67e
zh:ezsp:ezsp: <== Frame: 32900145000500001f0000000000000001ff000000ffff0a8101ad7eb7feff16b294
zh:ezsp:ezsp: <== 0x45: {"_cls_":"incomingMessageHandler","_id_":69,"_isRequest_":false,"type":5,"apsFrame":{"profileId":0,"sequence":1,"clusterId":31,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":0},"lastHopLqi":255,"lastHopRssi":0,"sender":0,"bindingIndex":255,"addressIndex":255,"message":{"type":"Buffer","data":[129,1,173,126,183,254,255,22,178,148]}}
zh:ezsp: processMessage: {"messageType":5,"apsFrame":{"profileId":0,"sequence":1,"clusterId":31,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":0},"lqi":255,"rssi":0,"sender":0,"bindingIndex":255,"addressIndex":255,"message":{"type":"Buffer","data":[129,1,173,126,183,254,255,22,178,148]}}
zh:ezsp:uart: <-- [2370b1a96b2a7d334ea6944a3aaa5592499c4e27aa12ce673bbd7e]
zh:ezsp:uart: <-- DATA (2,3,0): 2370b1a96b2a134ea6944a3aaa5592499c4e27aa12ce673bbd7e
zh:ezsp:uart: --> ACK  (3)
zh:ezsp:uart: --> [83401b7e]
zh:ezsp:uart: <-- ACK (3): 2370b1a96b2a134ea6944a3aaa5592499c4e27aa12ce673bbd7e
zh:ezsp:ezsp: <== Frame: 3290013f0006fcff00001f0000000000000001ff0000
zh:ezsp:ezsp: <== 0x3f: {"_cls_":"messageSentHandler","_id_":63,"_isRequest_":false,"type":6,"indexOrDestination":65532,"apsFrame":{"profileId":0,"sequence":1,"clusterId":31,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":0},"messageTag":255,"status":0,"message":{"type":"Buffer","data":[]}}
zh:ezsp:uart: <-- [3370b5a9772a15b3574ae75b1dab6d5f2eda239a957e]
zh:ezsp:uart: <-- DATA (3,3,0): 3370b5a9772a15b3574ae75b1dab6d5f2eda239a957e
zh:ezsp:uart: --> ACK  (4)
zh:ezsp:uart: --> [8430fc7e]
zh:ezsp:uart: <-- ACK (3): 3370b5a9772a15b3574ae75b1dab6d5f2eda239a957e
zh:ezsp:ezsp: <== Frame: 329401230000010edead7eb7feff16b29404
zh:ezsp:ezsp: <== 0x23: {"_cls_":"childJoinHandler","_id_":35,"_isRequest_":false,"index":0,"joining":1,"childId":56846,"childEui64":{"type":"Buffer","data":[148,178,22,255,254,183,126,173]},"childType":4}
zh:ezsp:driv: Unhandled frame childJoinHandler
zh:ezsp:uart: <-- [4370b1a9702a1b6cf4eafddb554320dd9c4d27aba2737e]
zh:ezsp:uart: <-- DATA (4,3,0): 4370b1a9702a1b6cf4eafddb554320dd9c4d27aba2737e
zh:ezsp:uart: --> ACK  (5)
zh:ezsp:uart: --> [8520dd7e]
zh:ezsp:uart: <-- ACK (3): 4370b1a9702a1b6cf4eafddb554320dd9c4d27aba2737e
zh:ezsp:ezsp: <== Frame: 32900124000edead7eb7feff16b29400030000
zh:ezsp:ezsp: <== 0x24: {"_cls_":"trustCenterJoinHandler","_id_":36,"_isRequest_":false,"newNodeId":56846,"newNodeEui64":{"type":"Buffer","data":[148,178,22,255,254,183,126,173]},"status":0,"policyDecision":3,"parentOfNewNodeId":0}
zh:ezsp: Device join request received: 56846 94b216fffeb77ead
zh:controller: Device '0x94b216fffeb77ead' joined
[9/23/2024, 1:13:25 PM] [ZigBee] Accepting joining whitelisted device '0x94b216fffeb77ead'
zh:controller: Device '0x94b216fffeb77ead' accepted by handler
zh:controller: Not interviewing '0x94b216fffeb77ead', completed 'true', in progress 'false'
zh:ezsp:uart: <-- [5370b5a9362ab8ccee6ab5337d38c1ddec7e]
zh:ezsp:uart: <-- DATA (5,3,0): 5370b5a9362ab8ccee6ab53318c1ddec7e
zh:ezsp:uart: --> ACK  (6)
zh:ezsp:uart: --> [8610be7e]
zh:ezsp:uart: <-- ACK (3): 5370b5a9362ab8ccee6ab53318c1ddec7e
zh:ezsp:ezsp: <== Frame: 3294016200ad7eb7feff16b294
zh:ezsp:ezsp: <== 0x62: {"_cls_":"incomingSenderEui64Handler","_id_":98,"_isRequest_":false,"senderEui64":{"type":"Buffer","data":[148,178,22,255,254,183,126,173]}}
zh:ezsp:driv: Unhandled frame incomingSenderEui64Handler
zh:ezsp:uart: <-- [6370b1a97d312a7d31b259874a25aa5596499c5eaf15e3109874f1026d575100885914db6cfb0ffddff57e]
zh:ezsp:uart: <-- DATA (6,3,0): 6370b1a9112a11b259874a25aa5596499c5eaf15e3109874f1026d575100885914db6cfb0ffddff57e
zh:ezsp:uart: --> ACK  (7)
zh:ezsp:uart: --> [87009f7e]
zh:ezsp:uart: <-- ACK (3): 6370b1a9112a11b259874a25aa5596499c5eaf15e3109874f1026d575100885914db6cfb0ffddff57e
zh:ezsp:ezsp: <== Frame: 329001450004000013000000000400001088be0edeffff0cc40edead7eb7feff16b2948002
zh:ezsp:ezsp: <== 0x45: {"_cls_":"incomingMessageHandler","_id_":69,"_isRequest_":false,"type":4,"apsFrame":{"profileId":0,"sequence":16,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":1024},"lastHopLqi":136,"lastHopRssi":-66,"sender":56846,"bindingIndex":255,"addressIndex":255,"message":{"type":"Buffer","data":[196,14,222,173,126,183,254,255,22,178,148,128]}}
zh:ezsp: processMessage: {"messageType":4,"apsFrame":{"profileId":0,"sequence":16,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":1024},"lqi":136,"rssi":-66,"sender":56846,"bindingIndex":255,"addressIndex":255,"message":{"type":"Buffer","data":[196,14,222,173,126,183,254,255,22,178,148,128]}}
zh:ezsp: ZDO Device announce: 56846, 94b216fffeb77ead
zh:ezsp: Device join request received: 56846 94b216fffeb77ead
zh:controller: Device '0x94b216fffeb77ead' joined
[9/23/2024, 1:13:26 PM] [ZigBee] Accepting joining whitelisted device '0x94b216fffeb77ead'
zh:controller: Device '0x94b216fffeb77ead' accepted by handler
zh:controller: Not interviewing '0x94b216fffeb77ead', completed 'true', in progress 'false'
zh:ezsp:uart: <-- [7370b1a96b2a7d334fa6944a36aa559249984e27bb12ce67d89e7e]
zh:ezsp:uart: <-- DATA (7,3,0): 7370b1a96b2a134fa6944a36aa559249984e27bb12ce67d89e7e
zh:ezsp:uart: --> ACK  (0)
zh:ezsp:uart: --> [8070787e]
zh:ezsp:uart: <-- ACK (3): 7370b1a96b2a134fa6944a36aa559249984e27bb12ce67d89e7e
zh:ezsp:ezsp: <== Frame: 3290013f0006fdff0000130000000004000010ff0000
zh:ezsp:ezsp: <== 0x3f: {"_cls_":"messageSentHandler","_id_":63,"_isRequest_":false,"type":6,"indexOrDestination":65533,"apsFrame":{"profileId":0,"sequence":16,"clusterId":19,"sourceEndpoint":0,"destinationEndpoint":0,"groupId":0,"options":1024},"messageTag":255,"status":0,"message":{"type":"Buffer","data":[]}}
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (3,0,0): 3300010500
zh:ezsp:uart: --> [307121a9512a4c7d3a7e]
zh:ezsp:uart: -?- waiting (4)
zh:ezsp:uart: <-- [0471a1a9512ab80f7e]
zh:ezsp:uart: <-- DATA (0,4,0): 0471a1a9512ab80f7e
zh:ezsp:uart: --> ACK  (1)
zh:ezsp:uart: --> [8160597e]
zh:ezsp:uart: <-- ACK (4): 0471a1a9512ab80f7e
zh:ezsp:ezsp: <== Frame: 3380010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (4) success
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (4,1,0): 3400010500
zh:ezsp:uart: --> [417621a9512a2bf27e]
zh:ezsp:uart: -?- waiting (5)
zh:ezsp:uart: <-- [1576a1a9512a80ff7e]
zh:ezsp:uart: <-- DATA (1,5,0): 1576a1a9512a80ff7e
zh:ezsp:uart: --> ACK  (2)
zh:ezsp:uart: --> [82503a7e]
zh:ezsp:uart: <-- ACK (5): 1576a1a9512a80ff7e
zh:ezsp:ezsp: <== Frame: 3480010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (5) success
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (5,2,0): 3500010500
zh:ezsp:uart: --> [527721a9512a55c77e]
zh:ezsp:uart: -?- waiting (6)
zh:ezsp:uart: <-- [2677a1a9512acbc27e]
zh:ezsp:uart: <-- DATA (2,6,0): 2677a1a9512acbc27e
zh:ezsp:uart: --> ACK  (3)
zh:ezsp:uart: --> [83401b7e]
zh:ezsp:uart: <-- ACK (6): 2677a1a9512acbc27e
zh:ezsp:ezsp: <== Frame: 3580010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (6) success
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (6,3,0): 3600010500
zh:ezsp:uart: --> [637421a9512ad1397e]
zh:ezsp:uart: -?- waiting (7)
zh:ezsp:uart: <-- [3774a1a9512a7a347e]
zh:ezsp:uart: <-- DATA (3,7,0): 3774a1a9512a7a347e
zh:ezsp:uart: --> ACK  (4)
zh:ezsp:uart: --> [8430fc7e]
zh:ezsp:uart: <-- ACK (7): 3774a1a9512a7a347e
zh:ezsp:ezsp: <== Frame: 3680010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (7) success
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (7,4,0): 3700010500
zh:ezsp:uart: --> [747521a9512aa9ad7e]
zh:ezsp:uart: -?- waiting (0)
zh:ezsp:uart: <-- [4075a1a9512a5db87e]
zh:ezsp:uart: <-- DATA (4,0,0): 4075a1a9512a5db87e
zh:ezsp:uart: --> ACK  (5)
zh:ezsp:uart: --> [8520dd7e]
zh:ezsp:uart: <-- ACK (0): 4075a1a9512a5db87e
zh:ezsp:ezsp: <== Frame: 3780010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (0) success
zh:ezsp:ezsp: Time to watchdog ... 0
zh:ezsp:ezsp: ==> nop: null
zh:ezsp:ezsp: ==> {"_cls_":"nop","_id_":5,"_isRequest_":true}
zh:ezsp:uart: --> DATA (0,5,0): 3800010500
zh:ezsp:uart: --> [057a21a9512acc687e]
zh:ezsp:uart: -?- waiting (1)
zh:ezsp:uart: <-- [517aa1a9512a67657e]
zh:ezsp:uart: <-- DATA (5,1,0): 517aa1a9512a67657e
zh:ezsp:uart: --> ACK  (6)
zh:ezsp:uart: --> [8610be7e]
zh:ezsp:uart: <-- ACK (1): 517aa1a9512a67657e
zh:ezsp:ezsp: <== Frame: 3880010500
zh:ezsp:ezsp: <== 0x5: {"_cls_":"nop","_id_":5,"_isRequest_":false}
zh:ezsp:uart: -+- waiting (1) success
madchicken commented 5 days ago

Question: did you try to repair the accessory? Does it show in the web interface of the plugin? I would try to remove it and repair using the last configuration (the one with 

"meta": {
  "waterLeak": true
}
davidhenco commented 5 days ago

Sorry but remove and repair with the last configuration does not solve the issue. The device appears as usual in the Web interface:

screencap
davidhenco commented 5 days ago

FWIW, here is the device structure shown in the Web interface:

{
  "type": "EndDevice",
  "ieeeAddr": "0x94b216fffeb77ead",
  "networkAddress": 56846,
  "manufacturerID": 4476,
  "manufacturerName": "IKEA of Sweden",
  "powerSource": "Battery",
  "modelID": "BADRING Water Leakage Sensor",
  "interviewCompleted": true,
  "softwareBuildID": "1.0.7",
  "lastSeen": 1727111088120,
  "endpoints": [
    {
      "ID": 1,
      "profileID": 260,
      "deviceID": 1026,
      "inputClusters": [
        0,
        1,
        3,
        32,
        1280,
        2821,
        64636,
        64641
      ],
      "outputClusters": [
        3,
        4,
        25
      ],
      "deviceNetworkAddress": 56846,
      "deviceIeeeAddress": "0x94b216fffeb77ead",
      "clusters": {
        "genBasic": {
          "attributes": {
            "modelId": "BADRING Water Leakage Sensor",
            "manufacturerName": "IKEA of Sweden",
            "powerSource": 3,
            "zclVersion": 8,
            "appVersion": 1,
            "stackVersion": 113,
            "hwVersion": 1,
            "dateCode": "20230508",
            "swBuildId": "1.0.7"
          }
        },
        "ssIasZone": {
          "attributes": {
            "iasCieAddr": "0x8c65a3fffe512652",
            "zoneState": 1
          }
        },
        "genPollCtrl": {
          "attributes": {
            "checkinInterval": 172800
          }
        }
      },
      "bindings": [
        {
          "cluster": 32,
          "type": "endpoint",
          "deviceIeeeAddress": "0x8c65a3fffe512652",
          "endpointID": 1
        }
      ],
      "configuredReportingList": [],
      "meta": {}
    }
  ],
  "settings": {
    "ieeeAddr": "0x94b216fffeb77ead",
    "friendlyName": "E2202"
  },
  "otaAvailable": false
}