Hey everyone,
im using a sonoff cc2652p zigbee dongle via ZHA
When pairing my ikea parasoll and vallhorn the progress never proceeds beyond the configuration phase, right after auditing
I have updated the dongles firmware from 2021.10 to 2024.07 and that didnt improve anything.
I actually have another parasoll connected and working just fine. and even the one thats causing issues used to work. But now it no longer connects.
Here are the logs during configuration. Could anyone point me to the issue or let me know what else i could try?
[zha.application.helpers::DeviceAvailabilityChecker.check_device_availability]
Device availability checker interval starting
Checking device availability
[0xBA2C](BADRING Water Leakage Sensor): Device seen - marking the device available and resetting counter
[0xBA2C](BADRING Water Leakage Sensor): Update device availability - device available: True - new availability: True - changed: False
[0x5748](PARASOLL Door/Window Sensor): Device seen - marking the device available and resetting counter
[0x5748](PARASOLL Door/Window Sensor): Update device availability - device available: True - new availability: True - changed: False
[0xF795](TRADFRI bulb E27 CWS globe 806lm): Device seen - marking the device available and resetting counter
[0xF795](TRADFRI bulb E27 CWS globe 806lm): Update device availability - device available: True - new availability: True - changed: False
[0xCE13](TRETAKT Smart plug): Device seen - marking the device available and resetting counter
[0xCE13](TRETAKT Smart plug): Update device availability - device available: True - new availability: True - changed: False
[0x3950](TRETAKT Smart plug): Device seen - marking the device available and resetting counter
[0x3950](TRETAKT Smart plug): Update device availability - device available: True - new availability: True - changed: False
[0x5B72](VALLHORN Wireless Motion Sensor): Device seen - marking the device available and resetting counter
[0x5B72](VALLHORN Wireless Motion Sensor): Update device availability - device available: True - new availability: True - changed: False
Device availability checker interval finished
[<Task pending name='global-updater_GlobalUpdater' coro=<periodic.<locals>.scheduler.<locals>.wrapper() running at /usr/local/lib/python3.13/site-packages/zha/decorators.py:78> cb=[set.remove()]>] executing periodic task [zha.application.helpers::GlobalUpdater.update_listeners]
Global updater interval starting
Global updater interval finished
Feeding watchdog
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 35, 481277, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.Broadcast: 15>, address=<BroadcastAddress.ALL_ROUTERS_AND_COORDINATOR: 65532>), dst_ep=0, source_route=None, extended_timeout=False, tsn=129, profile_id=0, cluster_id=19, data=Serialized[b'\x81%\x16\xba\xf9W\xfe\xffA-\x14\x80'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
New device 0x1625 (14:2d:41:ff:fe:57:f9:ba) joined the network
Emitting event device_joined with data DeviceJoinedEvent(device_info=DeviceJoinedDeviceInfo(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, pairing_status=<DevicePairingStatus.PAIRED: 1>), event_type='zha_gateway_message', event='device_joined') (1 listeners)
(ZHAGatewayProxy) handling event protocol for event: DeviceJoinedEvent(device_info=DeviceJoinedDeviceInfo(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, pairing_status=<DevicePairingStatus.PAIRED: 1>), event_type='zha_gateway_message', event='device_joined')
[0x1625] Scheduling initialization
Received frame on uninitialized device <Device model=None manuf=None nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=False> from ep 0 to ep 0, cluster 19: Serialized[b'\x81%\x16\xba\xf9W\xfe\xffA-\x14\x80']
[0x1625:zdo] ZDO request ZDOCmd.Device_annce: [0x1625, 14:2d:41:ff:fe:57:f9:ba, 128]
Tries remaining: 5
[0x1625] Requesting 'Node Descriptor'
[0x1625] Extending timeout for 0x01 request
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 35, 888477, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=1, profile_id=0, cluster_id=32770, data=Serialized[b'\x01\x00%\x16\x02@\x80|\x11RR\x00\x00,R\x00\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
Received frame on uninitialized device <Device model=None manuf=None nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=False> from ep 0 to ep 0, cluster 32770: Serialized[b'\x01\x00%\x16\x02@\x80|\x11RR\x00\x00,R\x00\x00']
[0x1625] Got Node Descriptor: NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4476, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.NONE: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)
[0x1625] Discovering endpoints
[0x1625] Extending timeout for 0x02 request
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 36, 183402, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=2, profile_id=0, cluster_id=32773, data=Serialized[b'\x02\x00%\x16\x02\x01\x02'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
Received frame on uninitialized device <Device model=None manuf=None nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=False> from ep 0 to ep 0, cluster 32773: Serialized[b'\x02\x00%\x16\x02\x01\x02']
[0x1625] Discovered endpoints: [1, 2]
[0x1625] Initializing endpoints [<Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>, <Endpoint id=2 in=[] out=[] status=<Status.NEW: 0>>]
[0x1625:1] Discovering endpoint information
[0x1625] Extending timeout for 0x03 request
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 36, 490788, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=3, profile_id=0, cluster_id=32772, data=Serialized[b'\x03\x00%\x16"\x01\x04\x01\x03\x01\x01\x08\x00\x00\x01\x00\x03\x00 \x00\x05\x0b\x00\x10|\xfc\x81\xfc\x05\x03\x00\x04\x00\x06\x00\x19\x00\x00\x10'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
Received frame on uninitialized device <Device model=None manuf=None nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=False> from ep 0 to ep 0, cluster 32772: Serialized[b'\x03\x00%\x16"\x01\x04\x01\x03\x01\x01\x08\x00\x00\x01\x00\x03\x00 \x00\x05\x0b\x00\x10|\xfc\x81\xfc\x05\x03\x00\x04\x00\x06\x00\x19\x00\x00\x10']
[0x1625:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=259, device_version=1, input_clusters=[0, 1, 3, 32, 2821, 4096, 64636, 64641], output_clusters=[3, 4, 6, 25, 4096])
[0x1625:2] Discovering endpoint information
[0x1625] Extending timeout for 0x04 request
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 36, 781940, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=4, profile_id=0, cluster_id=32772, data=Serialized[b'\x04\x00%\x16\x10\x02\x04\x01\x02\x04\x01\x03\x00\x00\x03\x00\x00\x05\x01\x03\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
Received frame on uninitialized device <Device model=None manuf=None nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=False> from ep 0 to ep 0, cluster 32772: Serialized[b'\x04\x00%\x16\x10\x02\x04\x01\x02\x04\x01\x03\x00\x00\x03\x00\x00\x05\x01\x03\x00']
[0x1625:2] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=2, profile=260, device_type=1026, device_version=1, input_clusters=[0, 3, 1280], output_clusters=[3])
[0x1625:1:0x0000] Sending request header: ZCLHeader(frame_control=FrameControl<0x00>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=5, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Client_to_Server: 0>)
[0x1625:1:0x0000] Sending request: Read_Attributes(attribute_ids=[4, 5])
[0x1625] Extending timeout for 0x05 request
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 37, 490399, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), 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=0, data=Serialized[b'\x08\x05\x01\x04\x00\x00B\x0eIKEA of Sweden\x05\x00\x00B\x1bPARASOLL Door/Window Sensor'], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=229, rssi=None)
[0x1625:1:0x0000] Received ZCL frame: b'\x08\x05\x01\x04\x00\x00B\x0eIKEA of Sweden\x05\x00\x00B\x1bPARASOLL Door/Window Sensor'
[0x1625:1:0x0000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x08>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=5, command_id=1, *direction=<Direction.Server_to_Client: 1>)
[0x1625:1:0x0000] Decoded ZCL frame: Basic:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=4, status=<Status.SUCCESS: 0>, value=TypeValue(type=CharacterString, value='IKEA of Sweden')), ReadAttributeRecord(attrid=5, status=<Status.SUCCESS: 0>, value=TypeValue(type=CharacterString, value='PARASOLL Door/Window Sensor'))])
[0x1625] Read model 'PARASOLL Door/Window Sensor' and manufacturer 'IKEA of Sweden' from <Endpoint id=1 in=[basic:0x0000, power:0x0001, identify:0x0003, poll_control:0x0020, diagnostic:0x0B05, lightlink:0x1000, manufacturer_specific:0xFC7C, manufacturer_specific:0xFC81] out=[identify:0x0003, groups:0x0004, on_off:0x0006, ota:0x0019, lightlink:0x1000] status=<Status.ZDO_INIT: 1>>
[0x1625] Discovered basic device information for <Device model='PARASOLL Door/Window Sensor' manuf='IKEA of Sweden' nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=True>
Device is initialized <Device model='PARASOLL Door/Window Sensor' manuf='IKEA of Sweden' nwk=0x1625 ieee=14:2d:41:ff:fe:57:f9:ba is_initialized=True>
Emitting event raw_device_initialized with data RawDeviceInitializedEvent(device_info=RawDeviceInitializedDeviceInfo(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, pairing_status=<DevicePairingStatus.INTERVIEW_COMPLETE: 2>, model='PARASOLL Door/Window Sensor', manufacturer='IKEA of Sweden', signature={'manufacturer': 'IKEA of Sweden', 'model': 'PARASOLL Door/Window Sensor', 'node_desc': {'logical_type': <LogicalType.EndDevice: 2>, 'complex_descriptor_available': 0, 'user_descriptor_available': 0, 'reserved': 0, 'aps_flags': 0, 'frequency_band': <FrequencyBand.Freq2400MHz: 8>, 'mac_capability_flags': <MACCapabilityFlags.AllocateAddress: 128>, 'manufacturer_code': 4476, 'maximum_buffer_size': 82, 'maximum_incoming_transfer_size': 82, 'server_mask': 11264, 'maximum_outgoing_transfer_size': 82, 'descriptor_capability_field': <DescriptorCapability.NONE: 0>}, 'endpoints': {1: {'profile_id': 260, 'device_type': <DeviceType.ON_OFF_LIGHT_SWITCH: 259>, 'input_clusters': [0, 1, 3, 32, 2821, 4096, 64636, 64641], 'output_clusters': [3, 4, 6, 25, 4096]}, 2: {'profile_id': 260, 'device_type': <DeviceType.IAS_ZONE: 1026>, 'input_clusters': [0, 3, 1280], 'output_clusters': [3]}}}), event_type='zha_gateway_message', event='raw_device_initialized') (1 listeners)
(ZHAGatewayProxy) handling event protocol for event: RawDeviceInitializedEvent(device_info=RawDeviceInitializedDeviceInfo(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, pairing_status=<DevicePairingStatus.INTERVIEW_COMPLETE: 2>, model='PARASOLL Door/Window Sensor', manufacturer='IKEA of Sweden', signature={'manufacturer': 'IKEA of Sweden', 'model': 'PARASOLL Door/Window Sensor', 'node_desc': {'logical_type': <LogicalType.EndDevice: 2>, 'complex_descriptor_available': 0, 'user_descriptor_available': 0, 'reserved': 0, 'aps_flags': 0, 'frequency_band': <FrequencyBand.Freq2400MHz: 8>, 'mac_capability_flags': <MACCapabilityFlags.AllocateAddress: 128>, 'manufacturer_code': 4476, 'maximum_buffer_size': 82, 'maximum_incoming_transfer_size': 82, 'server_mask': 11264, 'maximum_outgoing_transfer_size': 82, 'descriptor_capability_field': <DescriptorCapability.NONE: 0>}, 'endpoints': {1: {'profile_id': 260, 'device_type': <DeviceType.ON_OFF_LIGHT_SWITCH: 259>, 'input_clusters': [0, 1, 3, 32, 2821, 4096, 64636, 64641], 'output_clusters': [3, 4, 6, 25, 4096]}, 2: {'profile_id': 260, 'device_type': <DeviceType.IAS_ZONE: 1026>, 'input_clusters': [0, 3, 1280], 'output_clusters': [3]}}}), event_type='zha_gateway_message', event='raw_device_initialized')
Checking quirks for IKEA of Sweden PARASOLL Door/Window Sensor (14:2d:41:ff:fe:57:f9:ba)
Considering <class 'zhaquirks.xbee.xbee_io.XBeeSensor'>
Fail because endpoint list mismatch: {232, 230} {1, 2}
Considering <class 'zhaquirks.xbee.xbee3_io.XBee3Sensor'>
Fail because endpoint list mismatch: {232, 230} {1, 2}
Considering <class 'zhaquirks.tuya.ts0201.MoesTemperatureHumidtySensorWithScreen'>
Fail because endpoint list mismatch: {1} {1, 2}
Considering <class 'zhaquirks.smartthings.tag_v4.SmartThingsTagV4'>
Fail because endpoint list mismatch: {1} {1, 2}
Considering <class 'zhaquirks.smartthings.multi.SmartthingsMultiPurposeSensor'>
Fail because endpoint list mismatch: {1} {1, 2}
Considering <class 'zhaquirks.netvox.z308e3ed.Z308E3ED'>
Fail because endpoint list mismatch: {1} {1, 2}
Considering <class 'zhaquirks.gledopto.soposhgu10.SoposhGU10'>
Fail because endpoint list mismatch: {11, 13} {1, 2}
Creating cluster handler for cluster id: 0 class: <class 'zha.zigbee.cluster_handlers.general.BasicClusterHandler'>
Creating cluster handler for cluster id: 1 class: <class 'zha.zigbee.cluster_handlers.general.PowerConfigurationClusterHandler'>
Creating cluster handler for cluster id: 3 class: <class 'zha.zigbee.cluster_handlers.general.IdentifyClusterHandler'>
Creating cluster handler for cluster id: 32 class: <class 'zha.zigbee.cluster_handlers.general.PollControlClusterHandler'>
Creating cluster handler for cluster id: 2821 class: <class 'zha.zigbee.cluster_handlers.homeautomation.DiagnosticClusterHandler'>
Creating cluster handler for cluster id: 4096 class: <class 'zha.zigbee.cluster_handlers.lightlink.LightLinkClusterHandler'>
Creating cluster handler for cluster id: 64636 class: <class 'zha.zigbee.cluster_handlers.ClusterHandler'>
Creating cluster handler for cluster id: 64641 class: <class 'zha.zigbee.cluster_handlers.ClusterHandler'>
Creating client cluster handler for cluster id: 6 class: <class 'zha.zigbee.cluster_handlers.general.OnOffClientClusterHandler'>
Creating client cluster handler for cluster id: 25 class: <class 'zha.zigbee.cluster_handlers.general.OtaClientClusterHandler'>
Creating cluster handler for cluster id: 0 class: <class 'zha.zigbee.cluster_handlers.general.BasicClusterHandler'>
Creating cluster handler for cluster id: 3 class: <class 'zha.zigbee.cluster_handlers.general.IdentifyClusterHandler'>
Creating cluster handler for cluster id: 1280 class: <class 'zha.zigbee.cluster_handlers.security.IASZoneClusterHandler'>
device - 0x1625:14:2d:41:ff:fe:57:f9:ba entering async_device_initialized - is_new_join: True
device - 0x1625:14:2d:41:ff:fe:57:f9:ba has joined the ZHA zigbee network
[0x1625](PARASOLL Door/Window Sensor): Update device availability - device available: True - new availability: True - changed: False
[0x1625](PARASOLL Door/Window Sensor): started configuration
[0x1625:ZDO](PARASOLL Door/Window Sensor): 'async_configure' stage succeeded
Discovering entities for device: 14:2d:41:ff:fe:57:f9:ba-IKEA of Sweden PARASOLL Door/Window Sensor
Discovering entities for endpoint: 14:2d:41:ff:fe:57:f9:ba-1
'button' platform -> 'IdentifyButton' using ['identify']
'sensor' platform -> 'Battery' using ['power']
'sensor' platform -> 'RSSISensor' using ['basic']
'sensor' platform -> 'LQISensor' using ['basic']
'update' platform -> 'FirmwareUpdateEntity' using ['ota']
Discovering entities for endpoint: 14:2d:41:ff:fe:57:f9:ba-2
'binary_sensor' platform -> 'IASZone' using ['ias_zone']
'button' platform -> 'IdentifyButton' using ['identify']
'sensor' platform -> 'RSSISensor' using ['basic']
'sensor' platform -> 'LQISensor' using ['basic']
Attempting to discover quirks v2 entities for device: 14:2d:41:ff:fe:57:f9:ba-IKEA of Sweden PARASOLL Door/Window Sensor
Device: 14:2d:41:ff:fe:57:f9:ba-IKEA of Sweden PARASOLL Door/Window Sensor is not a quirks v2 device - skipping discover_quirks_v2_entities
[0x1625:1:0x0001]: Performing cluster binding
[0x1625] Extending timeout for 0x06 request
[0x1625:1:0x0000]: Configuring cluster attribute reporting
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Basic', cluster_id=0, attributes={}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0000', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:1:0x0000]: finished cluster handler configuration
[0x1625:1:0x0003]: Configuring cluster attribute reporting
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Identify', cluster_id=3, attributes={}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0003', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:1:0x0003]: finished cluster handler configuration
[0x1625:1:0x1000] Sending request header: ZCLHeader(frame_control=FrameControl<0x01>(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=7, command_id=65, *direction=<Direction.Client_to_Server: 0>)
[0x1625:1:0x1000] Sending request: get_group_identifiers(start_index=0)
[0x1625] Extending timeout for 0x07 request
Device concurrency (1) reached, delaying device request (0 enqueued)
[0x1625:1:0x0020]: Performing cluster binding
[0x1625] Extending timeout for 0x08 request
Device concurrency (1) reached, delaying device request (1 enqueued)
[0x1625:1:0x0019_client]: finished cluster handler configuration
[0x1625:1:0x0006_client]: Performing cluster binding
[0x1625] Extending timeout for 0x09 request
Device concurrency (1) reached, delaying device request (2 enqueued)
[0x1625:1:0x0019_client]: finished cluster handler configuration
[0x1625:2:0x0003]: Configuring cluster attribute reporting
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Identify', cluster_id=3, attributes={}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:2:0x0003', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:2:0x0003]: finished cluster handler configuration
[0x1625:2:0x0000]: Configuring cluster attribute reporting
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Basic', cluster_id=0, attributes={}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:2:0x0000', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:2:0x0000]: finished cluster handler configuration
[0x1625:2:0x0500] Sending request header: ZCLHeader(frame_control=FrameControl<0x00>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=10, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Client_to_Server: 0>)
[0x1625:2:0x0500] Sending request: Read_Attributes(attribute_ids=[1])
[0x1625] Extending timeout for 0x0a request
Device concurrency (1) reached, delaying device request (3 enqueued)
Error handling '_save_attribute' event with (14:2d:41:ff:fe:57:f9:ba, 1, <ClusterType.Server: 0>, 0, 4, 'IKEA of Sweden', datetime.datetime(2025, 5, 14, 20, 57, 37, 496339, tzinfo=datetime.timezone.utc)) params: FOREIGN KEY constraint failed
Error handling '_save_attribute' event with (14:2d:41:ff:fe:57:f9:ba, 1, <ClusterType.Server: 0>, 0, 5, 'PARASOLL Door/Window Sensor', datetime.datetime(2025, 5, 14, 20, 57, 37, 496439, tzinfo=datetime.timezone.utc)) params: FOREIGN KEY constraint failed
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 39, 476181, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=6, profile_id=0, cluster_id=32801, data=Serialized[b'\x06\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
[0x1625:1:0x0001]: bound 'power' cluster: Status.SUCCESS
Emitting event zha_channel_bind with data ClusterBindEvent(cluster_name='Power Configuration', cluster_id=1, success=True, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0001', event_type='zha_channel_message', event='zha_channel_bind') (0 listeners)
[0x1625:1:0x0001]: Configuring cluster attribute reporting
[0x1625:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl<0x00>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=11, command_id=<GeneralCommand.Configure_Reporting: 6>, *direction=<Direction.Client_to_Server: 0>)
[0x1625:1:0x0001] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0020, datatype=<DataTypeId.uint8: 32>, min_interval=3600, max_interval=10800, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0021, datatype=<DataTypeId.uint8: 32>, min_interval=3600, max_interval=10800, reportable_change=1)])
[0x1625] Extending timeout for 0x0b request
Device concurrency (1) reached, delaying device request (4 enqueued)
Previously delayed device request is now running, delayed by 1.97s
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 42, 468336, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), 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=4096, data=Serialized[b'\t\x07A\x01\x00\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=29, non_member_radius=0, lqi=225, rssi=None)
[0x1625:1:0x1000] Received ZCL frame: b'\t\x07A\x01\x00\x00'
[0x1625:1:0x1000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x09>(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=7, command_id=65, *direction=<Direction.Server_to_Client: 1>)
[0x1625:1:0x1000] Decoded ZCL frame: LightLink:get_group_identifiers_rsp(total=1, start_index=0, group_info_records=[])
[0x0000:2] Cannot add 0x0000 group, no groups cluster
[0x0000:1] Cannot add 0x0000 group, no groups cluster
Previously delayed device request is now running, delayed by 4.95s
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 45, 456819, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=8, profile_id=0, cluster_id=32801, data=Serialized[b'\x08\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
[0x1625:1:0x0020]: bound 'poll_control' cluster: Status.SUCCESS
Emitting event zha_channel_bind with data ClusterBindEvent(cluster_name='Poll Control', cluster_id=32, success=True, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0020', event_type='zha_channel_message', event='zha_channel_bind') (0 listeners)
[0x1625:1:0x0020]: Configuring cluster attribute reporting
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Poll Control', cluster_id=32, attributes={}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0020', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:1:0x0020]: Performing cluster handler specific configuration
Tries remaining: 3
[0x1625:1:0x0020] Sending request header: ZCLHeader(frame_control=FrameControl<0x00>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=12, command_id=<GeneralCommand.Write_Attributes: 2>, *direction=<Direction.Client_to_Server: 0>)
[0x1625:1:0x0020] Sending request: Write_Attributes(attributes=[Attribute(attrid=0x0000, value=TypeValue(type=uint32_t, value=13200))])
[0x1625] Extending timeout for 0x0c request
Device concurrency (1) reached, delaying device request (3 enqueued)
Previously delayed device request is now running, delayed by 7.94s
[<Task pending name='device-availability-checker_DeviceAvailabilityChecker' coro=<periodic.<locals>.scheduler.<locals>.wrapper() running at /usr/local/lib/python3.13/site-packages/zha/decorators.py:78> cb=[set.remove()]>] executing periodic task [zha.application.helpers::DeviceAvailabilityChecker.check_device_availability]
Device availability checker interval starting
Checking device availability
[0xBA2C](BADRING Water Leakage Sensor): Device seen - marking the device available and resetting counter
[0xBA2C](BADRING Water Leakage Sensor): Update device availability - device available: True - new availability: True - changed: False
[0x5748](PARASOLL Door/Window Sensor): Device seen - marking the device available and resetting counter
[0x5748](PARASOLL Door/Window Sensor): Update device availability - device available: True - new availability: True - changed: False
[0xF795](TRADFRI bulb E27 CWS globe 806lm): Device seen - marking the device available and resetting counter
[0xF795](TRADFRI bulb E27 CWS globe 806lm): Update device availability - device available: True - new availability: True - changed: False
[0xCE13](TRETAKT Smart plug): Device seen - marking the device available and resetting counter
[0xCE13](TRETAKT Smart plug): Update device availability - device available: True - new availability: True - changed: False
[0x3950](TRETAKT Smart plug): Device seen - marking the device available and resetting counter
[0x3950](TRETAKT Smart plug): Update device availability - device available: True - new availability: True - changed: False
[0x5B72](VALLHORN Wireless Motion Sensor): Device seen - marking the device available and resetting counter
[0x5B72](VALLHORN Wireless Motion Sensor): Update device availability - device available: True - new availability: True - changed: False
[0x1625](PARASOLL Door/Window Sensor): Device seen - marking the device available and resetting counter
[0x1625](PARASOLL Door/Window Sensor): Update device availability - device available: True - new availability: True - changed: False
Device availability checker interval finished
Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 5, 14, 20, 57, 48, 475262, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1625), src_ep=0, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=9, profile_id=0, cluster_id=32801, data=Serialized[b'\t\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=None, rssi=None)
[0x1625:1:0x0006_client]: bound 'on_off' cluster: Status.SUCCESS
Emitting event zha_channel_bind with data ClusterBindEvent(cluster_name='On/Off', cluster_id=6, success=True, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0006_CLIENT', event_type='zha_channel_message', event='zha_channel_bind') (0 listeners)
[0x1625:1:0x0006_client]: finished cluster handler configuration
Previously delayed device request is now running, delayed by 10.95s
Device 0x1625 (14:2d:41:ff:fe:57:f9:ba) left the network
[0x1625](PARASOLL Door/Window Sensor): Update device availability - device available: True - new availability: False - changed: True
[0x1625](PARASOLL Door/Window Sensor): Device availability changed and device became unavailable
Emitting event zha_event with data ZHAEvent(device_ieee=14:2d:41:ff:fe:57:f9:ba, unique_id='14:2d:41:ff:fe:57:f9:ba', data={'device_event_type': 'device_offline'}, event_type='zha_event', event='zha_event') (0 listeners)
[0x1625](PARASOLL Door/Window Sensor): Device is not on the network, marking unavailable
Emitting event device_left with data DeviceLeftEvent(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, event_type='zha_gateway_message', event='device_left') (1 listeners)
(ZHAGatewayProxy) handling event protocol for event: DeviceLeftEvent(ieee=14:2d:41:ff:fe:57:f9:ba, nwk=0x1625, event_type='zha_gateway_message', event='device_left')
[0x1625:1:0x0001]: failed to set reporting on 'power' cluster for: Device has left the network
Emitting event zha_channel_configure_reporting with data ClusterConfigureReportingEvent(cluster_name='Power Configuration', cluster_id=1, attributes={'battery_voltage': {'min': 3600, 'max': 10800, 'id': 'battery_voltage', 'name': 'battery_voltage', 'change': 1, 'status': None}, 'battery_percentage_remaining': {'min': 3600, 'max': 10800, 'id': 'battery_percentage_remaining', 'name': 'battery_percentage_remaining', 'change': 1, 'status': None}}, cluster_handler_unique_id='14:2d:41:ff:fe:57:f9:ba:1:0x0001', event_type='zha_channel_message', event='zha_channel_configure_reporting') (0 listeners)
[0x1625:1:0x0001]: finished cluster handler configuration
Tries remaining: 2
[0x1625:1:0x0020] Sending request header: ZCLHeader(frame_control=FrameControl<0x00>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=13, command_id=<GeneralCommand.Write_Attributes: 2>, *direction=<Direction.Client_to_Server: 0>)