home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
74.2k stars 31.16k forks source link

ZHA groups not create entity #91377

Closed pinpspinps closed 1 year ago

pinpspinps commented 1 year ago

The problem

Hello, When I create ZHA group, Home assistant don't create entity and therefore I can't use it in Home Assistant image When I open the group in ZHA integration I have a quick error message "group not found" and then I arrive on the group configuration page. image

What version of Home Assistant Core has the issue?

core-2023.4.3

What was the last working version of Home Assistant Core?

No response

What type of installation are you running?

Home Assistant OS

Integration causing the issue

ZHA

Link to integration documentation on our website

No response

Diagnostics information

{ "home_assistant": { "installation_type": "Home Assistant Container", "version": "2023.4.3", "dev": false, "hassio": false, "virtualenv": false, "python_version": "3.10.10", "docker": true, "arch": "aarch64", "timezone": "Europe/Paris", "os_name": "Linux", "os_version": "6.1.21-v8+", "run_as_root": true }, "custom_components": { "hacs": { "version": "1.32.1", "requirements": [ "aiogithubapi>=22.10.1" ] }, "zha_toolkit": { "version": "v0.8.37", "requirements": [ "packaging>=20.8", "pytz" ] }, "frigate": { "version": "4.0.0", "requirements": [ "pytz==2022.7" ] }, "feedparser": { "version": "0.1.7", "requirements": [ "feedparser==6.0.8" ] } }, "integration_manifest": { "domain": "zha", "name": "Zigbee Home Automation", "after_dependencies": [ "onboarding", "usb" ], "codeowners": [ "@dmulcahey", "@adminiuga", "@puddly" ], "config_flow": true, "dependencies": [ "file_upload" ], "documentation": "https://www.home-assistant.io/integrations/zha", "iot_class": "local_polling", "loggers": [ "aiosqlite", "bellows", "crccheck", "pure_pcapy3", "zhaquirks", "zigpy", "zigpy_deconz", "zigpy_xbee", "zigpy_zigate", "zigpy_znp" ], "requirements": [ "bellows==0.35.1", "pyserial==3.5", "pyserial-asyncio==0.6", "zha-quirks==0.0.97", "zigpy-deconz==0.20.0", "zigpy==0.54.1", "zigpy-xbee==0.17.0", "zigpy-zigate==0.10.3", "zigpy-znp==0.10.0" ], "usb": [ { "vid": "10C4", "pid": "EA60", "description": "2652", "known_devices": [ "slae.sh cc2652rb stick" ] }, { "vid": "1A86", "pid": "55D4", "description": "sonoffplus", "known_devices": [ "sonoff zigbee dongle plus v2" ] }, { "vid": "10C4", "pid": "EA60", "description": "sonoffplus", "known_devices": [ "sonoff zigbee dongle plus" ] }, { "vid": "10C4", "pid": "EA60", "description": "tubeszb", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "tubeszb", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "zigstar", "known_devices": [ "ZigStar Coordinators" ] }, { "vid": "1CF1", "pid": "0030", "description": "conbee", "known_devices": [ "Conbee II" ] }, { "vid": "10C4", "pid": "8A2A", "description": "zigbee", "known_devices": [ "Nortek HUSBZB-1" ] }, { "vid": "0403", "pid": "6015", "description": "zigate", "known_devices": [ "ZiGate+" ] }, { "vid": "10C4", "pid": "EA60", "description": "zigate", "known_devices": [ "ZiGate" ] }, { "vid": "10C4", "pid": "8B34", "description": "bv 2010/10", "known_devices": [ "Bitron Video AV2010/10" ] } ], "zeroconf": [ { "type": "_esphomelib._tcp.local.", "name": "tube" }, { "type": "_zigate-zigbee-gateway._tcp.local.", "name": "zigate" }, { "type": "_zigstar_gw._tcp.local.", "name": "zigstar" }, { "type": "_slzb-06._tcp.local.", "name": "slzb-06" } ], "is_built_in": true }, "data": { "config": {}, "config_entry": { "entry_id": "a83d9d5122b2aa2912de3a41f67465b5", "version": 3, "domain": "zha", "title": "Sonoff Zigbee 3.0 USB Dongle Plus", "data": { "device": { "path": "/dev/ttyUSB0", "baudrate": 115200, "flow_control": null }, "radio_type": "znp" }, "options": {}, "pref_disable_new_entities": false, "pref_disable_polling": false, "source": "usb", "unique_id": "REDACTED", "disabled_by": null }, "application_state": { "node_info": { "nwk": 0, "ieee": "REDACTED", "logical_type": 0 }, "network_info": { "extended_pan_id": "REDACTED", "pan_id": 11659, "nwk_update_id": 0, "nwk_manager_id": 0, "channel": 15, "channel_mask": 32768, "security_level": 5, "network_key": "REDACTED", "tc_link_key": { "key": [ 90, 105, 103, 66, 101, 101, 65, 108, 108, 105, 97, 110, 99, 101, 48, 57 ], "tx_counter": 0, "rx_counter": 0, "seq": 0, "partner_ieee": "REDACTED" }, "key_table": [], "children": [], "nwk_addresses": {}, "stack_specific": { "zstack": { "tclk_seed": "78f9d9cc4e2dc049eeecee0b3c0f863f" } }, "metadata": { "zstack": { "TransportRev": 2, "ProductId": 1, "MajorRel": 2, "MinorRel": 7, "MaintRel": 1, "CodeRevision": 20221226, "BootloaderBuildType": 0, "BootloaderRevision": null } }, "source": "zigpy-znp@0.10.0" }, "counters": {}, "broadcast_counters": {}, "device_counters": {}, "group_counters": {} }, "energy_scan": { "11": 8.235294117647058, "12": 28.235294117647058, "13": 25.49019607843137, "14": 8.235294117647058, "15": 35.68627450980392, "16": 0.0, "17": 3.9215686274509802, "18": 0.0, "19": 0.0, "20": 0.0, "21": 0.0, "22": 0.0, "23": 0.0, "24": 0.0, "25": 0.0, "26": 11.372549019607844 }, "versions": { "bellows": "0.35.1", "zigpy": "0.54.1", "zigpy_deconz": "0.20.0", "zigpy_xbee": "0.17.0", "zigpy_znp": "0.10.0", "zigpy_zigate": "0.10.3", "zhaquirks": "0.0.97" } } }

Example YAML snippet

No response

Anything in the logs that might be useful for us?

2023-04-13 19:43:58.933 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_added
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 20:91:8a:00:00:05:4c:d8 and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 00:0d:6f:00:13:8e:48:9f and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 20:91:8a:00:00:05:4c:d4 and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 20:91:8a:00:00:05:4c:d6 and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 20:91:8a:00:00:05:4c:e6 and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.933 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: 20:91:8a:00:00:05:4c:e0 and endpoint ID: 1 to group: test:0x0002
2023-04-13 19:43:58.935 DEBUG (MainThread) [zigpy.zcl] [0x2E5C:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=69, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.935 DEBUG (MainThread) [zigpy.zcl] [0x2E5C:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.936 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x2E5C), dst_ep=1, source_route=None, extended_timeout=False, tsn=69, profile_id=260, cluster_id=4, data=Serialized[b'\x01E\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.937 DEBUG (MainThread) [zigpy.zcl] [0xF46E:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=70, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.938 DEBUG (MainThread) [zigpy.zcl] [0xF46E:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.938 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xF46E), dst_ep=1, source_route=None, extended_timeout=False, tsn=70, profile_id=260, cluster_id=4, data=Serialized[b'\x01F\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.939 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO groups_v11 VALUES (?, ?)\n                    ON CONFLICT (group_id)\n                    DO UPDATE SET name=excluded.name', (0x0002, 'test'))
2023-04-13 19:43:58.941 DEBUG (MainThread) [zigpy.zcl] [0xC866:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=71, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.941 DEBUG (MainThread) [zigpy.zcl] [0xC866:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.942 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xC866), dst_ep=1, source_route=None, extended_timeout=False, tsn=71, profile_id=260, cluster_id=4, data=Serialized[b'\x01G\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.943 DEBUG (MainThread) [zigpy.zcl] [0x536D:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=72, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.944 DEBUG (MainThread) [zigpy.zcl] [0x536D:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.944 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x536D), dst_ep=1, source_route=None, extended_timeout=False, tsn=72, profile_id=260, cluster_id=4, data=Serialized[b'\x01H\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.946 DEBUG (MainThread) [zigpy.zcl] [0x214B:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=73, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.947 DEBUG (MainThread) [zigpy.zcl] [0x214B:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.948 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x214B), dst_ep=1, source_route=None, extended_timeout=False, tsn=73, profile_id=260, cluster_id=4, data=Serialized[b'\x01I\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.949 DEBUG (MainThread) [zigpy.zcl] [0x0E6C:1:0x0004] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=74, command_id=0, *direction=<Direction.Server_to_Client: 0>)
2023-04-13 19:43:58.949 DEBUG (MainThread) [zigpy.zcl] [0x0E6C:1:0x0004] Sending request: add(group_id=0x0002, group_name='0x0002')
2023-04-13 19:43:58.950 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0E6C), dst_ep=1, source_route=None, extended_timeout=False, tsn=74, profile_id=260, cluster_id=4, data=Serialized[b'\x01J\x00\x02\x00\x060x0002'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:43:58.951 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0x2E5C), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=69, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x45\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:58.954 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO groups_v11 VALUES (?, ?)\n                    ON CONFLICT (group_id)\n                    DO UPDATE SET name=excluded.name', (0x0002, 'test')) completed
2023-04-13 19:43:58.956 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:58.956 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:58.975 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:58.976 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0xF46E), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=70, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x46\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:58.980 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=69)
2023-04-13 19:43:59.000 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:59.001 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0xC866), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=71, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x47\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:59.004 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=70)
2023-04-13 19:43:59.022 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:59.023 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0x536D), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=72, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x48\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:59.026 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=71)
2023-04-13 19:43:59.045 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:59.046 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0x214B), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=73, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x49\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:59.049 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=72)
2023-04-13 19:43:59.067 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:59.068 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0x0E6C), DstEndpoint=1, DstPanId=0x0000, SrcEndpoint=1, ClusterId=4, TSN=74, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x01\x4A\x00\x02\x00\x06\x30\x78\x30\x30\x30\x32')
2023-04-13 19:43:59.072 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=73)
2023-04-13 19:43:59.090 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:43:59.098 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataConfirm.Callback(Status=<Status.SUCCESS: 0>, Endpoint=1, TSN=74)
2023-04-13 19:43:59.143 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.SrcRtgInd.Callback(DstAddr=0xF46E, Relays=[])
2023-04-13 19:43:59.144 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0x2E5C, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=65, SecurityUse=<Bool.false: 0>, TimeStamp=15083985, TSN=0, Data=b'\x19\x45\x00\x00\x02\x00', MacSrcAddr=0x573E, MsgResultRadius=28)
2023-04-13 19:43:59.145 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x2E5C), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19E\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=28, non_member_radius=0, lqi=65, rssi=None)
2023-04-13 19:43:59.145 DEBUG (MainThread) [zigpy.zcl] [0x2E5C:1:0x0004] Received ZCL frame: b'\x19E\x00\x00\x02\x00'
2023-04-13 19:43:59.146 DEBUG (MainThread) [zigpy.zcl] [0x2E5C:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=69, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.147 DEBUG (MainThread) [zigpy.zcl] [0x2E5C:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.148 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.150 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 00:0d:6f:00:13:8e:48:9f, 'relays': b'\x00'})
2023-04-13 19:43:59.151 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 00:0d:6f:00:13:8e:48:9f, 'relays': b'\x00'}) completed
2023-04-13 19:43:59.154 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.156 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.158 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.145849, 'ieee': 20:91:8a:00:00:05:4c:d8, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.160 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.145849, 'ieee': 20:91:8a:00:00:05:4c:d8, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.161 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.163 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.SrcRtgInd.Callback(DstAddr=0xC866, Relays=[0xF46E])
2023-04-13 19:43:59.164 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.165 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d8, 1))
2023-04-13 19:43:59.167 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d8, 1)) completed
2023-04-13 19:43:59.168 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.169 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.171 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:d4, 'relays': b'\x01n\xf4'})
2023-04-13 19:43:59.172 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:d4, 'relays': b'\x01n\xf4'}) completed
2023-04-13 19:43:59.174 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.174 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.330 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.SrcRtgInd.Callback(DstAddr=0x536D, Relays=[])
2023-04-13 19:43:59.331 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.SrcRtgInd.Callback(DstAddr=0x214B, Relays=[])
2023-04-13 19:43:59.332 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.SrcRtgInd.Callback(DstAddr=0x0E6C, Relays=[0x573E])
2023-04-13 19:43:59.333 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0xF46E, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=80, SecurityUse=<Bool.false: 0>, TimeStamp=15088052, TSN=0, Data=b'\x19\x46\x00\x00\x02\x00', MacSrcAddr=0xF46E, MsgResultRadius=29)
2023-04-13 19:43:59.334 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xF46E), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19F\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=80, rssi=None)
2023-04-13 19:43:59.335 DEBUG (MainThread) [zigpy.zcl] [0xF46E:1:0x0004] Received ZCL frame: b'\x19F\x00\x00\x02\x00'
2023-04-13 19:43:59.336 DEBUG (MainThread) [zigpy.zcl] [0xF46E:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=70, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.337 DEBUG (MainThread) [zigpy.zcl] [0xF46E:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.338 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.343 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:d6, 'relays': b'\x00'})
2023-04-13 19:43:59.345 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0xC866, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=80, SecurityUse=<Bool.false: 0>, TimeStamp=15089527, TSN=0, Data=b'\x19\x47\x00\x00\x02\x00', MacSrcAddr=0xF46E, MsgResultRadius=28)
2023-04-13 19:43:59.346 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0x536D, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=29, SecurityUse=<Bool.false: 0>, TimeStamp=15091220, TSN=0, Data=b'\x19\x48\x00\x00\x02\x00', MacSrcAddr=0x536D, MsgResultRadius=29)
2023-04-13 19:43:59.347 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0x214B, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=94, SecurityUse=<Bool.false: 0>, TimeStamp=15092111, TSN=0, Data=b'\x19\x49\x00\x00\x02\x00', MacSrcAddr=0x214B, MsgResultRadius=29)
2023-04-13 19:43:59.348 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.IncomingMsg.Callback(GroupId=0x0000, ClusterId=4, SrcAddr=0x0E6C, SrcEndpoint=1, DstEndpoint=1, WasBroadcast=<Bool.false: 0>, LQI=61, SecurityUse=<Bool.false: 0>, TimeStamp=15094042, TSN=0, Data=b'\x19\x4A\x00\x00\x02\x00', MacSrcAddr=0x573E, MsgResultRadius=28)
2023-04-13 19:43:59.349 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xC866), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19G\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=28, non_member_radius=0, lqi=80, rssi=None)
2023-04-13 19:43:59.350 DEBUG (MainThread) [zigpy.zcl] [0xC866:1:0x0004] Received ZCL frame: b'\x19G\x00\x00\x02\x00'
2023-04-13 19:43:59.350 DEBUG (MainThread) [zigpy.zcl] [0xC866:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=71, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.351 DEBUG (MainThread) [zigpy.zcl] [0xC866:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.352 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x536D), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19H\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=29, rssi=None)
2023-04-13 19:43:59.352 DEBUG (MainThread) [zigpy.zcl] [0x536D:1:0x0004] Received ZCL frame: b'\x19H\x00\x00\x02\x00'
2023-04-13 19:43:59.353 DEBUG (MainThread) [zigpy.zcl] [0x536D:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=72, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.353 DEBUG (MainThread) [zigpy.zcl] [0x536D:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.354 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x214B), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19I\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=94, rssi=None)
2023-04-13 19:43:59.354 DEBUG (MainThread) [zigpy.zcl] [0x214B:1:0x0004] Received ZCL frame: b'\x19I\x00\x00\x02\x00'
2023-04-13 19:43:59.355 DEBUG (MainThread) [zigpy.zcl] [0x214B:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=73, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.355 DEBUG (MainThread) [zigpy.zcl] [0x214B:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.356 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0E6C), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=0, profile_id=260, cluster_id=4, data=Serialized[b'\x19J\x00\x00\x02\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=28, non_member_radius=0, lqi=61, rssi=None)
2023-04-13 19:43:59.356 DEBUG (MainThread) [zigpy.zcl] [0x0E6C:1:0x0004] Received ZCL frame: b'\x19J\x00\x00\x02\x00'
2023-04-13 19:43:59.357 DEBUG (MainThread) [zigpy.zcl] [0x0E6C:1:0x0004] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=74, command_id=0, *direction=<Direction.Client_to_Server: 1>)
2023-04-13 19:43:59.358 DEBUG (MainThread) [zigpy.zcl] [0x0E6C:1:0x0004] Decoded ZCL frame: Groups:add_response(status=<Status.SUCCESS: 0>, group_id=0x0002)
2023-04-13 19:43:59.358 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.363 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.365 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:d6, 'relays': b'\x00'}) completed
2023-04-13 19:43:59.369 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.378 INFO (MainThread) [homeassistant.components.zha.core.group] [test](0x0002): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, time:0x000A, commissioning:0x0015, shade:0x0100, manufacturer_specific:0xFC20, manufacturer_specific:0xFC21] out=[identify:0x0003, manufacturer_specific:0xFC20] status=<Status.ZDO_INIT: 1>>
2023-04-13 19:43:59.395 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.398 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.401 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:e6, 'relays': b'\x00'})
2023-04-13 19:43:59.401 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:e6, 'relays': b'\x00'}) completed
2023-04-13 19:43:59.403 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.404 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.405 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:e0, 'relays': b'\x01>W'})
2023-04-13 19:43:59.406 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO relays_v11 VALUES (:ieee, :relays)\n                        ON CONFLICT (ieee)\n                        DO UPDATE SET relays=excluded.relays WHERE relays != :relays', {'ieee': 20:91:8a:00:00:05:4c:e0, 'relays': b'\x01>W'}) completed
2023-04-13 19:43:59.407 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.408 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.409 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.335437, 'ieee': 00:0d:6f:00:13:8e:48:9f, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.410 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.335437, 'ieee': 00:0d:6f:00:13:8e:48:9f, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.411 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.412 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.413 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 00:0d:6f:00:13:8e:48:9f, 1))
2023-04-13 19:43:59.413 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 00:0d:6f:00:13:8e:48:9f, 1)) completed
2023-04-13 19:43:59.415 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.415 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.417 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.350011, 'ieee': 20:91:8a:00:00:05:4c:d4, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.417 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.350011, 'ieee': 20:91:8a:00:00:05:4c:d4, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.418 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.419 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.421 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.352405, 'ieee': 20:91:8a:00:00:05:4c:d6, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.432 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.352405, 'ieee': 20:91:8a:00:00:05:4c:d6, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.433 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.434 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.435 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.354491, 'ieee': 20:91:8a:00:00:05:4c:e6, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.437 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.354491, 'ieee': 20:91:8a:00:00:05:4c:e6, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.445 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.453 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.465 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.356762, 'ieee': 20:91:8a:00:00:05:4c:e0, 'min_last_seen_delta': 30.0})
2023-04-13 19:43:59.470 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407839.356762, 'ieee': 20:91:8a:00:00:05:4c:e0, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:43:59.473 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.474 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.475 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d4, 1))
2023-04-13 19:43:59.477 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d4, 1)) completed
2023-04-13 19:43:59.477 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.478 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.479 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d6, 1))
2023-04-13 19:43:59.480 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:d6, 1)) completed
2023-04-13 19:43:59.481 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.481 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.482 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:e6, 1))
2023-04-13 19:43:59.483 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:e6, 1)) completed
2023-04-13 19:43:59.484 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.485 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:43:59.486 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:e0, 1))
2023-04-13 19:43:59.486 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'INSERT INTO group_members_v11 VALUES (?, ?, ?)\n                    ON CONFLICT\n                    DO NOTHING', (0x0002, 20:91:8a:00:00:05:4c:e0, 1)) completed
2023-04-13 19:43:59.487 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:43:59.488 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:44:01.210 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2023-04-13 19:44:01.217 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.APP_CNF|GP|UTIL|ZDO|AF|SYS: 1625>)
2023-04-13 19:44:05.594 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xCD66](unk_model): last_seen is 24401.669580459595 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:05.594 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xCD66](unk_model): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:05.630 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xF46E](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:05.631 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xF46E](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:05.652 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x0E6C](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:05.653 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x0E6C](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:12.726 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1F5B](122-130-1/2-2                  ): last_seen is 23760.02337050438 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:12.726 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1F5B](122-130-1/2-2                  ): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:15.796 DEBUG (MainThread) [zigpy_znp.zigbee.application] Sending packet ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=75, profile_id=0, cluster_id=<ZDOCmd.Mgmt_NWK_Update_req: 0x0038>, data=Serialized[b'K\x00\xf8\xff\x07\x04\x01'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:44:15.798 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=75, profile_id=0, cluster_id=<ZDOCmd.Mgmt_NWK_Update_req: 0x0038>, data=Serialized[b'K\x00\xf8\xff\x07\x04\x01'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:44:15.801 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Mgmt_NWK_Update_req: [NwkUpdate(ScanChannels=<Channels.ALL_CHANNELS: 134215680>, ScanDuration=4, ScanCount=1)]
2023-04-13 19:44:15.802 DEBUG (MainThread) [zigpy_znp.api] Sending request: AF.DataRequestExt.Req(DstAddrModeAddress=AddrModeAddress(mode=<AddrMode.NWK: 2>, address=0x0000), DstEndpoint=0, DstPanId=0x0000, SrcEndpoint=0, ClusterId=56, TSN=75, Options=<TransmitOptions.SUPPRESS_ROUTE_DISC_NETWORK: 32>, Radius=0, Data=b'\x4B\x00\xF8\xFF\x07\x04\x01')
2023-04-13 19:44:15.807 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407855.800284, 'ieee': 00:12:4b:00:24:c2:c8:46, 'min_last_seen_delta': 30.0})
2023-04-13 19:44:15.810 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407855.800284, 'ieee': 00:12:4b:00:24:c2:c8:46, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:44:15.813 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:44:15.814 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:44:15.816 DEBUG (MainThread) [zigpy_znp.api] Received command: AF.DataRequestExt.Rsp(Status=<Status.SUCCESS: 0>)
2023-04-13 19:44:17.609 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x31C7](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:17.609 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x31C7](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:20.666 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.MgmtNWKUpdateNotify.Callback(Src=0x0000, Status=<Status.SUCCESS: 0>, ScannedChannels=<Channels.ALL_CHANNELS: 134215680>, TotalTransmissions=33243, TransmissionFailures=0, EnergyValues=[21, 72, 65, 21, 91, 0, 10, 0, 0, 0, 0, 0, 0, 0, 0, 29])
2023-04-13 19:44:20.669 DEBUG (MainThread) [zigpy_znp.api] Command was not handled
2023-04-13 19:44:20.670 DEBUG (MainThread) [zigpy_znp.api] Received command: ZDO.MsgCbIncoming.Callback(Src=0x0000, IsBroadcast=<Bool.false: 0>, ClusterId=32824, SecurityUse=0, TSN=75, MacDst=0x0000, Data=b'\x00\x00\xF8\xFF\x07\xDB\x81\x00\x00\x10\x15\x48\x41\x15\x5B\x00\x0A\x00\x00\x00\x00\x00\x00\x00\x00\x1D')
2023-04-13 19:44:20.672 DEBUG (MainThread) [zigpy.application] Received a packet: ZigbeePacket(src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=75, profile_id=0, cluster_id=32824, data=Serialized[b'K\x00\x00\xf8\xff\x07\xdb\x81\x00\x00\x10\x15HA\x15[\x00\n\x00\x00\x00\x00\x00\x00\x00\x00\x1d'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
2023-04-13 19:44:20.674 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407860.673214, 'ieee': 00:12:4b:00:24:c2:c8:46, 'min_last_seen_delta': 30.0})
2023-04-13 19:44:20.675 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x7f8d76be40>, 'UPDATE devices_v11\n                    SET last_seen=:ts\n                    WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1681407860.673214, 'ieee': 00:12:4b:00:24:c2:c8:46, 'min_last_seen_delta': 30.0}) completed
2023-04-13 19:44:20.709 DEBUG (Thread-3) [aiosqlite] executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>)
2023-04-13 19:44:20.710 DEBUG (Thread-3) [aiosqlite] operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x7f8d76be40>) completed
2023-04-13 19:44:23.699 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x573E](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:23.699 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x573E](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:30.672 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xB9B5](unk_model): last_seen is 69075.14407444 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:30.673 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xB9B5](unk_model): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:31.219 DEBUG (MainThread) [zigpy_znp.api] Sending request: SYS.Ping.Req()
2023-04-13 19:44:31.226 DEBUG (MainThread) [zigpy_znp.api] Received command: SYS.Ping.Rsp(Capabilities=<MTCapabilities.APP_CNF|GP|UTIL|ZDO|AF|SYS: 1625>)
2023-04-13 19:44:32.628 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x380C](unk_model): last_seen is 22797.671013355255 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:32.629 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x380C](unk_model): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:35.593 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xF8DD](unk_model): last_seen is 69075.4577035904 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:35.593 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xF8DD](unk_model): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:43.576 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x214B](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:43.576 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x214B](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:43.639 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x64BC](unk_model): last_seen is 102823.85750222206 seconds ago and ping attempts have been exhausted, marking the device unavailable
2023-04-13 19:44:43.639 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x64BC](unk_model): Update device availability -  device available: False - new availability: False - changed: False
2023-04-13 19:44:43.662 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x8279](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:43.662 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x8279](unk_model): Update device availability -  device available: True - new availability: True - changed: False
2023-04-13 19:44:46.689 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xC866](unk_model): Device seen - marking the device available and resetting counter
2023-04-13 19:44:46.689 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xC866](unk_model): Update device availability -  device available: True - new availability: True - changed: False

Additional information

The coordinator is a Sonoff Zigbee 3.0 USB Dongle Plus (Model ZBDongle-P)

home-assistant[bot] commented 1 year ago

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

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

(message by CodeOwnersMention)


zha documentation zha source (message by IssueLinks)

puddly commented 1 year ago

I'm afraid I can't reproduce this issue, a new group is successfully created for me on 2023.4.3. Can you search for the entity directly in the Entities tab?

image
pinpspinps commented 1 year ago

Yes, but there are nothing concern the Zigbee group.

I find some link where person have the same issue but they give no solution. https://community.home-assistant.io/t/zha-groups-not-created-as-entity-ids/388460/2 https://www.reddit.com/r/homeassistant/comments/kuaczx/using_zha_groups/

In my Home Assistant no entity is create it doesn't matter the number of device I add to the the or if I reboot Home Assistant.

pinpspinps commented 1 year ago

My Sonoff Dongle is plug in a USB HUB. Do you think this is the problem?

pinpspinps commented 1 year ago

With the mobile app I managed to capture the error message that appears when I go to the group. Screenshot_20230417-183822

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.

overas commented 1 year ago

I experience the same. When I create zha group Test, it is created, but the group does not appear in the entity search.

image

2023-07-21 17:43:46.696 DEBUG (MainThread) [zigpy.group] Adding group: 10, Test
2023-07-21 17:43:46.697 INFO (MainThread) [homeassistant.components.zha.core.group] [Test](0x000A): group_added
2023-07-21 17:43:46.697 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Adding member with IEEE: cc:cc:cc:ff:fe:8c:4a:e5 and endpoint ID: 1 to group: Test:0x000a
2023-07-21 17:43:46.800 INFO (MainThread) [homeassistant.components.zha.core.group] [Test](0x000A): group_member_added - endpoint: <Endpoint id=1 in=[basic:0x0000, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, light_color:0x0300, lightlink:0x1000, manufacturer_specific:0xFC7C] out=[ota:0x0019, lightlink:0x1000] status=<Status.ZDO_INIT: 1>>

When I search after group.test I do not find it. image

I

Zha diagnostic of the coordinator: zha-7f5c179f236d4a2c6ca0f19a96cdd4e6-Texas Instruments CC1352_CC2652, Z-Stack 3.30+ (build 20221226)-2b97beec5d8cc07374e8697e7be6dc9a.json.txt

System Information

version core-2023.7.2
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.11.4
os_name Linux
os_version 6.1.34
arch x86_64
timezone Europe/Oslo
config_dir /config
Home Assistant Community Store GitHub API | ok -- | -- GitHub Content | ok GitHub Web | ok GitHub API Calls Remaining | 4932 Installed Version | 1.32.1 Stage | running Available Repositories | 1336 Downloaded Repositories | 9
Home Assistant Cloud logged_in | true -- | -- subscription_expiration | October 7, 2023 at 02:00 relayer_connected | true relayer_region | eu-central-1 remote_enabled | true remote_connected | true alexa_enabled | false google_enabled | false remote_server | eu-central-1-6.ui.nabu.casa certificate_status | ready can_reach_cert_server | ok can_reach_cloud_auth | ok can_reach_cloud | ok
Easee EV Charger component_version | 0.9.54 -- | -- reach_easee_cloud | ok connected2stream | true
Home Assistant Supervisor host_os | Home Assistant OS 10.3 -- | -- update_channel | stable supervisor_version | supervisor-2023.07.1 agent_version | 1.5.1 docker_version | 23.0.6 disk_total | 116.7 GB disk_used | 14.0 GB healthy | true supported | true board | generic-x86-64 supervisor_api | ok version_api | ok installed_addons | File editor (5.6.0), Advanced SSH & Web Terminal (15.0.4), ESPHome (2023.7.0), Z-Wave JS UI (1.15.0), EMHASS (0.3.15), SQLite Web (3.9.0), Frigate (0.12.1), Mosquitto broker (6.2.1)
Dashboards dashboards | 1 -- | -- resources | 1 views | 10 mode | storage
Recorder oldest_recorder_run | June 4, 2023 at 07:49 -- | -- current_recorder_run | July 21, 2023 at 17:42 estimated_db_size | 983.64 MiB database_engine | sqlite database_version | 3.41.2
dmulcahey commented 1 year ago

How many devices are in the group? Minimum of 2 of the same domain are required for an entity to be created

pinpspinps commented 1 year ago

yes, there are more than 2 devices in a group

overas commented 1 year ago

The same applies to me as well.

overas commented 1 year ago

I found the zha group entities name now. The problem is that the controller name comes first and then the group name after. It then becomes difficult to find the zha groups in an entity search

image

overas commented 1 year ago

As a workaround I can rename the entitet name without the controller name in the Controls window in the controller entitet window.

image

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.

liouma commented 1 year ago

same issue here with group of 2 light bulbs

Guspaz commented 1 year ago

ZHA groups require at least three entities of the same type to show up as a group entity. However, zigbee group commands are very slow (they will throttle if you use multiple in a row) and should only be used for large numbers of devices, even for 3 devices it will be much faster to send individual commands using an HA group than a zigbee group.