Received unexpected bridge id: 0000000000000000

robiecz commented 1 year ago

The problem

Hassio reports in log an unexpected bridge id from deconz plugin, but everything works well. It seems, that the devices with id 0000000000000000 are light groups. And it occurs during the restart only.

What version of Home Assistant Core has the issue?

2023.1.4

What was the last working version of Home Assistant Core?

2023.1.3 (I'm not 100% sure)

What type of installation are you running?

Home Assistant Supervised

Integration causing the issue

deCONZ (ConBee II)

Link to integration documentation on our website

https://www.home-assistant.io/integrations/deconz/

Diagnostics information

config_entry-deconz-90acb8d187c96f32bca925f53dcba946.json.txt

Example YAML snippet

No response

Anything in the logs that might be useful for us?

Logger: pydeconz.utils
Source: components/deconz/deconz_device.py:75 
First occurred: 08:13:21 (328 occurrences) 
Last logged: 08:19:29
Received unexpected bridge id: 0000000000000000

ConBee II
2.19.03 / 19. 9. 2022
Firmware
26780700
port: /dev/serial/by-id/usb-dresden_elektronik_ingenieurtechnik_GmbH_ConBee_II_DE2194427-if00

From deCONZ REST api (light groups)
{
    "5": {
        "action": {
            "alert": "none",
            "bri": 176,
            "colormode": "ct",
            "ct": 262,
            "effect": "none",
            "hue": 0,
            "on": true,
            "sat": 127,
            "scene": null,
            "xy": [
                0,
                0
            ]
        },
        "devicemembership": [],
        "etag": "585df3adb09fae611ae21639ed011a9c",
        "hidden": false,
        "id": "5",
        "lights": [
            "2",
            "8",
            "3"
        ],
        "lightsequence": [],
        "multideviceids": [],
        "name": "Bar",
        "scenes": [],
        "state": {
            "all_on": true,
            "any_on": true
        },
        "type": "LightGroup"
    },
    "6": {
        "action": {
            "alert": "none",
            "bri": 249,
            "colormode": "ct",
            "ct": 158,
            "effect": "none",
            "hue": 0,
            "on": false,
            "sat": 127,
            "scene": null,
            "xy": [
                0,
                0
            ]
        },
        "devicemembership": [],
        "etag": "c0b06a8de77b99982b16ecb5c88aab36",
        "hidden": false,
        "id": "6",
        "lights": [
            "13",
            "11",
            "5",
            "14"
        ],
        "lightsequence": [],
        "multideviceids": [],
        "name": "Hall",
        "scenes": [],
        "state": {
            "all_on": false,
            "any_on": false
        },
        "type": "LightGroup"
    },
    "10": {
        "action": {
            "alert": "none",
            "bri": 128,
            "colormode": "hs",
            "ct": 0,
            "effect": "none",
            "hue": 0,
            "on": true,
            "sat": 128,
            "scene": null,
            "xy": [
                0,
                0
            ]
        },
        "devicemembership": [],
        "etag": "0c17e373327bc3f10ffcdc312c1c1af6",
        "hidden": false,
        "id": "10",
        "lights": [
            "2",
            "8",
            "3",
            "10"
        ],
        "lightsequence": [],
        "multideviceids": [],
        "name": "Kitchen",
        "scenes": [],
        "state": {
            "all_on": true,
            "any_on": true
        },
        "type": "LightGroup"
    }
}

From deCONZ plugin log:
09:15:25:855 delay sending request 130 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:15:25:872    0x00178801020C245D force poll (2)
09:15:25:922    0x00178801020C245D force poll (2)
09:15:26:650    0x001788010405288E force poll (2)
09:15:34:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:15:34:756 Skip automatic channel change, TODO warn user
09:15:40:759 ZDP get node descriptor for 0x74DE
09:15:44:231 ZCL attribute report 0x001788010C2A2C25 for cluster: 0x0001, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
09:15:44:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:15:44:756 Skip automatic channel change, TODO warn user
09:15:54:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:15:54:756 Skip automatic channel change, TODO warn user
09:16:04:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:04:756 Skip automatic channel change, TODO warn user
09:16:14:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:14:756 Skip automatic channel change, TODO warn user
09:16:16:758 ZDP get node descriptor for 0x74DE
09:16:24:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:24:756 Skip automatic channel change, TODO warn user
09:16:25:712 delayed group sending
09:16:25:718 delayed group sending
09:16:25:719 delay sending request 240 dt 0 ms to 0x001788010405288E, ep: 0x0B cluster: 0x0300 onAir: 1
09:16:25:752 send move to color temperature 209 to 0x00178801020C245D
09:16:25:756 delay sending request 240 dt 1 ms to 0x001788010405288E, ep: 0x0B cluster: 0x0300 onAir: 1
09:16:25:788    0x001788010405288E force poll (2)
09:16:25:808 delay sending request 244 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0008 onAir: 1
09:16:25:809 delay sending request 245 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:16:25:847    0x00178801020C245D force poll (2)
09:16:25:856 delay sending request 245 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:16:25:872    0x001788010405288E force poll (2)
09:16:25:873 delay sending request 245 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:16:25:895    0x00178801020C245D force poll (2)
09:16:25:944    0x00178801020C245D force poll (2)
09:16:29:674 ZCL attribute report 0x00158D00045C0018 for cluster: 0x0402, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:29:695 ZCL attribute report 0x00158D00045C0018 for cluster: 0x0405, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:34:699 ZCL attribute report 0x847127FFFEA35A34 for cluster: 0x0008, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:34:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:34:757 Skip automatic channel change, TODO warn user
09:16:34:821 ZCL attribute report 0x847127FFFEA35A34 for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:35:542 ZCL attribute report 0x847127FFFEA35A34 for cluster: 0x0006, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:35:566 ZCL attribute report 0x847127FFFE8F813E for cluster: 0x0008, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:35:818 ZCL attribute report 0x847127FFFE8F813E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:36:545 ZCL attribute report 0x847127FFFE8F813E for cluster: 0x0006, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:36:577 ZCL attribute report 0x60A423FFFEB032F6 for cluster: 0x0008, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:36:854 ZCL attribute report 0x60A423FFFEB032F6 for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:37:581 ZCL attribute report 0x60A423FFFEB032F6 for cluster: 0x0006, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:39:055 ZCL attribute report 0x588E81FFFEFBC74E for cluster: 0x0008, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:39:071 ZCL attribute report 0x588E81FFFEFBC74E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:16:44:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:44:757 Skip automatic channel change, TODO warn user
09:16:52:756 ZDP get node descriptor for 0x74DE
09:16:54:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:16:54:757 Skip automatic channel change, TODO warn user
09:17:04:083 ZCL attribute report 0x588E81FFFEFBC74E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:17:04:757 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:04:759 Skip automatic channel change, TODO warn user
09:17:09:714 ZCL attribute report 0x000D6F0011F9F9DF for cluster: 0x0001, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
09:17:10:755 Skip idle timer callback, too early: elapsed 806 msec
09:17:14:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:14:756 Skip automatic channel change, TODO warn user
09:17:16:724 Bind response success for 0x000d6f0011f9f9df ep: 0x01 cluster: 0x0000
09:17:18:692 ZCL attribute report 0x588E81FFFEFBC74E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:17:24:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:24:756 Skip automatic channel change, TODO warn user
09:17:25:701 delayed group sending
09:17:25:711 delayed group sending
09:17:25:712 delay sending request 117 dt 0 ms to 0x001788010405288E, ep: 0x0B cluster: 0x0300 onAir: 1
09:17:25:751 send move to color temperature 209 to 0x00178801020C245D
09:17:25:757 delay sending request 117 dt 1 ms to 0x001788010405288E, ep: 0x0B cluster: 0x0300 onAir: 1
09:17:25:796    0x001788010405288E force poll (2)
09:17:25:806 delay sending request 121 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0008 onAir: 1
09:17:25:807 delay sending request 122 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:17:25:850    0x00178801020C245D force poll (2)
09:17:25:856 delay sending request 122 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:17:25:862    0x001788010405288E force poll (2)
09:17:25:863 delay sending request 122 dt 0 ms to 0x00178801020C245D, ep: 0x0B cluster: 0x0300 onAir: 1
09:17:25:910    0x00178801020C245D force poll (2)
09:17:25:953    0x00178801020C245D force poll (2)
09:17:27:353 ZCL attribute report 0x588E81FFFEFBC74E for cluster: 0x0006, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:17:28:757 ZDP get node descriptor for 0x74DE
09:17:34:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:34:758 Skip automatic channel change, TODO warn user
09:17:35:174 ZCL attribute report 0x847127FFFEA35A34 for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:17:44:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:44:756 Skip automatic channel change, TODO warn user
09:17:54:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:17:54:756 Skip automatic channel change, TODO warn user
09:17:54:973 ZCL attribute report 0x847127FFFE8F813E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:17:58:636 ZCL attribute report 0x60A423FFFEB032F6 for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:18:04:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:18:04:757 Skip automatic channel change, TODO warn user
09:18:04:761 ZDP get node descriptor for 0x74DE
09:18:14:755 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:18:14:756 Skip automatic channel change, TODO warn user
09:18:19:516 ZCL attribute report 0x847127FFFE8F813E for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:18:23:435 ZCL attribute report 0x60A423FFFEB032F6 for cluster: 0x0300, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
09:18:24:756 apsUseExtPanid is 0xDDDDDDDDDDDDDDDD but should be 0, start reconfiguration
09:18:24:757 Skip automatic channel change, TODO warn user
09:18:25:701 delayed group sending
09:18:25:717 delayed group sending

Additional information

No response home-assistant_2023-01-15T08-23-38.249Z.log config_entry-deconz-90acb8d187c96f32bca925f53dcba946.json.txt

home-assistant[bot] commented 1 year ago

Hey there @kane610, mind taking a look at this issue as it has been labeled with an integration (deconz) you are listed as a code owner for? Thanks!

Code owner commands

Code owners of `deconz` can trigger bot actions by commenting: - `@home-assistant close` Closes the issue. - `@home-assistant rename Awesome new title` Change the title of the issue. - `@home-assistant reopen` Reopen the issue. - `@home-assistant unassign deconz` Removes the current integration label and assignees on the issue, add the integration domain after the command.

_{^{(message by CodeOwnersMention)}}

deconz documentation deconz source _{^{(message by IssueLinks)}}

gleichda commented 1 year ago

hey @robiecz I stumbled over the same issue today. For me the root cause was most probably that the device /dev/ttyAMA0 was in use by another application as well (Had a docker container with deconz running...)

robiecz commented 1 year ago

hey @robiecz I stumbled over the same issue today. For me the root cause was most probably that the device /dev/ttyAMA0 was in use by another application as well (Had a docker container with deconz running...)

Well, I have only one instance (docker as well).

issue-triage-workflows[bot] commented 1 year ago

There hasn't been any activity on this issue recently. Due to the high number of incoming GitHub notifications, we have to clean some of the old issues, as many of them have already been resolved with the latest updates. Please make sure to update to the latest Home Assistant version and check if that solves the issue. Let us know if that works for you by adding a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thank you for your contributions.

home-assistant / core