OTA issue with some IKEA leds and not others #1555

pipiche38 · 2025-02-14T10:09:19Z

pipiche38
Feb 14, 2025

I'm trying to upgrade all my Ikea Leds with tradfri-bulb-w-1000lm_release_prod_v587810353_5a161508-742d-4eab-8761-286c80d116eb.ota (coming from @Koenkk) repo.

This firmware has been already pushed to 8 leds, but I'm not successul with 2 remainings led and I'mgetting this error message

2025-02-05 22:09:31,999 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:32,003 INFO :b"Warning while submitting - zcl_raw_ota_image_block_response_success 00:0d:6f:ff:fe:e4:55:15/0xd01c 0x104 0x19 payload: b'\x19c\x05\x00|\x11\x01!1F\t#\x00\x00\x00\x00?\x1e\xf1\xee\x0b\x00\x018\x00\x00\x00|\x11\x01!1F\t#\x02\x00EBL tradfri_light_basic\x00\x00\x00\x00\x00\x00\x00\x00\x00\xec)\x03\x00\x00\x00\xc0\xfd\x02\x00\x00' AckIsDisable: False Retry: 1/1 with exception: 'Failed to enqueue message: <sl_Status.FAIL: 1>' (<class 'zigpy.exceptions.DeliveryError'>))"
2025-02-05 22:09:32,005 INFO :b"_retry_or_not: result: Failed to enqueue message: <sl_Status.FAIL: 1> (<class 'zigpy.exceptions.DeliveryError'>)"

here are the full log

2025-02-05 22:08:29,802 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x00@%\xb7z\x00\x00\x00\x00\x00 *\x07\x00\x00\x000"\xd5\x08\x00\x001"\x00\x00\x00\x00A%b\x1f\x00\x00\x00\x00\x00!*\x00\x00\x00\x04A \x00'
2025-02-05 22:08:29,806 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:29,816 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4000, value=TypeValue(type=uint48_t, value=31415)), Attribute(attrid=0x2000, value=TypeValue(type=int24s, value=7)), Attribute(attrid=0x3000, value=TypeValue(type=uint24_t, value=2261)), Attribute(attrid=0x3100, value=TypeValue(type=uint24_t, value=0)), Attribute(attrid=0x4100, value=TypeValue(type=uint48_t, value=8034)), Attribute(attrid=0x2100, value=TypeValue(type=int24s, value=0)), Attribute(attrid=0x4104, value=TypeValue(type=uint8_t, value=0))])
2025-02-05 22:08:29,824 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4000, value=TypeValue(type=uint48_t, value=31415)), Attribute(attrid=0x2000, value=TypeValue(type=int24s, value=7)), Attribute(attrid=0x3000, value=TypeValue(type=uint24_t, value=2261)), Attribute(attrid=0x3100, value=TypeValue(type=uint24_t, value=0)), Attribute(attrid=0x4100, value=TypeValue(type=uint48_t, value=8034)), Attribute(attrid=0x2100, value=TypeValue(type=int24s, value=0)), Attribute(attrid=0x4104, value=TypeValue(type=uint8_t, value=0))])
2025-02-05 22:08:29,833 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4000=31415, 0x2000=7, 0x3000=2261, 0x3100=0, 0x4100=8034, 0x2100=0, 0x4104=0
2025-02-05 22:08:30,408 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 30, 407730, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=30, profile_id=260, cluster_id=1794, data=Serialized[b'\x1c<\x11\x00\n\x01@%\x12\xbf\x00\x00\x00\x00\x01 *b\x00\x00\x010"\xe7\x08\x00\x011"U\x02\x00\x01A%\xba\xae\x00\x00\x00\x00\x01!*^\x00\x00\x05A H'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:08:30,419 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x01@%\x12\xbf\x00\x00\x00\x00\x01 *b\x00\x00\x010"\xe7\x08\x00\x011"U\x02\x00\x01A%\xba\xae\x00\x00\x00\x00\x01!*^\x00\x00\x05A H'
2025-02-05 22:08:30,427 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:30,435 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4001, value=TypeValue(type=uint48_t, value=48914)), Attribute(attrid=0x2001, value=TypeValue(type=int24s, value=98)), Attribute(attrid=0x3001, value=TypeValue(type=uint24_t, value=2279)), Attribute(attrid=0x3101, value=TypeValue(type=uint24_t, value=597)), Attribute(attrid=0x4101, value=TypeValue(type=uint48_t, value=44730)), Attribute(attrid=0x2101, value=TypeValue(type=int24s, value=94)), Attribute(attrid=0x4105, value=TypeValue(type=uint8_t, value=72))])
2025-02-05 22:08:30,441 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4001, value=TypeValue(type=uint48_t, value=48914)), Attribute(attrid=0x2001, value=TypeValue(type=int24s, value=98)), Attribute(attrid=0x3001, value=TypeValue(type=uint24_t, value=2279)), Attribute(attrid=0x3101, value=TypeValue(type=uint24_t, value=597)), Attribute(attrid=0x4101, value=TypeValue(type=uint48_t, value=44730)), Attribute(attrid=0x2101, value=TypeValue(type=int24s, value=94)), Attribute(attrid=0x4105, value=TypeValue(type=uint8_t, value=72))])
2025-02-05 22:08:30,446 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4001=48914, 0x2001=98, 0x3001=2279, 0x3101=597, 0x4101=44730, 0x2101=94, 0x4105=72
2025-02-05 22:08:30,898 DEBUG   :Received a packe
8000
t: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 30, 896740, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=31, profile_id=260, cluster_id=1794, data=Serialized[b'\x1c<\x11\x00\n\x02@%\x9ej\x01\x00\x00\x00\x02 *L\x00\x00\x020"\xc4\x08\x00\x021"k\x01\x00\x02A%\xbc\x99\x00\x00\x00\x00\x02!*\x1e\x00\x00\x06A ]'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:08:30,917 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x02@%\x9ej\x01\x00\x00\x00\x02 *L\x00\x00\x020"\xc4\x08\x00\x021"k\x01\x00\x02A%\xbc\x99\x00\x00\x00\x00\x02!*\x1e\x00\x00\x06A ]'
2025-02-05 22:08:30,920 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:30,929 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4002, value=TypeValue(type=uint48_t, value=92830)), Attribute(attrid=0x2002, value=TypeValue(type=int24s, value=76)), Attribute(attrid=0x3002, value=TypeValue(type=uint24_t, value=2244)), Attribute(attrid=0x3102, value=TypeValue(type=uint24_t, value=363)), Attribute(attrid=0x4102, value=TypeValue(type=uint48_t, value=39356)), Attribute(attrid=0x2102, value=TypeValue(type=int24s, value=30)), Attribute(attrid=0x4106, value=TypeValue(type=uint8_t, value=93))])
2025-02-05 22:08:30,935 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4002, value=TypeValue(type=uint48_t, value=92830)), Attribute(attrid=0x2002, value=TypeValue(type=int24s, value=76)), Attribute(attrid=0x3002, value=TypeValue(type=uint24_t, value=2244)), Attribute(attrid=0x3102, value=TypeValue(type=uint24_t, value=363)), Attribute(attrid=0x4102, value=TypeValue(type=uint48_t, value=39356)), Attribute(attrid=0x2102, value=TypeValue(type=int24s, value=30)), Attribute(attrid=0x4106, value=TypeValue(type=uint8_t, value=93))])
2025-02-05 22:08:30,949 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4002=92830, 0x2002=76, 0x3002=2244, 0x3102=363, 0x4102=39356, 0x2102=30, 0x4106=93
2025-02-05 22:08:39,169 DEBUG   :Feeding watchdog
2025-02-05 22:08:39,224 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 39, 223714, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x1697), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=150, profile_id=260, cluster_id=8, data=Serialized[b'80\n\x00\x00 \xfe'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=148, rssi=-63)
2025-02-05 22:08:39,239 DEBUG   :[0x1697:1:0x0008] Received ZCL frame: b'80\n\x00\x00 \xfe'
2025-02-05 22:08:39,244 DEBUG   :[0x1697:1:0x0008] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x38>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=1, *is_cluster=False, *is_general=True), tsn=48, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:39,249 DEBUG   :[0x1697:1:0x0008] Decoded ZCL frame: LevelControl:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=254))])
2025-02-05 22:08:39,251 DEBUG   :[0x1697:1:0x0008] Received command 0x0A (TSN 48): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=254))])
2025-02-05 22:08:39,253 DEBUG   :[0x1697:1:0x0008] Attribute report received: current_level=254
2025-02-05 22:08:47,065 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:08:49,264 DEBUG   :Feeding watchdog
2025-02-05 22:08:51,227 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 51, 226027, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x683F), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=201, profile_id=260, cluster_id=6, data=Serialized[b'8a\n\x00\x00\x10\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=172, rssi=-57)
2025-02-05 22:08:51,234 DEBUG   :[0x683F:1:0x0006] Received ZCL frame: b'8a\n\x00\x00\x10\x00'
2025-02-05 22:08:51,241 DEBUG   :[0x683F:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x38>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=1, *is_cluster=False, *is_general=True), tsn=97, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:51,245 DEBUG   :[0x683F:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,247 DEBUG   :[0x683F:1:0x0006] Received command 0x0A (TSN 97): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,249 DEBUG   :[0x683F:1:0x0006] Attribute report received: on_off=<Bool.false: 0>
2025-02-05 22:08:51,308 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 51, 307838, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xB033), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=165, profile_id=260, cluster_id=6, data=Serialized[b'8h\n\x00\x00\x10\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=180, rssi=-55)
2025-02-05 22:08:51,315 DEBUG   :[0xB033:1:0x0006] Received ZCL frame: b'8h\n\x00\x00\x10\x00'
2025-02-05 22:08:51,318 DEBUG   :[0xB033:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x38>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=1, *is_cluster=False, *is_general=True), tsn=104, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:51,327 DEBUG   :[0xB033:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,329 DEBUG   :[0xB033:1:0x0006] Received command 0x0A (TSN 104): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,331 DEBUG   :[0xB033:1:0x0006] Attribute report received: on_off=<Bool.false: 0>
2025-02-05 22:08:51,380 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 51, 379819, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xD01C), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=39, profile_id=260, cluster_id=6, data=Serialized[b'\x08Z\n\x00\x00\x10\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=172, rssi=-57)
2025-02-05 22:08:51,389 DEBUG   :[0xD01C:1:0x0006] Received ZCL frame: b'\x08Z\n\x00\x00\x10\x00'
2025-02-05 22:08:51,392 DEBUG   :[0xD01C:1:0x0006] 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=90, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:51,396 DEBUG   :[0xD01C:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,399 DEBUG   :[0xD01C:1:0x0006] Received command 0x0A (TSN 90): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:51,402 DEBUG   :[0xD01C:1:0x0006] Attribute report received: on_off=<Bool.false: 0>
2025-02-05 22:08:51,418 DEBUG   :[0xD01C:1:0x0006] Sending reply header: ZCLHeader(frame_control=FrameControl<0x10>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Client_to_Server: 0>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=90, command_id=<GeneralCommand.Default_Response: 11>, *direction=<Direction.Client_to_Server: 0>)
2025-02-05 22:08:51,422 DEBUG   :[0xD01C:1:0x0006] Sending reply: Default_Response(command_id=10, status=<Status.SUCCESS: 0>)
2025-02-05 22:08:52,009 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:08:55,366 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 8, 55, 365974, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0xB38D), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=252, profile_id=260, cluster_id=6, data=Serialized[b'8|\n\x00\x00\x10\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:08:55,370 DEBUG   :[0xB38D:1:0x0006] Received ZCL frame: b'8|\n\x00\x00\x10\x00'
2025-02-05 22:08:55,374 DEBUG   :[0xB38D:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x38>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=1, *is_cluster=False, *is_general=True), tsn=124, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:08:55,376 DEBUG   :[0xB38D:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:55,377 DEBUG   :[0xB38D:1:0x0006] Received command 0x0A (TSN 124): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:08:55,378 DEBUG   :[0xB38D:1:0x0006] Attribute report received: on_off=<Bool.false: 0>
2025-02-05 22:08:57,017 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:08:59,319 DEBUG   :Feeding watchdog
2025-02-05 22:09:02,006 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:06,992 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:08,837 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 8, 835914, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x6EF5), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=55, profile_id=260, cluster_id=8, data=Serialized[b'8}\n\x00\x00 \x9e'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=192, rssi=-52)
2025-02-05 22:09:08,845 DEBUG   :[0x6EF5:1:0x0008] Received ZCL frame: b'8}\n\x00\x00 \x9e'
2025-02-05 22:09:08,852 DEBUG   :[0x6EF5:1:0x0008] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x38>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=1, *is_cluster=False, *is_general=True), tsn=125, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:08,857 DEBUG   :[0x6EF5:1:0x0008] Decoded ZCL frame: LevelControl:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=158))])
2025-02-05 22:09:08,859 DEBUG   :[0x6EF5:1:0x0008] Received command 0x0A (TSN 125): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=158))])
2025-02-05 22:09:08,861 DEBUG   :[0x6EF5:1:0x0008] Attribute report received: current_level=158
2025-02-05 22:09:09,377 DEBUG   :Feeding watchdog
2025-02-05 22:09:09,394 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 9, 393883, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x8CD9), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=5, profile_id=260, cluster_id=6, data=Serialized[b'\x18T\n\x00\x00\x10\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=112, rssi=-72)
2025-02-05 22:09:09,404 DEBUG   :[0x8CD9:1:0x0006] Received ZCL frame: b'\x18T\n\x00\x00\x10\x00'
2025-02-05 22:09:09,408 DEBUG   :[0x8CD9:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=84, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:09,412 DEBUG   :[0x8CD9:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:09:09,415 DEBUG   :[0x8CD9:1:0x0006] Received command 0x0A (TSN 84): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=<Bool.false: 0>))])
2025-02-05 22:09:09,417 DEBUG   :[0x8CD9:1:0x0006] Attribute report received: on_off=<Bool.false: 0>
2025-02-05 22:09:11,991 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:16,131 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 16, 130600, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x8CD9), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=6, profile_id=260, cluster_id=2820, data=Serialized[b'\x18U\n\x05\x05!\xef\x08'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=112, rssi=-72)
2025-02-05 22:09:16,138 DEBUG   :[0x8CD9:1:0x0b04] Received ZCL frame: b'\x18U\n\x05\x05!\xef\x08'
2025-02-05 22:09:16,141 DEBUG   :[0x8CD9:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=85, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:16,148 DEBUG   :[0x8CD9:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Report_Attributes(attribute_reports=[Attribute(attrid=0x0505, value=TypeValue(type=uint16_t, value=2287))])
2025-02-05 22:09:16,150 DEBUG   :[0x8CD9:1:0x0b04] Received command 0x0A (TSN 85): Report_Attributes(attribute_reports=[Attribute(attrid=0x0505, value=TypeValue(type=uint16_t, value=2287))])
2025-02-05 22:09:16,152 DEBUG   :[0x8CD9:1:0x0b04] Attribute report received: rms_voltage=2287
2025-02-05 22:09:16,990 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:19,463 DEBUG   :Feeding watchdog
2025-02-05 22:09:21,988 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:26,987 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>
2025-02-05 22:09:29,098 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 29, 96927, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=32, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\x00\n\x00\x00%i\xa4\x02\x00\x00\x00\x00\x04*\xb2\x00\x00\x031"\xcd\x03\x00\x03A%\xd9g\x01\x00\x00\x00\x03!*\x7f\x00\x00\x00\x02\x18\x00'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:09:29,147 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x18\x00\n\x00\x00%i\xa4\x02\x00\x00\x00\x00\x04*\xb2\x00\x00\x031"\xcd\x03\x00\x03A%\xd9g\x01\x00\x00\x00\x03!*\x7f\x00\x00\x00\x02\x18\x00'
2025-02-05 22:09:29,151 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x18>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:29,161 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=173161)), Attribute(attrid=0x0400, value=TypeValue(type=int24s, value=178)), Attribute(attrid=0x3103, value=TypeValue(type=uint24_t, value=973)), Attribute(attrid=0x4103, value=TypeValue(type=uint48_t, value=92121)), Attribute(attrid=0x2103, value=TypeValue(type=int24s, value=127)), Attribute(attrid=0x0200, value=TypeValue(type=bitmap8, value=<bitmap8: 0>))])
2025-02-05 22:09:29,168 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=173161)), Attribute(attrid=0x0400, value=TypeValue(type=int24s, value=178)), Attribute(attrid=0x3103, value=TypeValue(type=uint24_t, value=973)), Attribute(attrid=0x4103, value=TypeValue(type=uint48_t, value=92121)), Attribute(attrid=0x2103, value=TypeValue(type=int24s, value=127)), Attribute(attrid=0x0200, value=TypeValue(type=bitmap8, value=<bitmap8: 0>))])
2025-02-05 22:09:29,175 DEBUG   :[0x4608:1:0x0702] Attribute report received: current_summ_delivered=173161, instantaneous_demand=178, 0x3103=973, 0x4103=92121, 0x2103=127, status=<bitmap8: 0>
2025-02-05 22:09:29,517 DEBUG   :Feeding watchdog
2025-02-05 22:09:29,601 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 29, 599925, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=33, profile_id=260, cluster_id=1794, data=Serialized[b'\x1c<\x11\x00\n\x00@%\xb7z\x00\x00\x00\x00\x00 *\x05\x00\x00\x000"\xd6\x08\x00\x001"\x08\x00\x00\x00A%b\x1f\x00\x00\x00\x00\x00!*\x00\x00\x00\x04A d'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:09:29,617 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x00@%\xb7z\x00\x00\x00\x00\x00 *\x05\x00\x00\x000"\xd6\x08\x00\x001"\x08\x00\x00\x00A%b\x1f\x00\x00\x00\x00\x00!*\x00\x00\x00\x04A d'
2025-02-05 22:09:29,620 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:29,630 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4000, value=TypeValue(type=uint48_t, value=31415)), Attribute(attrid=0x2000, value=TypeValue(type=int24s, value=5)), Attribute(attrid=0x3000, value=TypeValue(type=uint24_t, value=2262)), Attribute(attrid=0x3100, value=TypeValue(type=uint24_t, value=8)), Attribute(attrid=0x4100, value=TypeValue(type=uint48_t, value=8034)), Attribute(attrid=0x2100, value=TypeValue(type=int24s, value=0)), Attribute(attrid=0x4104, value=TypeValue(type=uint8_t, value=100))])
2025-02-05 22:09:29,636 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4000, value=TypeValue(type=uint48_t, value=31415)), Attribute(attrid=0x2000, value=TypeValue(type=int24s, value=5)), Attribute(attrid=0x3000, value=TypeValue(type=uint24_t, value=2262)), Attribute(attrid=0x3100, value=TypeValue(type=uint24_t, value=8)), Attribute(attrid=0x4100, value=TypeValue(type=uint48_t, value=8034)), Attribute(attrid=0x2100, value=TypeValue(type=int24s, value=0)), Attribute(attrid=0x4104, value=TypeValue(type=uint8_t, value=100))])
2025-02-05 22:09:29,646 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4000=31415, 0x2000=5, 0x3000=2262, 0x3100=8, 0x4100=8034, 0x2100=0, 0x4104=100
2025-02-05 22:09:30,390 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 30, 389312, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=34, profile_id=260, cluster_id=1794, data=Serialized[b'\x1c<\x11\x00\n\x01@%\x13\xbf\x00\x00\x00\x00\x01 *a\x00\x00\x010"\xe7\x08\x00\x011"Q\x02\x00\x01A%\xbb\xae\x00\x00\x00\x00\x01!*_\x00\x00\x05A H'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:09:30,406 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x01@%\x13\xbf\x00\x00\x00\x00\x01 *a\x00\x00\x010"\xe7\x08\x00\x011"Q\x02\x00\x01A%\xbb\xae\x00\x00\x00\x00\x01!*_\x00\x00\x05A H'
2025-02-05 22:09:30,409 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:30,417 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4001, value=TypeValue(type=uint48_t, value=48915)), Attribute(attrid=0x2001, value=TypeValue(type=int24s, value=97)), Attribute(attrid=0x3001, value=TypeValue(type=uint24_t, value=2279)), Attribute(attrid=0x3101, value=TypeValue(type=uint24_t, value=593)), Attribute(attrid=0x4101, value=TypeValue(type=uint48_t, value=44731)), Attribute(attrid=0x2101, value=TypeValue(type=int24s, value=95)), Attribute(attrid=0x4105, value=TypeValue(type=uint8_t, value=72))])
2025-02-05 22:09:30,423 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4001, value=TypeValue(type=uint48_t, value=48915)), Attribute(attrid=0x2001, value=TypeValue(type=int24s, value=97)), Attribute(attrid=0x3001, value=TypeValue(type=uint24_t, value=2279)), Attribute(attrid=0x3101, value=TypeValue(type=uint24_t, value=593)), Attribute(attrid=0x4101, value=TypeValue(type=uint48_t, value=44731)), Attribute(attrid=0x2101, value=TypeValue(type=int24s, value=95)), Attribute(attrid=0x4105, value=TypeValue(type=uint8_t, value=72))])
2025-02-05 22:09:30,428 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4001=48915, 0x2001=97, 0x3001=2279, 0x3101=593, 0x4101=44731, 0x2101=95, 0x4105=72
2025-02-05 22:09:30,966 DEBUG   :Received a packet: ZigbeePacket(timestamp=datetime.datetime(2025, 2, 5, 21, 9, 30, 965535, tzinfo=datetime.timezone.utc), priority=0, src=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x4608), src_ep=1, dst=AddrModeAddress(addr_mode=<AddrMode.NWK: 2>, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=35, profile_id=260, cluster_id=1794, data=Serialized[b'\x1c<\x11\x00\n\x02@%\x9fj\x01\x00\x00\x00\x02 *L\x00\x00\x020"\xbd\x08\x00\x021"t\x01\x00\x02A%\xbc\x99\x00\x00\x00\x00\x02!*!\x00\x00\x06A \\'], tx_options=<TransmitOptions.NONE: 0>, radius=0, non_member_radius=0, lqi=255, rssi=-30)
2025-02-05 22:09:30,983 DEBUG   :[0x4608:1:0x0702] Received ZCL frame: b'\x1c<\x11\x00\n\x02@%\x9fj\x01\x00\x00\x00\x02 *L\x00\x00\x020"\xbd\x08\x00\x021"t\x01\x00\x02A%\xbc\x99\x00\x00\x00\x00\x02!*!\x00\x00\x06A \\'
2025-02-05 22:09:30,986 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl<0x1C>(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=True, direction=<Direction.Server_to_Client: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4412, tsn=0, command_id=10, *direction=<Direction.Server_to_Client: 1>)
2025-02-05 22:09:30,994 DEBUG   :[0x4608:1:0x0702] Decoded ZCL frame: Metering:Report_Attributes(attribute_reports=[Attribute(attrid=0x4002, value=TypeValue(type=uint48_t, value=92831)), Attribute(attrid=0x2002, value=TypeValue(type=int24s, value=76)), Attribute(attrid=0x3002, value=TypeValue(type=uint24_t, value=2237)), Attribute(attrid=0x3102, value=TypeValue(type=uint24_t, value=372)), Attribute(attrid=0x4102, value=TypeValue(type=uint48_t, value=39356)), Attribute(attrid=0x2102, value=TypeValue(type=int24s, value=33)), Attribute(attrid=0x4106, value=TypeValue(type=uint8_t, value=92))])
2025-02-05 22:09:31,005 DEBUG   :[0x4608:1:0x0702] Received command 0x0A (TSN 0): Report_Attributes(attribute_reports=[Attribute(attrid=0x4002, value=TypeValue(type=uint48_t, value=92831)), Attribute(attrid=0x2002, value=TypeValue(type=int24s, value=76)), Attribute(attrid=0x3002, value=TypeValue(type=uint24_t, value=2237)), Attribute(attrid=0x3102, value=TypeValue(type=uint24_t, value=372)), Attribute(attrid=0x4102, value=TypeValue(type=uint48_t, value=39356)), Attribute(attrid=0x2102, value=TypeValue(type=int24s, value=33)), Attribute(attrid=0x4106, value=TypeValue(type=uint8_t, value=92))])
2025-02-05 22:09:31,013 DEBUG   :[0x4608:1:0x0702] Attribute report received: 0x4002=92831, 0x2002=76, 0x3002=2237, 0x3102=372, 0x4102=39356, 0x2102=33, 0x4106=92
2025-02-05 22:09:31,999 WARNING :Unknown status <EmberStatus.MESSAGE_TOO_LONG: 116>, converting to generic <sl_Status.FAIL: 1>

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Uh oh!

OTA issue with some IKEA leds and not others #1555

Uh oh!

{{title}}

Uh oh!

Uh oh!

{{editor}}'s edit

{{editor}}'s edit

Uh oh!

Replies: 0 comments

Select a reply

Uh oh!

OTA issue with some IKEA leds and not others #1555

Uh oh!

Uh oh!

pipiche38 Feb 14, 2025

Replies: 0 comments

pipiche38
Feb 14, 2025