search

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
72.62k stars 30.38k forks source link

Device available but off and attribute error #75131

Closed MetroAffe closed 2 years ago

MetroAffe commented 2 years ago

The problem

After I changed the batterys of my Ikea Tradfri Motion sensors its not working anymore. All other devices working without any problem.

It looks like it’s available but offline (sleep mode?!) I‘m not sure…

I already tried everything. Reset, restart, removed, add new device again …. No idea where the Problem is. Maybe can someone explain the log to me.

Adapter

sonoff zigbee 3.0 usb dongle plus

What version of Home Assistant Core has the issue?

Home Assistant 2022.7.3 Supervisor 2022.07.0 Operating System 8.2

What was the last working version of Home Assistant Core?

No response

What type of installation are you running?

Home Assistant Supervised

Integration causing the issue

ZHA

Link to integration documentation on our website

No response

Diagnostics information

No response

Example YAML snippet

No response

Anything in the logs that might be useful for us?

[0x0000:zdo] ZDO request ZDOCmd.Mgmt_Permit_Joining_rsp: [<Status.SUCCESS: 0>]
[0x0000:zdo] No handler for ZDO request:ZDOCmd.Mgmt_Permit_Joining_rsp([<Status.SUCCESS: 0>])

New device 0xf4e9 (80:4b:50:ff:fe:8e:39:44) joined the network
[0xf4e9] Scheduling initialization
Received frame on uninitialized device <Device model=None manuf=None nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=False> from ep 0 to ep 0, cluster 19: b'\x81\xe9\xf4D9\x8e\xfe\xffPK\x80\x80'
[0xf4e9:zdo] ZDO request ZDOCmd.Device_annce: [0xF4E9, 80:4b:50:ff:fe:8e:39:44, 128]
Tries remaining: 3
[0xf4e9] Requesting 'Node Descriptor'
Tries remaining: 2
[0xf4e9] Extending timeout for 0x08 request
Received frame on uninitialized device <Device model=None manuf=None nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x08\x00\xe9\xf4\x02@\x80|\x11RR\x00\x00,R\x00\x00'
[0xf4e9] 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)
[0xf4e9] Discovering endpoints
Tries remaining: 3
[0xf4e9] Extending timeout for 0x09 request
[0x20EF](lumi.sensor_magnet.aq2): Device seen - marking the device available and resetting counter
[0x20EF](lumi.sensor_magnet.aq2): Update device availability -  device available: True - new availability: True - changed: False
Received frame on uninitialized device <Device model=None manuf=None nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=False> from ep 0 to ep 0, cluster 32773: b'\t\x00\xe9\xf4\x01\x01'
[0xf4e9] Discovered endpoints: [1]
[0xf4e9] Initializing endpoints [<Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>]
[0xf4e9:1] Discovering endpoint information
Tries remaining: 3
[0xf4e9] Extending timeout for 0x0a request
Received frame on uninitialized device <Device model=None manuf=None nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=False> from ep 0 to ep 0, cluster 32772: b'\n\x00\xe9\xf4"\x01\x04\x01P\x08\x01\x07\x00\x00\x01\x00\x03\x00\t\x00 \x00\x00\x10|\xfc\x06\x03\x00\x04\x00\x06\x00\x08\x00\x19\x00\x00\x10'
[0xf4e9:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=2128, device_version=1, input_clusters=[0, 1, 3, 9, 32, 4096, 64636], output_clusters=[3, 4, 6, 8, 25, 4096])
[0xF4E9:1:0x0000] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=11, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0xF4E9:1:0x0000] Sending request: Read_Attributes(attribute_ids=[4, 5])
[0xf4e9] Extending timeout for 0x0b request
[0xF4E9:1:0x0000] Received ZCL frame: b'\x18\x0B\x01\x04\x00\x00\x42\x0E\x49\x4B\x45\x41\x20\x6F\x66\x20\x53\x77\x65\x64\x65\x6E\x05\x00\x00\x42\x15\x54\x52\x41\x44\x46\x52\x49\x20\x6D\x6F\x74\x69\x6F\x6E\x20\x73\x65\x6E\x73\x6F\x72'
[0xF4E9:1:0x0000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=11, command_id=1, *is_reply=True)
[0xF4E9:1:0x0000] Decoded ZCL frame: Basic:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0004, status=<Status.SUCCESS: 0>, value=TypeValue(type=CharacterString, value='IKEA of Sweden')), ReadAttributeRecord(attrid=0x0005, status=<Status.SUCCESS: 0>, value=TypeValue(type=CharacterString, value='TRADFRI motion sensor'))])
[0xf4e9] Read model 'TRADFRI motion sensor' and manufacturer 'IKEA of Sweden' from <Endpoint id=1 in=[basic:0x0000, power:0x0001, identify:0x0003, alarms:0x0009, poll_control:0x0020, lightlink:0x1000, manufacturer_specific:0xFC7C] out=[identify:0x0003, groups:0x0004, on_off:0x0006, level:0x0008, ota:0x0019, lightlink:0x1000] status=<Status.ZDO_INIT: 1>>
[0xf4e9] Discovered basic device information for <Device model='TRADFRI motion sensor' manuf='IKEA of Sweden' nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=True>
Device is initialized <Device model='TRADFRI motion sensor' manuf='IKEA of Sweden' nwk=0xF4E9 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=True>
Checking quirks for IKEA of Sweden TRADFRI motion sensor (80:4b:50:ff:fe:8e:39:44)
Considering <class 'zhaquirks.ikea.motionzha.IkeaTradfriMotionE1745'>
Found custom device replacement for 80:4b:50:ff:fe:8e:39:44: <class 'zhaquirks.ikea.motionzha.IkeaTradfriMotionE1745'>
'button' component -> 'ZHAIdentifyButton' using ['identify']
'sensor' component -> 'Battery' using ['power']
'sensor' component -> 'RSSISensor' using ['basic']
'sensor' component -> 'LQISensor' using ['basic']
device - 0xF4E9:80:4b:50:ff:fe:8e:39:44 entering async_device_initialized - is_new_join: True
device - 0xF4E9:80:4b:50:ff:fe:8e:39:44 has joined the ZHA zigbee network
[0xF4E9](TRADFRI motion sensor): started configuration
[0xF4E9:ZDO](TRADFRI motion sensor): 'async_configure' stage succeeded
[0xF4E9:1:0x0003]: Configuring cluster attribute reporting
[0xF4E9:1:0x0003]: finished channel configuration
[0xF4E9:1:0x0000]: Configuring cluster attribute reporting
[0xF4E9:1:0x0000]: finished channel configuration
[0xF4E9:1:0x0001]: Performing cluster binding
[0xf4e9] Extending timeout for 0x0c request
[0xF4E9:1:0x1000] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=13, command_id=65, *is_reply=False)
[0xF4E9:1:0x1000] Sending request: get_group_identifiers(start_index=0)
[0xf4e9] Extending timeout for 0x0d request
[0xF4E9:1:0x0020]: Performing cluster binding
[0xf4e9] Extending timeout for 0x0e request
[0xF4E9:1:0x0006]: Performing cluster binding
[0xf4e9] Extending timeout for 0x0f request
[0xF4E9:1:0x0008]: Performing cluster binding
[0xf4e9] Extending timeout for 0x10 request
[0xF4E9:1:0x0006]: Performing cluster binding
[0xf4e9] Extending timeout for 0x11 request
[0xF4E9:1:0x0019]: finished channel configuration
Error handling '_save_attribute' event with (80:4b:50:ff:fe:8e:39:44, 1, 0, 4, 'IKEA of Sweden') params: FOREIGN KEY constraint failed
Error handling '_save_attribute' event with (80:4b:50:ff:fe:8e:39:44, 1, 0, 5, 'TRADFRI motion sensor') params: FOREIGN KEY constraint failed
[0xF4E9:1:0x1000] Received ZCL frame: b'\x19\x0D\x41\x01\x00\x00'
[0xF4E9:1:0x1000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=True, *is_general=False), tsn=13, command_id=65, *is_reply=True)
[0xF4E9:1:0x1000] Decoded ZCL frame: LightLinkCluster: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
[0xF4E9:1:0x0001]: bound 'power' cluster: Status.SUCCESS
[0xF4E9:1:0x0001]: Configuring cluster attribute reporting
[0xF4E9:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=18, command_id=<GeneralCommand.Configure_Reporting: 6>, *is_reply=False)
[0xF4E9:1:0x0001] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0020, datatype=32, min_interval=3600, max_interval=10800, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0021, datatype=32, min_interval=3600, max_interval=10800, reportable_change=1)])
[0xf4e9] Extending timeout for 0x12 request
[0xF4E9:1:0x0006] Received ZCL frame: b'\x01\x01\x42\x00\x08\x07\x00\x00'
[0xF4E9:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=0, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=1, command_id=66, *is_reply=False)
[0xF4E9:1:0x0006] Decoded ZCL frame: OnOff:on_with_timed_off(on_off_control=0, on_time=1800, off_wait_time=0)
[0xF4E9:1:0x0006] Received command 0x42 (TSN 1): on_with_timed_off(on_off_control=0, on_time=1800, off_wait_time=0)
[0xF4E9:1:0x0006] No explicit handler for cluster command 0x42: on_with_timed_off(on_off_control=0, on_time=1800, off_wait_time=0)
[0xF4E9:1:0x0006]: received 'on_with_timed_off' command with on_with_timed_off(on_off_control=0, on_time=1800, off_wait_time=0) args on cluster_id '6' tsn '1'
[0xF4E9:1:0x0001] Received ZCL frame: b'\x08\x12\x07\x00'
[0xF4E9:1:0x0001] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, is_reply=1, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=18, command_id=7, *is_reply=True)
[0xF4E9:1:0x0001] Decoded ZCL frame: PowerConfiguration2CRCluster:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=0)])
[0xF4E9:1:0x0001]: Successfully configured reporting for '{'battery_voltage': (3600, 10800, 1), 'battery_percentage_remaining': (3600, 10800, 1)}' on 'power' cluster: [ConfigureReportingResponseRecord(status=0)]
[0xF4E9:1:0x0001]: finished channel configuration
Device 0xf4e9 (80:4b:50:ff:fe:8e:39:44) left the network
[0xF4E9:1:0x0020]: Failed to bind 'poll_control' cluster: 
[0xF4E9:1:0x0020]: Configuring cluster attribute reporting
[0xF4E9:1:0x0020]: Performing channel specific configuration
[0xF4E9:1:0x0020] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=19, command_id=<GeneralCommand.Write_Attributes: 2>, *is_reply=False)
[0xF4E9:1:0x0020] Sending request: Write_Attributes(attributes=[Attribute(attrid=0x0000, value=TypeValue(type=uint32_t, value=13200))])
[0xf4e9] Extending timeout for 0x13 request
[0xF4E9:1:0x0006]: Failed to bind 'on_off' cluster: 
[0xF4E9:1:0x0006]: finished channel configuration
[0xF4E9:1:0x0008]: Failed to bind 'level' cluster: 
[0xF4E9:1:0x0008]: finished channel configuration
[0xF4E9:1:0x0006]: Failed to bind 'on_off' cluster: 
[0xF4E9:1:0x0006]: finished channel configuration
[0xF4E9:1:0x0020]: Couldn't set check-in interval: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0xF4E9:1:0x0020]: finished channel configuration
[0xF4E9:1:0x0003]: 'async_configure' stage succeeded
[0xF4E9:1:0x0000]: 'async_configure' stage succeeded
[0xF4E9:1:0x0001]: 'async_configure' stage succeeded
[0xF4E9:1:0x1000]: 'async_configure' stage succeeded
[0xF4E9:1:0x0020]: 'async_configure' stage succeeded
[0xF4E9:1:0x0006]: 'async_configure' stage succeeded
[0xF4E9:1:0x0008]: 'async_configure' stage succeeded
[0xF4E9:1:0x0006]: 'async_configure' stage succeeded
[0xF4E9:1:0x0019]: 'async_configure' stage succeeded
[0xF4E9](TRADFRI motion sensor): completed configuration
[0xF4E9](TRADFRI motion sensor): stored in registry: ZhaDeviceEntry(name='IKEA of Sweden TRADFRI motion sensor', ieee='80:4b:50:ff:fe:8e:39:44', last_seen=1657698369.987027)
[0xF4E9:1:0x0003] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=20, command_id=64, *is_reply=False)
[0xF4E9:1:0x0003] Sending request: trigger_effect(effect_id=<EffectIdentifier.Okay: 2>, effect_variant=<EffectVariant.Default: 0>)
[0xf4e9] Extending timeout for 0x14 request
Device 0x21b2 (80:4b:50:ff:fe:8e:39:44) joined the network
Device 80:4b:50:ff:fe:8e:39:44 changed id (0xf4e9 => 0x21b2)
[0x21b2] Skipping initialization, device is fully initialized
Device is initialized <IkeaTradfriMotionE1745 model='TRADFRI motion sensor' manuf='IKEA of Sweden' nwk=0x21B2 ieee=80:4b:50:ff:fe:8e:39:44 is_initialized=True>
device - 0x21B2:80:4b:50:ff:fe:8e:39:44 entering async_device_initialized - is_new_join: True
device - 0x21B2:80:4b:50:ff:fe:8e:39:44 has joined the ZHA zigbee network
[0x21B2](TRADFRI motion sensor): started configuration
[0x21B2:ZDO](TRADFRI motion sensor): 'async_configure' stage succeeded
[0x21B2:1:0x0003]: Configuring cluster attribute reporting
[0x21B2:1:0x0003]: finished channel configuration
[0x21B2:1:0x0000]: Configuring cluster attribute reporting
[0x21B2:1:0x0000]: finished channel configuration
[0x21B2:1:0x0001]: Performing cluster binding
[0x21b2] Extending timeout for 0x15 request
[0x21B2:1:0x1000] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=22, command_id=65, *is_reply=False)
[0x21B2:1:0x1000] Sending request: get_group_identifiers(start_index=0)
[0x21b2] Extending timeout for 0x16 request
[0x21B2:1:0x0020]: Performing cluster binding
[0x21b2] Extending timeout for 0x17 request
[0x21B2:1:0x0006]: Performing cluster binding
[0x21b2] Extending timeout for 0x18 request
[0x21B2:1:0x0008]: Performing cluster binding
[0x21b2] Extending timeout for 0x19 request
[0x21B2:1:0x0006]: Performing cluster binding
[0x21b2] Extending timeout for 0x1a request
[0x21B2:1:0x0019]: finished channel configuration
Device 0x21b2 (80:4b:50:ff:fe:8e:39:44) joined the network
[0x21B2:1:0x1000]: Couldn't get list of groups: 
[0x21B2:1:0x0003]: command failed: 'trigger_effect' args: '(2, 0)' kwargs '{}' exception: ''
[0x21B2](TRADFRI motion sensor): started initialization
[0x21B2:ZDO](TRADFRI motion sensor): 'async_initialize' stage succeeded
[0x21B2:1:0x0003]: initializing channel: from_cache: False
[0x21B2:1:0x0003]: finished channel initialization
[0x21B2:1:0x0000]: initializing channel: from_cache: False
[0x21B2:1:0x0000]: finished channel initialization
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=27, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x1b request
[0x21B2:1:0x1000]: initializing channel: from_cache: False
[0x21B2:1:0x1000]: finished channel initialization
[0x21B2:1:0x0020]: initializing channel: from_cache: False
[0x21B2:1:0x0020]: finished channel initialization
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=28, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x1c request
[0x21B2:1:0x0008]: initializing channel: from_cache: False
[0x21B2:1:0x0008]: finished channel initialization
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: finished channel initialization
[0x21B2:1:0x0019]: initializing channel: from_cache: False
[0x21B2:1:0x0019]: finished channel initialization
[0x998B](lumi.weather): last_seen is 447495.6173315048 seconds ago and ping attempts have been exhausted, marking the device unavailable
[0x998B](lumi.weather): Update device availability -  device available: False - new availability: False - changed: False
[0x20EF](lumi.sensor_magnet.aq2): Device seen - marking the device available and resetting counter
[0x20EF](lumi.sensor_magnet.aq2): Update device availability -  device available: True - new availability: True - changed: False
[0xB455:1:0x0402] Received ZCL frame: b'\x18\x03\x0A\x00\x00\x29\x61\x09'
[0xB455:1:0x0402] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=3, command_id=10, *is_reply=True)
[0xB455:1:0x0402] Decoded ZCL frame: TemperatureMeasurementCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=2401))])
[0xB455:1:0x0402] Received command 0x0A (TSN 3): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=2401))])
[0xB455:1:0x0402] Attribute report received: measured_value=2401
[0xB455:1:0x0403] Received ZCL frame: b'\x18\x05\x0A\x00\x00\x29\xBE\x03\x14\x00\x28\xFF\x10\x00\x29\x74\x25'
[0xB455:1:0x0403] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=5, command_id=10, *is_reply=True)
[0xB455:1:0x0403] Decoded ZCL frame: PressureMeasurementCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=958)), Attribute(attrid=0x0014, value=TypeValue(type=int8s, value=-1)), Attribute(attrid=0x0010, value=TypeValue(type=int16s, value=9588))])
[0xB455:1:0x0403] Received command 0x0A (TSN 5): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=int16s, value=958)), Attribute(attrid=0x0014, value=TypeValue(type=int8s, value=-1)), Attribute(attrid=0x0010, value=TypeValue(type=int16s, value=9588))])
[0xB455:1:0x0403] Attribute report received: measured_value=958, 0x0014=-1, 0x0010=9588
[0xB455:1:0x0405] Received ZCL frame: b'\x18\x04\x0A\x00\x00\x21\xD0\x12'
[0xB455:1:0x0405] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=4, command_id=10, *is_reply=True)
[0xB455:1:0x0405] Decoded ZCL frame: RelativeHumidityCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint16_t, value=4816))])
[0xB455:1:0x0405] Received command 0x0A (TSN 4): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint16_t, value=4816))])
[0xB455:1:0x0405] Attribute report received: measured_value=4816
[0x21B2:1:0x0001]: Failed to bind 'power' cluster: 
[0x21B2:1:0x0001]: Configuring cluster attribute reporting
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=29, command_id=<GeneralCommand.Configure_Reporting: 6>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0020, datatype=32, min_interval=3600, max_interval=10800, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0021, datatype=32, min_interval=3600, max_interval=10800, reportable_change=1)])
[0x21b2] Extending timeout for 0x1d request
[0x21B2:1:0x0020]: Failed to bind 'poll_control' cluster: 
[0x21B2:1:0x0020]: Configuring cluster attribute reporting
[0x21B2:1:0x0020]: Performing channel specific configuration
[0x21B2:1:0x0020] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=30, command_id=<GeneralCommand.Write_Attributes: 2>, *is_reply=False)
[0x21B2:1:0x0020] Sending request: Write_Attributes(attributes=[Attribute(attrid=0x0000, value=TypeValue(type=uint32_t, value=13200))])
[0x21b2] Extending timeout for 0x1e request
[0x21B2:1:0x0006]: Failed to bind 'on_off' cluster: 
[0x21B2:1:0x0006]: finished channel configuration
[0x21B2:1:0x0008]: Failed to bind 'level' cluster: 
[0x21B2:1:0x0008]: finished channel configuration
[0x21B2:1:0x0006]: Failed to bind 'on_off' cluster: 
[0x21B2:1:0x0006]: finished channel configuration
[0xEFF2](lumi.weather): Device seen - marking the device available and resetting counter
[0xEFF2](lumi.weather): Update device availability -  device available: True - new availability: True - changed: False
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
[0x21B2:1:0x0001]: async_initialize: retryable request #1 failed: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>. Retrying in 0.9s
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>
[0x21B2:1:0x0006]: async_initialize: retryable request #1 failed: Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>. Retrying in 0.9s
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=31, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x1f request
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=32, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x20 request
[0x21B2:1:0x0001]: failed to set reporting on 'power' cluster for: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: finished channel configuration
[0x21B2:1:0x0020]: Couldn't set check-in interval: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0020]: finished channel configuration
[0x21B2:1:0x0003]: 'async_configure' stage succeeded
[0x21B2:1:0x0000]: 'async_configure' stage succeeded
[0x21B2:1:0x0001]: 'async_configure' stage succeeded
[0x21B2:1:0x1000]: 'async_configure' stage succeeded
[0x21B2:1:0x0020]: 'async_configure' stage succeeded
[0x21B2:1:0x0006]: 'async_configure' stage succeeded
[0x21B2:1:0x0008]: 'async_configure' stage succeeded
[0x21B2:1:0x0006]: 'async_configure' stage succeeded
[0x21B2:1:0x0019]: 'async_configure' stage succeeded
[0x21B2](TRADFRI motion sensor): completed configuration
[0x21B2](TRADFRI motion sensor): stored in registry: ZhaDeviceEntry(name='IKEA of Sweden TRADFRI motion sensor', ieee='80:4b:50:ff:fe:8e:39:44', last_seen=1657698404.466701)
[0x21B2:1:0x0003] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.CLUSTER_COMMAND: 1>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=33, command_id=64, *is_reply=False)
[0x21B2:1:0x0003] Sending request: trigger_effect(effect_id=<EffectIdentifier.Okay: 2>, effect_variant=<EffectVariant.Default: 0>)
[0x21b2] Extending timeout for 0x21 request
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: retryable request #2 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 1.0s
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: retryable request #2 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 1.2s
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=34, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x22 request
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=35, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x23 request
[0x21B2:1:0x0003]: command failed: 'trigger_effect' args: '(2, 0)' kwargs '{}' exception: 'Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>'
[0x21B2](TRADFRI motion sensor): started initialization
[0x21B2:ZDO](TRADFRI motion sensor): 'async_initialize' stage succeeded
[0x21B2:1:0x0003]: initializing channel: from_cache: False
[0x21B2:1:0x0003]: finished channel initialization
[0x21B2:1:0x0000]: initializing channel: from_cache: False
[0x21B2:1:0x0000]: finished channel initialization
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=36, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x24 request
[0x21B2:1:0x1000]: initializing channel: from_cache: False
[0x21B2:1:0x1000]: finished channel initialization
[0x21B2:1:0x0020]: initializing channel: from_cache: False
[0x21B2:1:0x0020]: finished channel initialization
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=37, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x25 request
[0x21B2:1:0x0008]: initializing channel: from_cache: False
[0x21B2:1:0x0008]: finished channel initialization
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: finished channel initialization
[0x21B2:1:0x0019]: initializing channel: from_cache: False
[0x21B2:1:0x0019]: finished channel initialization
[0x2547](lumi.weather): Device seen - marking the device available and resetting counter
[0x2547](lumi.weather): Update device availability -  device available: True - new availability: True - changed: False
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: retryable request #3 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 3.2s
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: retryable request #3 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 3.0s
[0x21B2](TRADFRI motion sensor): Device seen - marking the device available and resetting counter
[0x21B2](TRADFRI motion sensor): Update device availability -  device available: True - new availability: True - changed: False
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: retryable request #1 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 1.2s
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: retryable request #1 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 1.0s
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=38, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x26 request
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=39, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x27 request
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=40, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x28 request
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=41, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x29 request
[0xB455](lumi.weather): Device seen - marking the device available and resetting counter
[0xB455](lumi.weather): Update device availability -  device available: True - new availability: True - changed: False
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: retryable request #2 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 0.9s
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: retryable request #2 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 0.9s
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: all attempts have failed: [DeliveryError('Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>')]
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: all attempts have failed: [DeliveryError('Request failed after 5 attempts: <Status.MAC_NO_ACK: 233>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>'), DeliveryError('Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>')]
[0x21B2:1:0x0003]: 'async_initialize' stage succeeded
[0x21B2:1:0x0000]: 'async_initialize' stage succeeded
[0x21B2:1:0x0001]: 'async_initialize' stage succeeded
[0x21B2:1:0x1000]: 'async_initialize' stage succeeded
[0x21B2:1:0x0020]: 'async_initialize' stage succeeded
[0x21B2:1:0x0006]: 'async_initialize' stage succeeded
[0x21B2:1:0x0008]: 'async_initialize' stage succeeded
[0x21B2:1:0x0006]: 'async_initialize' stage succeeded
[0x21B2:1:0x0019]: 'async_initialize' stage succeeded
[0x21B2](TRADFRI motion sensor): power source: Battery or Unknown
[0x21B2](TRADFRI motion sensor): completed initialization
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=42, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x2a request
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=43, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x2b request
[0x21B2:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0006]: async_initialize: retryable request #3 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 3.5s
[0x21B2:1:0x0001]: failed to get attributes '['battery_voltage', 'battery_percentage_remaining']' on 'power' cluster: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>
[0x21B2:1:0x0001]: async_initialize: retryable request #3 failed: Request failed after 5 attempts: <Status.NWK_INVALID_REQUEST: 194>. Retrying in 2.7s
[0x21B2:1:0x0001]: initializing channel: from_cache: False
[0x21B2:1:0x0001]: initializing uncached channel attributes: ['battery_voltage', 'battery_percentage_remaining'] - from cache[False]
[0x21B2:1:0x0001]: Reading attributes in chunks: ['battery_voltage', 'battery_percentage_remaining']
[0x21B2:1:0x0001] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=44, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0001] Sending request: Read_Attributes(attribute_ids=[32, 33])
[0x21b2] Extending timeout for 0x2c request
[0x21B2:1:0x0006]: initializing channel: from_cache: False
[0x21B2:1:0x0006]: initializing cached channel attributes: ['start_up_on_off']
[0x21B2:1:0x0006]: Reading attributes in chunks: ['start_up_on_off']
[0x21B2:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=45, command_id=<GeneralCommand.Read_Attributes: 0>, *is_reply=False)
[0x21B2:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387])
[0x21b2] Extending timeout for 0x2d request

Additional information

No response

thorrrr commented 2 years ago

HI I have been going crazy i put new batteries 3 weeks ago Duracell but my IKEA keeps stopping working. I have renewed batteries to be sure and i have had to remove re add 6 times. It works for 6 to 18 hours then freezes it shows fully available but does not trigger. Soon as i re add it works fine again. It is not a connection issue as it has 6 mains repeaters around it and has worked for 2 years no issue. It is defo 2022.7 as if i roll back it works as before.

On a sidenote i am also seeing same items just dropping off as well that have always worked before. But again, if i roll back they don't !

MetroAffe commented 2 years ago

Okay well…. 2022.7.4 which was released today fixed it for me. Can you try this too? If it works I will close this issue

thorrrr commented 2 years ago

Okay well…. 2022.7.4 which was released today fixed it for me. Can you try this too? If it works I will close this issue

HI Yes mine is working fine now without even re adding it. I thought it was me going crazy

MetroAffe commented 2 years ago

Okay well…. 2022.7.4 which was released today fixed it for me. Can you try this too? If it works I will close this issue

HI Yes mine is working fine now without even re adding it. I thought it was me going crazy

Great 😊