zigpy / zha-device-handlers

ZHA device handlers bridge the functionality gap created when manufacturers deviate from the ZCL specification, handling deviations and exceptions by parsing custom messages to and from Zigbee devices.
Apache License 2.0
731 stars 673 forks source link

[BUG] Xiaomi Dual T2 relay does not show up fields #2934

Closed trapacska closed 8 months ago

trapacska commented 8 months ago

Bug description

image

My intent to use this thing for a garage door. Where Inwould like to have a pulse detached mode enabled with configurable pulse value, and to receive the two reed status from the switch inputs.

Steps to reproduce

zhaquirks/xiaomi/aqara/switch_acn047.py

copied this file to custom quirks, restarted HA but I still cant read detached state from S1 and S2 inputs.

Expected behavior

It was previously working with z2m in a way that it sent an action single_l1 or single_l2 when thise pins was shorted to COM.

Screenshots/Video

Screenshots/Video [Paste/upload your media here]

Device signature

Device signature ```json { "node_descriptor": "NodeDescriptor(logical_type=, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=, mac_capability_flags=, manufacturer_code=4447, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=False, *is_full_function_device=True, *is_mains_powered=True, *is_receiver_on_when_idle=True, *is_router=True, *is_security_capable=False)", "endpoints": { "1": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x0000", "0x0003", "0x0004", "0x0005", "0x0006", "0x0012", "0x0702", "0x0b04", "0xfcc0" ], "output_clusters": [ "0x000a", "0x0019" ] }, "2": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x0003", "0x0004", "0x0005", "0x0006", "0x0012", "0xfcc0" ], "output_clusters": [] }, "21": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x000c" ], "output_clusters": [] } }, "manufacturer": "Aqara", "model": "lumi.switch.acn047", "class": "zigpy.device.Device" } ```

Diagnostic information

Diagnostic information ```json { "home_assistant": { "installation_type": "Home Assistant OS", "version": "2023.11.2", "dev": false, "hassio": true, "virtualenv": false, "python_version": "3.11.6", "docker": true, "arch": "aarch64", "timezone": "Europe/Budapest", "os_name": "Linux", "os_version": "6.1.21-v8", "supervisor": "2023.12.1", "host_os": "Home Assistant OS 11.1", "docker_version": "24.0.6", "chassis": "embedded", "run_as_root": true }, "custom_components": { "hacs": { "version": "1.31.0", "requirements": [ "aiogithubapi>=22.10.1" ] } }, "integration_manifest": { "domain": "zha", "name": "Zigbee Home Automation", "after_dependencies": [ "onboarding", "usb" ], "codeowners": [ "@dmulcahey", "@adminiuga", "@puddly" ], "config_flow": true, "dependencies": [ "file_upload" ], "documentation": "https://www.home-assistant.io/integrations/zha", "iot_class": "local_polling", "loggers": [ "aiosqlite", "bellows", "crccheck", "pure_pcapy3", "zhaquirks", "zigpy", "zigpy_deconz", "zigpy_xbee", "zigpy_zigate", "zigpy_znp", "universal_silabs_flasher" ], "requirements": [ "bellows==0.36.8", "pyserial==3.5", "pyserial-asyncio==0.6", "zha-quirks==0.0.106", "zigpy-deconz==0.21.1", "zigpy==0.59.0", "zigpy-xbee==0.19.0", "zigpy-zigate==0.11.0", "zigpy-znp==0.11.6", "universal-silabs-flasher==0.0.14", "pyserial-asyncio-fast==0.11" ], "usb": [ { "vid": "10C4", "pid": "EA60", "description": "*2652*", "known_devices": [ "slae.sh cc2652rb stick" ] }, { "vid": "1A86", "pid": "55D4", "description": "*sonoff*plus*", "known_devices": [ "sonoff zigbee dongle plus v2" ] }, { "vid": "10C4", "pid": "EA60", "description": "*sonoff*plus*", "known_devices": [ "sonoff zigbee dongle plus" ] }, { "vid": "10C4", "pid": "EA60", "description": "*tubeszb*", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "*tubeszb*", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "*zigstar*", "known_devices": [ "ZigStar Coordinators" ] }, { "vid": "1CF1", "pid": "0030", "description": "*conbee*", "known_devices": [ "Conbee II" ] }, { "vid": "10C4", "pid": "8A2A", "description": "*zigbee*", "known_devices": [ "Nortek HUSBZB-1" ] }, { "vid": "0403", "pid": "6015", "description": "*zigate*", "known_devices": [ "ZiGate+" ] }, { "vid": "10C4", "pid": "EA60", "description": "*zigate*", "known_devices": [ "ZiGate" ] }, { "vid": "10C4", "pid": "8B34", "description": "*bv 2010/10*", "known_devices": [ "Bitron Video AV2010/10" ] } ], "zeroconf": [ { "type": "_esphomelib._tcp.local.", "name": "tube*" }, { "type": "_zigate-zigbee-gateway._tcp.local.", "name": "*zigate*" }, { "type": "_zigstar_gw._tcp.local.", "name": "*zigstar*" }, { "type": "_uzg-01._tcp.local.", "name": "uzg-01*" }, { "type": "_slzb-06._tcp.local.", "name": "slzb-06*" } ], "is_built_in": true }, "data": { "ieee": "**REDACTED**", "nwk": 45063, "manufacturer": "Aqara", "model": "lumi.switch.acn047", "name": "Aqara lumi.switch.acn047", "quirk_applied": false, "quirk_class": "zigpy.device.Device", "quirk_id": null, "manufacturer_code": 4447, "power_source": "Mains", "lqi": 255, "rssi": -30, "last_seen": "2024-01-24T10:53:26", "available": true, "device_type": "Router", "signature": { "node_descriptor": "NodeDescriptor(logical_type=, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=, mac_capability_flags=, manufacturer_code=4447, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=False, *is_full_function_device=True, *is_mains_powered=True, *is_receiver_on_when_idle=True, *is_router=True, *is_security_capable=False)", "endpoints": { "21": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x000c" ], "output_clusters": [] }, "2": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x0003", "0x0004", "0x0005", "0x0006", "0x0012", "0xfcc0" ], "output_clusters": [] }, "1": { "profile_id": "0x0104", "device_type": "0x0000", "input_clusters": [ "0x0000", "0x0003", "0x0004", "0x0005", "0x0006", "0x0012", "0x0702", "0x0b04", "0xfcc0" ], "output_clusters": [ "0x000a", "0x0019" ] } }, "manufacturer": "Aqara", "model": "lumi.switch.acn047" }, "active_coordinator": false, "entities": [ { "entity_id": "button.aqara_lumi_switch_acn047_azonositas", "name": "Aqara lumi.switch.acn047" }, { "entity_id": "sensor.aqara_lumi_switch_acn047_teljesitmeny", "name": "Aqara lumi.switch.acn047" }, { "entity_id": "sensor.aqara_lumi_switch_acn047_osszegzett_mennyiseg", "name": "Aqara lumi.switch.acn047" }, { "entity_id": "switch.aqara_lumi_switch_acn047_kapcsolo", "name": "Aqara lumi.switch.acn047" }, { "entity_id": "switch.aqara_lumi_switch_acn047_kapcsolo_2", "name": "Aqara lumi.switch.acn047" } ], "neighbors": [], "routes": [ { "dest_nwk": "0x0000", "route_status": "Active", "memory_constrained": false, "many_to_one": true, "route_record_required": false, "next_hop": "0x0000" }, { "dest_nwk": "0x5C92", "route_status": "Active", "memory_constrained": false, "many_to_one": false, "route_record_required": false, "next_hop": "0x5B82" } ], "endpoint_names": [ { "name": "ON_OFF_SWITCH" }, { "name": "ON_OFF_SWITCH" }, { "name": "ON_OFF_SWITCH" } ], "user_given_name": null, "device_reg_id": "d52192511554a4b4084878791c9752e0", "area_id": null, "cluster_details": { "21": { "device_type": { "name": "ON_OFF_SWITCH", "id": 0 }, "profile_id": 260, "in_clusters": { "0x000c": { "endpoint_attribute": "analog_input", "attributes": { "0x0055": { "attribute_name": "present_value", "value": 0.0 } }, "unsupported_attributes": {} } }, "out_clusters": {} }, "2": { "device_type": { "name": "ON_OFF_SWITCH", "id": 0 }, "profile_id": 260, "in_clusters": { "0x0005": { "endpoint_attribute": "scenes", "attributes": {}, "unsupported_attributes": {} }, "0x0004": { "endpoint_attribute": "groups", "attributes": {}, "unsupported_attributes": {} }, "0x0003": { "endpoint_attribute": "identify", "attributes": {}, "unsupported_attributes": {} }, "0x0012": { "endpoint_attribute": "multistate_input", "attributes": {}, "unsupported_attributes": {} }, "0x0006": { "endpoint_attribute": "on_off", "attributes": { "0x0000": { "attribute_name": "on_off", "value": 0 } }, "unsupported_attributes": { "0x4003": { "attribute_name": "start_up_on_off" } } }, "0xfcc0": { "endpoint_attribute": "manufacturer_specific", "attributes": {}, "unsupported_attributes": {} } }, "out_clusters": {} }, "1": { "device_type": { "name": "ON_OFF_SWITCH", "id": 0 }, "profile_id": 260, "in_clusters": { "0x0b04": { "endpoint_attribute": "electrical_measurement", "attributes": { "0x0605": { "attribute_name": "ac_power_divisor", "value": 10 }, "0x0604": { "attribute_name": "ac_power_multiplier", "value": 1 }, "0x050b": { "attribute_name": "active_power", "value": 0 }, "0x0000": { "attribute_name": "measurement_type", "value": 1 } }, "unsupported_attributes": { "0x0300": { "attribute_name": "ac_frequency" }, "0x0601": { "attribute_name": "ac_voltage_divisor" }, "0x0302": { "attribute_name": "ac_frequency_max" }, "0x0603": { "attribute_name": "ac_current_divisor" }, "0x0602": { "attribute_name": "ac_current_multiplier" }, "0x0505": { "attribute_name": "rms_voltage" }, "0x0600": { "attribute_name": "ac_voltage_multiplier" }, "0x0507": { "attribute_name": "rms_voltage_max" }, "0x0508": { "attribute_name": "rms_current" }, "0x0401": { "attribute_name": "ac_frequency_divisor" }, "0x050a": { "attribute_name": "rms_current_max" }, "0x0403": { "attribute_name": "power_divisor" }, "0x050d": { "attribute_name": "active_power_max" }, "0x050f": { "attribute_name": "apparent_power" }, "0x0510": { "attribute_name": "power_factor" }, "0x0400": { "attribute_name": "ac_frequency_multiplier" }, "0x0402": { "attribute_name": "power_multiplier" } } }, "0x0702": { "endpoint_attribute": "smartenergy_metering", "attributes": { "0x0000": { "attribute_name": "current_summ_delivered", "value": 0 }, "0x0302": { "attribute_name": "divisor", "value": 1000 }, "0x0306": { "attribute_name": "metering_device_type", "value": 0 }, "0x0301": { "attribute_name": "multiplier", "value": 1 }, "0x0303": { "attribute_name": "summation_formatting", "value": 159 }, "0x0300": { "attribute_name": "unit_of_measure", "value": 0 } }, "unsupported_attributes": { "0x0400": { "attribute_name": "instantaneous_demand" }, "0x0100": { "attribute_name": "current_tier1_summ_delivered" }, "0x0102": { "attribute_name": "current_tier2_summ_delivered" }, "0x0104": { "attribute_name": "current_tier3_summ_delivered" }, "0x0106": { "attribute_name": "current_tier4_summ_delivered" }, "0x0108": { "attribute_name": "current_tier5_summ_delivered" }, "0x010a": { "attribute_name": "current_tier6_summ_delivered" }, "0x0200": { "attribute_name": "status" }, "0x0304": { "attribute_name": "demand_formatting" } } }, "0x0005": { "endpoint_attribute": "scenes", "attributes": {}, "unsupported_attributes": {} }, "0x0004": { "endpoint_attribute": "groups", "attributes": {}, "unsupported_attributes": {} }, "0x0003": { "endpoint_attribute": "identify", "attributes": {}, "unsupported_attributes": {} }, "0x0012": { "endpoint_attribute": "multistate_input", "attributes": {}, "unsupported_attributes": {} }, "0x0000": { "endpoint_attribute": "basic", "attributes": { "0x0001": { "attribute_name": "app_version", "value": 27 }, "0x0004": { "attribute_name": "manufacturer", "value": "Aqara" }, "0x0005": { "attribute_name": "model", "value": "lumi.switch.acn047" } }, "unsupported_attributes": {} }, "0x0006": { "endpoint_attribute": "on_off", "attributes": { "0x0000": { "attribute_name": "on_off", "value": 0 } }, "unsupported_attributes": { "0x4003": { "attribute_name": "start_up_on_off" } } }, "0xfcc0": { "endpoint_attribute": "manufacturer_specific", "attributes": {}, "unsupported_attributes": {} } }, "out_clusters": { "0x0019": { "endpoint_attribute": "ota", "attributes": {}, "unsupported_attributes": {} }, "0x000a": { "endpoint_attribute": "time", "attributes": {}, "unsupported_attributes": {} } } } } } } ```

Logs

Logs ```python [0x5B82](TRADFRIbulbE14WWclear250lm): Device seen - marking the device available and resetting counter [0x5B82](TRADFRIbulbE14WWclear250lm): Update device availability - device available: True - new availability: True - changed: False Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 34, 902774, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=19, data=Serialized[b'\x02\x07\xb0\x04\x94\x9b\x00\x10D\xefT\x8e'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-37) New device 0xb007 (54:ef:44:10:00:9b:94:04) joined the network [0xb007] Scheduling initialization Received frame on uninitialized device from ep 0 to ep 0, cluster 19: Serialized[b'\x02\x07\xb0\x04\x94\x9b\x00\x10D\xefT\x8e'] [0xb007:zdo] ZDO request ZDOCmd.Device_annce: [0xB007, 54:ef:44:10:00:9b:94:04, 142] Tries remaining: 5 [0xb007] Requesting 'Node Descriptor' [0xb007] Extending timeout for 0xc2 request Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 34, 964096, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32770, data=Serialized[b'\xc2\x00\x07\xb0\x01@\x8e_\x11RR\x00\x00,R\x00\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-37) Received frame on uninitialized device from ep 0 to ep 0, cluster 32770: Serialized[b'\xc2\x00\x07\xb0\x01@\x8e_\x11RR\x00\x00,R\x00\x00'] [0xb007] Got Node Descriptor: NodeDescriptor(logical_type=, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=, mac_capability_flags=, manufacturer_code=4447, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=False, *is_full_function_device=True, *is_mains_powered=True, *is_receiver_on_when_idle=True, *is_router=True, *is_security_capable=False) [0xb007] Discovering endpoints Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 4190, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32773, data=Serialized[b'\xc4\x00\x07\xb0\x03\x15\x02\x01'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-37) Received frame on uninitialized device from ep 0 to ep 0, cluster 32773: Serialized[b'\xc4\x00\x07\xb0\x03\x15\x02\x01'] [0xb007] Discovered endpoints: [21, 2, 1] [0xb007] Initializing endpoints [>, >, >] [0xb007:21] Discovering endpoint information Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 44788, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32772, data=Serialized[b'\xc6\x00\x07\xb0\n\x15\x04\x01\x00\x00\x01\x01\x0c\x00\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-34) Received frame on uninitialized device from ep 0 to ep 0, cluster 32772: Serialized[b'\xc6\x00\x07\xb0\n\x15\x04\x01\x00\x00\x01\x01\x0c\x00\x00'] [0xb007:21] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=21, profile=260, device_type=0, device_version=1, input_clusters=[12], output_clusters=[]) [0xb007:2] Discovering endpoint information Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 92802, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32772, data=Serialized[b'\xc8\x00\x07\xb0\x14\x02\x04\x01\x00\x00\x01\x06\x05\x00\x04\x00\x03\x00\x12\x00\x06\x00\xc0\xfc\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) Received frame on uninitialized device from ep 0 to ep 0, cluster 32772: Serialized[b'\xc8\x00\x07\xb0\x14\x02\x04\x01\x00\x00\x01\x06\x05\x00\x04\x00\x03\x00\x12\x00\x06\x00\xc0\xfc\x00'] [0xb007:2] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=2, profile=260, device_type=0, device_version=1, input_clusters=[5, 4, 3, 18, 6, 64704], output_clusters=[]) [0xb007:1] Discovering endpoint information Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 138493, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32772, data=Serialized[b'\xca\x00\x07\xb0\x1e\x01\x04\x01\x00\x00\x01\t\x04\x0b\x02\x07\x05\x00\x04\x00\x03\x00\x12\x00\x00\x00\x06\x00\xc0\xfc\x02\x19\x00\n\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) Received frame on uninitialized device from ep 0 to ep 0, cluster 32772: Serialized[b'\xca\x00\x07\xb0\x1e\x01\x04\x01\x00\x00\x01\t\x04\x0b\x02\x07\x05\x00\x04\x00\x03\x00\x12\x00\x00\x00\x06\x00\xc0\xfc\x02\x19\x00\n\x00'] [0xb007:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=0, device_version=1, input_clusters=[2820, 1794, 5, 4, 3, 18, 0, 6, 64704], output_clusters=[25, 10]) [0xb007] Read model None and manufacturer None from > [0xb007] Read model None and manufacturer None from > [0xB007:1:0x0000] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=204, command_id=, *direction=) [0xB007:1:0x0000] Sending request: Read_Attributes(attribute_ids=[4, 5]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 191879, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=0, data=Serialized[b'\x18\xcc\x01\x04\x00\x00B\x05Aqara\x05\x00\x00B\x12lumi.switch.acn047'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) [0xB007:1:0x0000] Received ZCL frame: b'\x18\xcc\x01\x04\x00\x00B\x05Aqara\x05\x00\x00B\x12lumi.switch.acn047' [0xB007:1:0x0000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=204, command_id=1, *direction=) [0xB007:1:0x0000] Decoded ZCL frame: Basic:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0004, status=, value=TypeValue(type=CharacterString, value='Aqara')), ReadAttributeRecord(attrid=0x0005, status=, value=TypeValue(type=CharacterString, value='lumi.switch.acn047'))]) [0xb007] Read model 'lumi.switch.acn047' and manufacturer 'Aqara' from > [0xb007] Discovered basic device information for Device is initialized Checking quirks for Aqara lumi.switch.acn047 (54:ef:44:10:00:9b:94:04) Considering Fail because endpoint list mismatch: {1, 2, 242} {1, 2, 21} Considering Fail because endpoint list mismatch: {1, 2, 41, 42, 242, 51, 21, 31} {1, 2, 21} Considering Fail because endpoint list mismatch: {232, 230} {1, 2, 21} Considering Fail because endpoint list mismatch: {232, 230} {1, 2, 21} Considering Fail because endpoint list mismatch: {1} {1, 2, 21} Considering Fail because endpoint list mismatch: {1} {1, 2, 21} Considering Fail because endpoint list mismatch: {1} {1, 2, 21} Considering Fail because endpoint list mismatch: {1} {1, 2, 21} Considering Fail because endpoint list mismatch: {11, 13} {1, 2, 21} Creating cluster handler for cluster id: 12 class: Discovering entities for endpoint: 54:ef:44:10:00:9b:94:04-21 Creating cluster handler for cluster id: 5 class: Creating cluster handler for cluster id: 4 class: Creating cluster handler for cluster id: 3 class: Creating cluster handler for cluster id: 18 class: Creating cluster handler for cluster id: 6 class: Creating cluster handler for cluster id: 64704 class: Discovering entities for endpoint: 54:ef:44:10:00:9b:94:04-2 'button' component -> 'ZHAIdentifyButton' using ['identify'] 'select' component -> 'ZHAStartupOnOffSelectEntity' using ['on_off'] Creating cluster handler for cluster id: 2820 class: Creating cluster handler for cluster id: 1794 class: Creating cluster handler for cluster id: 5 class: Creating cluster handler for cluster id: 4 class: Creating cluster handler for cluster id: 3 class: Creating cluster handler for cluster id: 18 class: Creating cluster handler for cluster id: 0 class: Creating cluster handler for cluster id: 6 class: Creating cluster handler for cluster id: 64704 class: Discovering entities for endpoint: 54:ef:44:10:00:9b:94:04-1 'button' component -> 'ZHAIdentifyButton' using ['identify'] 'sensor' component -> 'ElectricalMeasurementApparentPower' using ['electrical_measurement'] 'sensor' component -> 'ElectricalMeasurementRMSCurrent' using ['electrical_measurement'] 'sensor' component -> 'ElectricalMeasurementRMSVoltage' using ['electrical_measurement'] 'sensor' component -> 'ElectricalMeasurementFrequency' using ['electrical_measurement'] 'sensor' component -> 'ElectricalMeasurementPowerFactor' using ['electrical_measurement'] 'sensor' component -> 'RSSISensor' using ['basic'] 'sensor' component -> 'LQISensor' using ['basic'] 'sensor' component -> 'PolledElectricalMeasurement' using ['electrical_measurement'] 'sensor' component -> 'SmartEnergyMetering' using ['smartenergy_metering'] 'sensor' component -> 'SmartEnergySummation' using ['smartenergy_metering'] 'select' component -> 'ZHAStartupOnOffSelectEntity' using ['on_off'] device - 0xB007:54:ef:44:10:00:9b:94:04 entering async_device_initialized - is_new_join: True device - 0xB007:54:ef:44:10:00:9b:94:04 has joined the ZHA zigbee network [0xB007](lumi.switch.acn047): started configuration [0xB007:ZDO](lumi.switch.acn047): 'async_configure' stage succeeded Error handling '_save_attribute' event with (54:ef:44:10:00:9b:94:04, 1, 0, 4, 'Aqara', datetime.datetime(2024, 1, 24, 9, 50, 35, 204726, tzinfo=datetime.timezone.utc)) params: FOREIGN KEY constraint failed [0xB007:2:0x0003]: Configuring cluster attribute reporting [0xB007:2:0x0003]: finished cluster handler configuration [0xB007:2:0x0006]: Performing cluster binding [0xB007:2:0xfcc0]: Performing cluster binding [0xB007:1:0x0000]: Configuring cluster attribute reporting [0xB007:1:0x0000]: finished cluster handler configuration [0xB007:1:0x0003]: Configuring cluster attribute reporting [0xB007:1:0x0003]: finished cluster handler configuration [0xB007:1:0x0b04]: Performing cluster binding [0xB007:1:0x0702]: Performing cluster binding [0xB007:1:0xfcc0]: Performing cluster binding [0xB007:1:0x0006]: Performing cluster binding [0xB007:1:0x0019]: finished cluster handler configuration Error handling '_save_attribute' event with (54:ef:44:10:00:9b:94:04, 1, 0, 5, 'lumi.switch.acn047', datetime.datetime(2024, 1, 24, 9, 50, 35, 204852, tzinfo=datetime.timezone.utc)) params: FOREIGN KEY constraint failed Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 485287, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32801, data=Serialized[b'\xce\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-33) [0xB007:2:0x0006]: bound 'on_off' cluster: Status.SUCCESS [0xB007:2:0x0006]: Configuring cluster attribute reporting [0xB007:2:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=218, command_id=, *direction=) [0xB007:2:0x0006] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0000, datatype=16, min_interval=0, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 520220, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32801, data=Serialized[b'\xd0\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:2:0xfcc0]: bound 'manufacturer_specific' cluster: Status.SUCCESS [0xB007:2:0xfcc0]: Configuring cluster attribute reporting [0xB007:2:0xfcc0]: finished cluster handler configuration Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 560053, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=0, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=0, source_route=None, extended_timeout=False, tsn=None, profile_id=0, cluster_id=32801, data=Serialized[b'\xd2\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0b04]: bound 'electrical_measurement' cluster: Status.SUCCESS [0xB007:1:0x0b04]: Configuring cluster attribute reporting [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=220, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x050B, datatype=41, min_interval=5, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x050D, datatype=41, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x050F, datatype=33, min_interval=5, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 594503, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\xda\x07\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) [0xB007:2:0x0006] Received ZCL frame: b'\x18\xda\x07\x00' [0xB007:2:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=218, command_id=7, *direction=) [0xB007:2:0x0006] Decoded ZCL frame: OnOff:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=)]) [0xB007:2:0x0006]: Successfully configured reporting for '{'on_off': (0, 900, 1)}' on 'on_off' cluster: [ConfigureReportingResponseRecord(status=)] [0xB007:2:0x0006]: finished cluster handler configuration [0xB007:2:0x0003]: 'async_configure' stage succeeded [0xB007:2:0x0006]: 'async_configure' stage succeeded [0xB007:2:0xfcc0]: 'async_configure' stage succeeded Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 678780, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xdc\x07\x8d\x00\x0b\x05\x86\x00\r\x05\x86\x00\x0f\x05'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-34) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xdc\x07\x8d\x00\x0b\x05\x86\x00\r\x05\x86\x00\x0f\x05' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=220, command_id=7, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=1291), ConfigureReportingResponseRecord(status=, direction=, attrid=1293), ConfigureReportingResponseRecord(status=, direction=, attrid=1295)]) [0xB007:1:0x0b04]: Successfully configured reporting for 'set()' on 'electrical_measurement' cluster [0xB007:1:0x0b04]: Failed to configure reporting for '['active_power', 'active_power_max', 'apparent_power']' on 'electrical_measurement' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=1291), ConfigureReportingResponseRecord(status=, direction=, attrid=1293), ConfigureReportingResponseRecord(status=, direction=, attrid=1295)] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=222, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0508, datatype=33, min_interval=5, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x050A, datatype=33, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0505, datatype=33, min_interval=5, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 786409, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xde\x07\x86\x00\x08\x05\x86\x00\n\x05\x86\x00\x05\x05'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-34) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xde\x07\x86\x00\x08\x05\x86\x00\n\x05\x86\x00\x05\x05' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=222, command_id=7, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=1288), ConfigureReportingResponseRecord(status=, direction=, attrid=1290), ConfigureReportingResponseRecord(status=, direction=, attrid=1285)]) [0xB007:1:0x0b04]: Successfully configured reporting for 'set()' on 'electrical_measurement' cluster [0xB007:1:0x0b04]: Failed to configure reporting for '['rms_current', 'rms_current_max', 'rms_voltage']' on 'electrical_measurement' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=1288), ConfigureReportingResponseRecord(status=, direction=, attrid=1290), ConfigureReportingResponseRecord(status=, direction=, attrid=1285)] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=224, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0507, datatype=33, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0300, datatype=33, min_interval=5, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0302, datatype=33, min_interval=30, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 35, 856851, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xe0\x07\x86\x00\x07\x05\x86\x00\x00\x03\x86\x00\x02\x03'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xe0\x07\x86\x00\x07\x05\x86\x00\x00\x03\x86\x00\x02\x03' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=224, command_id=7, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=1287), ConfigureReportingResponseRecord(status=, direction=, attrid=768), ConfigureReportingResponseRecord(status=, direction=, attrid=770)]) [0xB007:1:0x0b04]: Successfully configured reporting for 'set()' on 'electrical_measurement' cluster [0xB007:1:0x0b04]: Failed to configure reporting for '['rms_voltage_max', 'ac_frequency', 'ac_frequency_max']' on 'electrical_measurement' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=1287), ConfigureReportingResponseRecord(status=, direction=, attrid=768), ConfigureReportingResponseRecord(status=, direction=, attrid=770)] [0xB007:1:0x0b04]: finished cluster handler configuration [0x94FF](TRADFRI bulb E27 CWS 806lm): Device seen - marking the device available and resetting counter [0x94FF](TRADFRI bulb E27 CWS 806lm): Update device availability - device available: True - new availability: True - changed: False Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 39, 774062, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=64704, data=Serialized[b'\x1c_\x11\x05\n\xf7\x00A?\x03(\x1b\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x9693\xa3\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0xfcc0] Received ZCL frame: b'\x1c_\x11\x05\n\xf7\x00A?\x03(\x1b\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x9693\xa3\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00' [0xB007:1:0xfcc0] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=True, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4447, tsn=5, command_id=10, *direction=) [0xB007:1:0xfcc0] Decoded ZCL frame: ManufacturerSpecificCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x00F7, value=TypeValue(type=LVBytes, value=b'\x03(\x1b\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x9693\xa3\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'))]) [0xB007:1:0xfcc0] Received command 0x0A (TSN 5): Report_Attributes(attribute_reports=[Attribute(attrid=0x00F7, value=TypeValue(type=LVBytes, value=b'\x03(\x1b\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x9693\xa3\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'))]) [0xB007:1:0xfcc0] Attribute report received: 0x00F7=b'\x03(\x1b\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x9693\xa3\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00' Tries remaining: 3 [0xE0A7:1:0xef00] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=226, command_id=0, *direction=) [0xE0A7:1:0xef00] Sending request: set_data(param=Command(status=0, tsn=226, command_id=617, function=0, data=9)) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 513828, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xE0A7), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=61184, data=Serialized[b'\x08\xe2\x0b\x00\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-72) [0xE0A7:1:0xef00] Received ZCL frame: b'\x08\xe2\x0b\x00\x00' [0xE0A7:1:0xef00] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=226, command_id=11, *direction=) [0xE0A7:1:0xef00] Decoded ZCL frame: BecaManufCluster:Default_Response(command_id=0, status=) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 563827, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=10, data=Serialized[b'\x10\x06\x00\x00\x00\x02\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x000a] Received ZCL frame: b'\x10\x06\x00\x00\x00\x02\x00' [0xB007:1:0x000a] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=6, command_id=0, *direction=) [0xB007:1:0x000a] Decoded ZCL frame: Time:Read_Attributes(attribute_ids=[0, 2]) [0xB007:1:0x000a] Received command 0x00 (TSN 6): Read_Attributes(attribute_ids=[0, 2]) [0xB007:1:0x000a] Sending reply header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=6, command_id=, *direction=) [0xB007:1:0x000a] Sending reply: Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=UTCTime, value=759405040)), ReadAttributeRecord(attrid=0x0002, status=, value=TypeValue(type=int32s, value=3600))]) [0xB007:1:0x0702]: Failed to bind 'smartenergy_metering' cluster: [0xB007:1:0x0702]: Configuring cluster attribute reporting [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=229, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0400, datatype=42, min_interval=5, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0000, datatype=37, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0100, datatype=37, min_interval=30, max_interval=900, reportable_change=1)]) [0xB007:1:0xfcc0]: Failed to bind 'manufacturer_specific' cluster: [0xB007:1:0xfcc0]: Configuring cluster attribute reporting [0xB007:1:0xfcc0]: finished cluster handler configuration [0xB007:1:0x0006]: Failed to bind 'on_off' cluster: [0xB007:1:0x0006]: Configuring cluster attribute reporting [0xB007:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=231, command_id=, *direction=) [0xB007:1:0x0006] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0000, datatype=16, min_interval=0, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 775889, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xE0A7), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=61184, data=Serialized[b'\td\x01\x00\xe2i\x02\x00\x04\x00\x00\x00\t'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-72) [0xE0A7:1:0xef00] Received ZCL frame: b'\td\x01\x00\xe2i\x02\x00\x04\x00\x00\x00\t' [0xE0A7:1:0xef00] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=100, command_id=1, *direction=) [0xE0A7:1:0xef00] Decoded ZCL frame: BecaManufCluster:get_data(param=Command(status=0, tsn=226, command_id=617, function=0, data=[4, 0, 0, 0, 9])) [0xE0A7:1:0xef00] Received command 0x01 (TSN 100): get_data(param=Command(status=0, tsn=226, command_id=617, function=0, data=[4, 0, 0, 0, 9])) [0xE0A7:1:0x0201]: Attribute report 'BecaThermostat'[local_temperature_calibration] = 9 [0xE0A7:1:0xef00] Sending reply header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=100, command_id=, *direction=) [0xE0A7:1:0xef00] Sending reply: Default_Response(command_id=1, status=) climate.th_dolgozo_termosztat: Attribute 'local_temperature_calibration' = 9 update Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 821229, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\xe5\x07\x86\x00\x00\x04\x86\x00\x00\x01'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-34) [0xB007:1:0x0702] Received ZCL frame: b'\x18\xe5\x07\x86\x00\x00\x04\x86\x00\x00\x01' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=229, command_id=7, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=1024), ConfigureReportingResponseRecord(status=, direction=, attrid=256)]) [0xB007:1:0x0702]: Successfully configured reporting for '{'current_summ_delivered'}' on 'smartenergy_metering' cluster [0xB007:1:0x0702]: Failed to configure reporting for '['instantaneous_demand', 'current_tier1_summ_delivered']' on 'smartenergy_metering' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=1024), ConfigureReportingResponseRecord(status=, direction=, attrid=256)] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=234, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0102, datatype=37, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0104, datatype=37, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0106, datatype=37, min_interval=30, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 869846, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\xe7\x07\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-33) [0xB007:1:0x0006] Received ZCL frame: b'\x18\xe7\x07\x00' [0xB007:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=231, command_id=7, *direction=) [0xB007:1:0x0006] Decoded ZCL frame: OnOff:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=)]) [0xB007:1:0x0006]: Successfully configured reporting for '{'on_off': (0, 900, 1)}' on 'on_off' cluster: [ConfigureReportingResponseRecord(status=)] [0xB007:1:0x0006]: finished cluster handler configuration Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 40, 918044, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\xea\x07\x86\x00\x02\x01\x86\x00\x04\x01\x86\x00\x06\x01'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0702] Received ZCL frame: b'\x18\xea\x07\x86\x00\x02\x01\x86\x00\x04\x01\x86\x00\x06\x01' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=234, command_id=7, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=258), ConfigureReportingResponseRecord(status=, direction=, attrid=260), ConfigureReportingResponseRecord(status=, direction=, attrid=262)]) [0xB007:1:0x0702]: Successfully configured reporting for 'set()' on 'smartenergy_metering' cluster [0xB007:1:0x0702]: Failed to configure reporting for '['current_tier2_summ_delivered', 'current_tier3_summ_delivered', 'current_tier4_summ_delivered']' on 'smartenergy_metering' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=258), ConfigureReportingResponseRecord(status=, direction=, attrid=260), ConfigureReportingResponseRecord(status=, direction=, attrid=262)] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=236, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Configure_Reporting(config_records=[AttributeReportingConfig(direction=0, attrid=0x0108, datatype=37, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x010A, datatype=37, min_interval=30, max_interval=900, reportable_change=1), AttributeReportingConfig(direction=0, attrid=0x0200, datatype=24, min_interval=1, max_interval=900, reportable_change=1)]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 7542, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\xec\x07\x86\x00\x08\x01\x86\x00\n\x01\x86\x00\x00\x02'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) [0xB007:1:0x0702] Received ZCL frame: b'\x18\xec\x07\x86\x00\x08\x01\x86\x00\n\x01\x86\x00\x00\x02' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=236, command_id=7, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Configure_Reporting_rsp(status_records=[ConfigureReportingResponseRecord(status=, direction=, attrid=264), ConfigureReportingResponseRecord(status=, direction=, attrid=266), ConfigureReportingResponseRecord(status=, direction=, attrid=512)]) [0xB007:1:0x0702]: Successfully configured reporting for 'set()' on 'smartenergy_metering' cluster [0xB007:1:0x0702]: Failed to configure reporting for '['current_tier5_summ_delivered', 'current_tier6_summ_delivered', 'status']' on 'smartenergy_metering' cluster: [ConfigureReportingResponseRecord(status=, direction=, attrid=264), ConfigureReportingResponseRecord(status=, direction=, attrid=266), ConfigureReportingResponseRecord(status=, direction=, attrid=512)] [0xB007:1:0x0702]: finished cluster handler configuration [0xB007:1:0x0000]: 'async_configure' stage succeeded [0xB007:1:0x0003]: 'async_configure' stage succeeded [0xB007:1:0x0b04]: 'async_configure' stage succeeded [0xB007:1:0x0702]: 'async_configure' stage succeeded [0xB007:1:0xfcc0]: 'async_configure' stage succeeded [0xB007:1:0x0006]: 'async_configure' stage succeeded [0xB007:1:0x0019]: 'async_configure' stage succeeded [0xB007](lumi.switch.acn047): completed configuration Tries remaining: 3 [0xB007:2:0x0003] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=True, *is_general=False), tsn=238, command_id=64, *direction=) [0xB007:2:0x0003] Sending request: trigger_effect(effect_id=, effect_variant=) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 95409, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=3, data=Serialized[b'\x08\xee\x0b@\x81'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-30) [0xB007:2:0x0003] Received ZCL frame: b'\x08\xee\x0b@\x81' [0xB007:2:0x0003] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=238, command_id=11, *direction=) [0xB007:2:0x0003] Decoded ZCL frame: Identify:Default_Response(command_id=64, status=) [0xB007](lumi.switch.acn047): started initialization [0xB007:ZDO](lumi.switch.acn047): 'async_initialize' stage succeeded [0xB007:2:0x0003]: initializing cluster handler: from_cache: False [0xB007:2:0x0003]: finished cluster handler initialization [0xB007:2:0x0006]: initializing cluster handler: from_cache: False [0xB007:2:0x0006]: initializing cached cluster handler attributes: ['start_up_on_off'] [0xB007:2:0x0006]: Reading attributes in chunks: ['start_up_on_off'] [0xB007:2:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=240, command_id=, *direction=) [0xB007:2:0x0006] Sending request: Read_Attributes(attribute_ids=[16387]) [0xB007:2:0xfcc0]: initializing cluster handler: from_cache: False [0xB007:2:0xfcc0]: Performing cluster handler specific initialization: [] [0xB007:2:0xfcc0]: finished cluster handler initialization [0xB007:1:0x0000]: initializing cluster handler: from_cache: False [0xB007:1:0x0000]: finished cluster handler initialization [0xB007:1:0x0003]: initializing cluster handler: from_cache: False [0xB007:1:0x0003]: finished cluster handler initialization [0xB007:1:0x0b04]: initializing cluster handler: from_cache: False [0xB007:1:0x0b04]: initializing cached cluster handler attributes: ['ac_current_divisor', 'ac_current_multiplier', 'ac_power_divisor', 'ac_power_multiplier', 'ac_voltage_divisor', 'ac_voltage_multiplier', 'ac_frequency_divisor', 'ac_frequency_multiplier', 'measurement_type', 'power_divisor', 'power_multiplier', 'power_factor'] [0xB007:1:0x0b04]: Reading attributes in chunks: ['ac_current_divisor', 'ac_current_multiplier', 'ac_power_divisor', 'ac_power_multiplier', 'ac_voltage_divisor'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=242, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1539, 1538, 1541, 1540, 1537]) [0xB007:1:0x0702]: initializing cluster handler: from_cache: False [0xB007:1:0x0702]: initializing cached cluster handler attributes: ['demand_formatting', 'divisor', 'metering_device_type', 'multiplier', 'summation_formatting', 'unit_of_measure'] [0xB007:1:0x0702]: Reading attributes in chunks: ['demand_formatting', 'divisor', 'metering_device_type', 'multiplier', 'summation_formatting'] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=244, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Read_Attributes(attribute_ids=[772, 770, 774, 769, 771]) [0xB007:1:0xfcc0]: initializing cluster handler: from_cache: False [0xB007:1:0xfcc0]: Performing cluster handler specific initialization: [] [0xB007:1:0xfcc0]: finished cluster handler initialization [0xB007:1:0x0006]: initializing cluster handler: from_cache: False [0xB007:1:0x0006]: initializing cached cluster handler attributes: ['start_up_on_off'] [0xB007:1:0x0006]: Reading attributes in chunks: ['start_up_on_off'] [0xB007:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=246, command_id=, *direction=) [0xB007:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387]) [0xB007:1:0x0019]: initializing cluster handler: from_cache: False [0xB007:1:0x0019]: finished cluster handler initialization Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 245491, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\xf0\x01\x03@\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-29) [0xB007:2:0x0006] Received ZCL frame: b'\x18\xf0\x01\x03@\x86' [0xB007:2:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=240, command_id=1, *direction=) [0xB007:2:0x0006] Decoded ZCL frame: OnOff:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x4003, status=)]) [0xB007:2:0x0006]: initializing uncached cluster handler attributes: ['on_off'] - from cache[False] [0xB007:2:0x0006]: Reading attributes in chunks: ['on_off'] [0xB007:2:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=248, command_id=, *direction=) [0xB007:2:0x0006] Sending request: Read_Attributes(attribute_ids=[0]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 285694, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xf2\x01\x03\x06\x86\x02\x06\x86\x05\x06\x00!\n\x00\x04\x06\x00!\x01\x00\x01\x06\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-30) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xf2\x01\x03\x06\x86\x02\x06\x86\x05\x06\x00!\n\x00\x04\x06\x00!\x01\x00\x01\x06\x86' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=242, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0603, status=), ReadAttributeRecord(attrid=0x0602, status=), ReadAttributeRecord(attrid=0x0605, status=, value=TypeValue(type=uint16_t, value=10)), ReadAttributeRecord(attrid=0x0604, status=, value=TypeValue(type=uint16_t, value=1)), ReadAttributeRecord(attrid=0x0601, status=)]) [0xB007:1:0x0b04]: Reading attributes in chunks: ['ac_voltage_multiplier', 'ac_frequency_divisor', 'ac_frequency_multiplier', 'measurement_type', 'power_divisor'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=250, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1536, 1025, 1024, 0, 1027]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 759107, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\xf4\x01\x04\x03\x86\x02\x03\x00"\xe8\x03\x00\x06\x03\x00\x18\x00\x01\x03\x00"\x01\x00\x00\x03\x03\x00\x18\x9f'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) [0xB007:1:0x0702] Received ZCL frame: b'\x18\xf4\x01\x04\x03\x86\x02\x03\x00"\xe8\x03\x00\x06\x03\x00\x18\x00\x01\x03\x00"\x01\x00\x00\x03\x03\x00\x18\x9f' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=244, command_id=1, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0304, status=), ReadAttributeRecord(attrid=0x0302, status=, value=TypeValue(type=uint24_t, value=1000)), ReadAttributeRecord(attrid=0x0306, status=, value=TypeValue(type=bitmap8, value=)), ReadAttributeRecord(attrid=0x0301, status=, value=TypeValue(type=uint24_t, value=1)), ReadAttributeRecord(attrid=0x0303, status=, value=TypeValue(type=bitmap8, value=))]) [0xB007:1:0x0702]: Reading attributes in chunks: ['unit_of_measure'] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=252, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Read_Attributes(attribute_ids=[768]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 806539, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\xf8\x01\x00\x00\x00\x10\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-29) [0xB007:2:0x0006] Received ZCL frame: b'\x18\xf8\x01\x00\x00\x00\x10\x00' [0xB007:2:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=248, command_id=1, *direction=) [0xB007:2:0x0006] Decoded ZCL frame: OnOff:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=Bool, value=))]) [0xB007:2:0x0006]: finished cluster handler initialization [0xB007:2:0x0003]: 'async_initialize' stage succeeded [0xB007:2:0x0006]: 'async_initialize' stage succeeded [0xB007:2:0xfcc0]: 'async_initialize' stage succeeded Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 860626, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=0, data=Serialized[b'\x18\x0c\n\x01\x00 \x1b'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:1:0x0000] Received ZCL frame: b'\x18\x0c\n\x01\x00 \x1b' [0xB007:1:0x0000] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=12, command_id=10, *direction=) [0xB007:1:0x0000] Decoded ZCL frame: Basic:Report_Attributes(attribute_reports=[Attribute(attrid=0x0001, value=TypeValue(type=uint8_t, value=27))]) [0xB007:1:0x0000] Received command 0x0A (TSN 12): Report_Attributes(attribute_reports=[Attribute(attrid=0x0001, value=TypeValue(type=uint8_t, value=27))]) [0xB007:1:0x0000] Attribute report received: app_version=27 Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 893424, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xfa\x01\x00\x06\x86\x01\x04\x86\x00\x04\x86\x00\x00\x00\x1b\x01\x00\x00\x00\x03\x04\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-29) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xfa\x01\x00\x06\x86\x01\x04\x86\x00\x04\x86\x00\x00\x00\x1b\x01\x00\x00\x00\x03\x04\x86' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=250, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0600, status=), ReadAttributeRecord(attrid=0x0401, status=), ReadAttributeRecord(attrid=0x0400, status=), ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=bitmap32, value=)), ReadAttributeRecord(attrid=0x0403, status=)]) [0xB007:1:0x0b04]: Reading attributes in chunks: ['power_multiplier', 'power_factor'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=254, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1026, 1296]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 41, 942789, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\xfc\x01\x00\x03\x000\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-30) [0xB007:1:0x0702] Received ZCL frame: b'\x18\xfc\x01\x00\x03\x000\x00' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=252, command_id=1, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0300, status=, value=TypeValue(type=enum8, value=))]) [0xB007:1:0x0702]: initializing uncached cluster handler attributes: ['instantaneous_demand', 'current_summ_delivered', 'current_tier1_summ_delivered', 'current_tier2_summ_delivered', 'current_tier3_summ_delivered', 'current_tier4_summ_delivered', 'current_tier5_summ_delivered', 'current_tier6_summ_delivered', 'status'] - from cache[False] [0xB007:1:0x0702]: Reading attributes in chunks: ['instantaneous_demand', 'current_summ_delivered', 'current_tier1_summ_delivered', 'current_tier2_summ_delivered', 'current_tier3_summ_delivered'] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=0, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Read_Attributes(attribute_ids=[1024, 0, 256, 258, 260]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 66860, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\xfe\x01\x02\x04\x86\x10\x05\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-30) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\xfe\x01\x02\x04\x86\x10\x05\x86' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=254, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0402, status=), ReadAttributeRecord(attrid=0x0510, status=)]) [0xB007:1:0x0b04]: initializing uncached cluster handler attributes: ['active_power', 'active_power_max', 'apparent_power', 'rms_current', 'rms_current_max', 'rms_voltage', 'rms_voltage_max', 'ac_frequency', 'ac_frequency_max'] - from cache[False] [0xB007:1:0x0b04]: Reading attributes in chunks: ['active_power', 'active_power_max', 'apparent_power', 'rms_current', 'rms_current_max'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=2, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291, 1293, 1295, 1288, 1290]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 160574, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\x00\x01\x00\x04\x86\x00\x00\x00%\x00\x00\x00\x00\x00\x00\x00\x01\x86\x02\x01\x86\x04\x01\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0702] Received ZCL frame: b'\x18\x00\x01\x00\x04\x86\x00\x00\x00%\x00\x00\x00\x00\x00\x00\x00\x01\x86\x02\x01\x86\x04\x01\x86' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=0, command_id=1, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0400, status=), ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=uint48_t, value=0)), ReadAttributeRecord(attrid=0x0100, status=), ReadAttributeRecord(attrid=0x0102, status=), ReadAttributeRecord(attrid=0x0104, status=)]) [0xB007:1:0x0702]: Reading attributes in chunks: ['current_tier4_summ_delivered', 'current_tier5_summ_delivered', 'current_tier6_summ_delivered', 'status'] [0xB007:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=4, command_id=, *direction=) [0xB007:1:0x0702] Sending request: Read_Attributes(attribute_ids=[262, 264, 266, 512]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 207010, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\x02\x01\x0b\x05\x00!\x00\x00\r\x05\x86\x0f\x05\x86\x08\x05\x86\n\x05\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\x02\x01\x0b\x05\x00!\x00\x00\r\x05\x86\x0f\x05\x86\x08\x05\x86\n\x05\x86' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=2, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x050B, status=, value=TypeValue(type=uint16_t, value=0)), ReadAttributeRecord(attrid=0x050D, status=), ReadAttributeRecord(attrid=0x050F, status=), ReadAttributeRecord(attrid=0x0508, status=), ReadAttributeRecord(attrid=0x050A, status=)]) [0xB007:1:0x0b04]: Reading attributes in chunks: ['rms_voltage', 'rms_voltage_max', 'ac_frequency', 'ac_frequency_max'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=6, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1285, 1287, 768, 770]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 300391, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=1794, data=Serialized[b'\x18\x04\x01\x06\x01\x86\x08\x01\x86\n\x01\x86\x00\x02\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0702] Received ZCL frame: b'\x18\x04\x01\x06\x01\x86\x08\x01\x86\n\x01\x86\x00\x02\x86' [0xB007:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=4, command_id=1, *direction=) [0xB007:1:0x0702] Decoded ZCL frame: Metering:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0106, status=), ReadAttributeRecord(attrid=0x0108, status=), ReadAttributeRecord(attrid=0x010A, status=), ReadAttributeRecord(attrid=0x0200, status=)]) [0xB007:1:0x0702]: Performing cluster handler specific initialization: ['instantaneous_demand', 'current_summ_delivered', 'current_tier1_summ_delivered', 'current_tier2_summ_delivered', 'current_tier3_summ_delivered', 'current_tier4_summ_delivered', 'current_tier5_summ_delivered', 'current_tier6_summ_delivered', 'status'] [0xB007:1:0x0702]: finished cluster handler initialization Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 324479, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\x06\x01\x05\x05\x86\x07\x05\x86\x00\x03\x86\x02\x03\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\x06\x01\x05\x05\x86\x07\x05\x86\x00\x03\x86\x02\x03\x86' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=6, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0505, status=), ReadAttributeRecord(attrid=0x0507, status=), ReadAttributeRecord(attrid=0x0300, status=), ReadAttributeRecord(attrid=0x0302, status=)]) [0xB007:1:0x0b04]: finished cluster handler initialization Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 42, 773070, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=64704, data=Serialized[b'\x1c_\x11\x0e\n\xf7\x00A?\x03(\x1a\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x969f\x8e\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-32) [0xB007:1:0xfcc0] Received ZCL frame: b'\x1c_\x11\x0e\n\xf7\x00A?\x03(\x1a\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x969f\x8e\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00' [0xB007:1:0xfcc0] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=True, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4447, tsn=14, command_id=10, *direction=) [0xB007:1:0xfcc0] Decoded ZCL frame: ManufacturerSpecificCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x00F7, value=TypeValue(type=LVBytes, value=b'\x03(\x1a\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x969f\x8e\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'))]) [0xB007:1:0xfcc0] Received command 0x0A (TSN 14): Report_Attributes(attribute_reports=[Attribute(attrid=0x00F7, value=TypeValue(type=LVBytes, value=b'\x03(\x1a\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x969f\x8e\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00'))]) [0xB007:1:0xfcc0] Attribute report received: 0x00F7=b'\x03(\x1a\x05!\r\x00\t!\x00\x03\n!\x00\x00\x0c \n\r#\x1b\x00\x00\x00\x11#\x01\x00\x00\x00d\x10\x00e\x10\x00\x959\x00\x00\x00\x00\x969f\x8e\tE\x989\x00\x00\x00\x00\x979\x00\x00\x00\x00\x9a \x00' Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 43, 867807, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\x10\n\x00\x00\x10\x00\xf5\x00#\x00\x07\xb0\x02'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-31) [0xB007:1:0x0006] Received ZCL frame: b'\x18\x10\n\x00\x00\x10\x00\xf5\x00#\x00\x07\xb0\x02' [0xB007:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=16, command_id=10, *direction=) [0xB007:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x00F5, value=TypeValue(type=uint32_t, value=45090560))]) [0xB007:1:0x0006] Received command 0x0A (TSN 16): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x00F5, value=TypeValue(type=uint32_t, value=45090560))]) [0xB007:1:0x0006] Attribute report received: on_off=, 0x00F5=45090560 Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 45, 29471, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\x12\n\x00\x00\x10\x00\xf5\x00#\x00\x07\xb0\x02'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:2:0x0006] Received ZCL frame: b'\x18\x12\n\x00\x00\x10\x00\xf5\x00#\x00\x07\xb0\x02' [0xB007:2:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=18, command_id=10, *direction=) [0xB007:2:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x00F5, value=TypeValue(type=uint32_t, value=45090560))]) [0xB007:2:0x0006] Received command 0x0A (TSN 18): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x00F5, value=TypeValue(type=uint32_t, value=45090560))]) [0xB007:2:0x0006] Attribute report received: on_off=, 0x00F5=45090560 Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 46, 756164, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0x94FF), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=768, data=Serialized[b'\x08\x07\n\x00\x00 \t\x01\x00 \xe7\x03\x00!\x13\x8e\x04\x00!\xf3]'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-76) [0x94FF:1:0x0300] Received ZCL frame: b'\x08\x07\n\x00\x00 \t\x01\x00 \xe7\x03\x00!\x13\x8e\x04\x00!\xf3]' [0x94FF:1:0x0300] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=7, command_id=10, *direction=) [0x94FF:1:0x0300] Decoded ZCL frame: Color:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=9)), Attribute(attrid=0x0001, value=TypeValue(type=uint8_t, value=231)), Attribute(attrid=0x0003, value=TypeValue(type=uint16_t, value=36371)), Attribute(attrid=0x0004, value=TypeValue(type=uint16_t, value=24051))]) [0x94FF:1:0x0300] Received command 0x0A (TSN 7): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint8_t, value=9)), Attribute(attrid=0x0001, value=TypeValue(type=uint8_t, value=231)), Attribute(attrid=0x0003, value=TypeValue(type=uint16_t, value=36371)), Attribute(attrid=0x0004, value=TypeValue(type=uint16_t, value=24051))]) [0x94FF:1:0x0300] Attribute report received: current_hue=9, current_saturation=231, current_x=36371, current_y=24051 [0x94FF:1:0x0300] Sending reply header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=7, command_id=, *direction=) [0x94FF:1:0x0300] Sending reply: Default_Response(command_id=10, status=) [0xB007:1:0x0006]: failed to get attributes '['start_up_on_off']' on 'on_off' cluster: [0xB007:1:0x0006]: async_initialize: retryable request #1 failed: . Retrying in 0.8s [0xE0A7](TS0601): Device seen - marking the device available and resetting counter [0xE0A7](TS0601): Update device availability - device available: True - new availability: True - changed: False [0xB007:1:0x0006]: initializing cluster handler: from_cache: False [0xB007:1:0x0006]: initializing cached cluster handler attributes: ['start_up_on_off'] [0xB007:1:0x0006]: Reading attributes in chunks: ['start_up_on_off'] [0xB007:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=9, command_id=, *direction=) [0xB007:1:0x0006] Sending request: Read_Attributes(attribute_ids=[16387]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 47, 697424, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\t\x01\x03@\x86'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:1:0x0006] Received ZCL frame: b'\x18\t\x01\x03@\x86' [0xB007:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=9, command_id=1, *direction=) [0xB007:1:0x0006] Decoded ZCL frame: OnOff:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x4003, status=)]) [0xB007:1:0x0006]: initializing uncached cluster handler attributes: ['on_off'] - from cache[False] [0xB007:1:0x0006]: Reading attributes in chunks: ['on_off'] [0xB007:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=11, command_id=, *direction=) [0xB007:1:0x0006] Sending request: Read_Attributes(attribute_ids=[0]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 47, 749595, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=6, data=Serialized[b'\x18\x0b\x01\x00\x00\x00\x10\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-29) [0xB007:1:0x0006] Received ZCL frame: b'\x18\x0b\x01\x00\x00\x00\x10\x00' [0xB007:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=11, command_id=1, *direction=) [0xB007:1:0x0006] Decoded ZCL frame: OnOff:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=Bool, value=))]) [0xB007:1:0x0006]: finished cluster handler initialization [0xB007:1:0x0000]: 'async_initialize' stage succeeded [0xB007:1:0x0003]: 'async_initialize' stage succeeded [0xB007:1:0x0b04]: 'async_initialize' stage succeeded [0xB007:1:0x0702]: 'async_initialize' stage succeeded [0xB007:1:0xfcc0]: 'async_initialize' stage succeeded [0xB007:1:0x0006]: 'async_initialize' stage succeeded [0xB007:1:0x0019]: 'async_initialize' stage succeeded [0xB007](lumi.switch.acn047): power source: Mains [0xB007](lumi.switch.acn047): completed initialization start_up_on_off is not supported - skipping ZHAStartupOnOffSelectEntity entity creation start_up_on_off is not supported - skipping ZHAStartupOnOffSelectEntity entity creation Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 48, 269253, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=21, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=12, data=Serialized[b'\x18\x14\nU\x009\x00\x00\x00\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:21:0x000c] Received ZCL frame: b'\x18\x14\nU\x009\x00\x00\x00\x00' [0xB007:21:0x000c] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=20, command_id=10, *direction=) [0xB007:21:0x000c] Decoded ZCL frame: AnalogInput:Report_Attributes(attribute_reports=[Attribute(attrid=0x0055, value=TypeValue(type=Single, value=0.0))]) [0xB007:21:0x000c] Received command 0x0A (TSN 20): Report_Attributes(attribute_reports=[Attribute(attrid=0x0055, value=TypeValue(type=Single, value=0.0))]) [0xB007:21:0x000c] Attribute report received: present_value=0.0 Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 51, 358232, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=64704, data=Serialized[b'\x1c_\x11\x16\n\n\x00 \x01\xd0\x02\x10\x00\x03\x02\x10\x00\x17\x05 \x01\x00\x02 \x01\x89\x02 \x00\xeb\x00!\xc8\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-29) [0xB007:1:0xfcc0] Received ZCL frame: b'\x1c_\x11\x16\n\n\x00 \x01\xd0\x02\x10\x00\x03\x02\x10\x00\x17\x05 \x01\x00\x02 \x01\x89\x02 \x00\xeb\x00!\xc8\x00' [0xB007:1:0xfcc0] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=True, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4447, tsn=22, command_id=10, *direction=) [0xB007:1:0xfcc0] Decoded ZCL frame: ManufacturerSpecificCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x000A, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x02D0, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x0203, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x0517, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x0200, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x0289, value=TypeValue(type=uint8_t, value=0)), Attribute(attrid=0x00EB, value=TypeValue(type=uint16_t, value=200))]) [0xB007:1:0xfcc0] Received command 0x0A (TSN 22): Report_Attributes(attribute_reports=[Attribute(attrid=0x000A, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x02D0, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x0203, value=TypeValue(type=Bool, value=)), Attribute(attrid=0x0517, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x0200, value=TypeValue(type=uint8_t, value=1)), Attribute(attrid=0x0289, value=TypeValue(type=uint8_t, value=0)), Attribute(attrid=0x00EB, value=TypeValue(type=uint16_t, value=200))]) [0xB007:1:0xfcc0] Attribute report received: 0x000A=1, 0x02D0=, 0x0203=, 0x0517=1, 0x0200=1, 0x0289=0, 0x00EB=200 [0x5C92](TS0601): Device seen - marking the device available and resetting counter [0x5C92](TS0601): Update device availability - device available: True - new availability: True - changed: False Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 55, 355860, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=2, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=64704, data=Serialized[b'\x1c_\x11\x18\n\x00\x02 \x01'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:2:0xfcc0] Received ZCL frame: b'\x1c_\x11\x18\n\x00\x02 \x01' [0xB007:2:0xfcc0] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=True, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), manufacturer=4447, tsn=24, command_id=10, *direction=) [0xB007:2:0xfcc0] Decoded ZCL frame: ManufacturerSpecificCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0200, value=TypeValue(type=uint8_t, value=1))]) [0xB007:2:0xfcc0] Received command 0x0A (TSN 24): Report_Attributes(attribute_reports=[Attribute(attrid=0x0200, value=TypeValue(type=uint8_t, value=1))]) [0xB007:2:0xfcc0] Attribute report received: 0x0200=1 [0xB007:1:0x0b04]: async_update [0xB007:1:0x0b04]: Reading attributes in chunks: ['active_power'] [0xB007:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, direction=, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=13, command_id=, *direction=) [0xB007:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291]) Received a packet: ZigbeePacket(timestamp=datetime.datetime(2024, 1, 24, 9, 50, 56, 182232, tzinfo=datetime.timezone.utc), src=AddrModeAddress(addr_mode=, address=0xB007), src_ep=1, dst=AddrModeAddress(addr_mode=, address=0x0000), dst_ep=1, source_route=None, extended_timeout=False, tsn=None, profile_id=260, cluster_id=2820, data=Serialized[b'\x18\r\x01\x0b\x05\x00!\x00\x00'], tx_options=, radius=0, non_member_radius=0, lqi=255, rssi=-28) [0xB007:1:0x0b04] Received ZCL frame: b'\x18\r\x01\x0b\x05\x00!\x00\x00' [0xB007:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, direction=, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=13, command_id=1, *direction=) [0xB007:1:0x0b04] Decoded ZCL frame: ElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x050B, status=, value=TypeValue(type=uint16_t, value=0))]) ```

Additional information

No response

trapacska commented 8 months ago

@dmulcahey can you help me out please? Ready to provide whatever needed. Dev myself also - still was unable to figure out the quirk world

TheJulianJES commented 8 months ago

Please fill-out the issue template. Remove any custom quirks and provide the device signature and/or device diagnostics. Both can be seen/downloaded on the device page.

Also, did you check the clusters menu? (Manage Zigbee device)

trapacska commented 8 months ago

@TheJulianJES @dmulcahey updated description with diagnostics, signature and the logs when I paired the device.

trapacska commented 8 months ago

Updated HA to the latest version and now it seems like that there is a new input type "dropdown", which then showing up fine.

There are two things missing so far: interlock and the events to be received when S1-COM or S2-COM shorted in detached mode.

trapacska commented 8 months ago

Finally were able to capture the two events for both switches. Found the issue with the implementation. Will open a PR tomorrow. image image

Until then I was unable to find out why these two lines are not showing up on the UI: 0x02D0: ("interlock", t.Bool, True) 0x00EB: ("pulse_length", t.uint16_t, True) (here: https://github.com/zigpy/zha-device-handlers/blob/dev/zhaquirks/xiaomi/aqara/switch_acn047.py#L105)

I tried under manage device to read and write the attribute manually and that indeed worked well.

@TheJulianJES @dmulcahey can you help me understand what can cause or what can be the reasons for these attributes to not to show up on the UI? I would like to continue investigation but I am stuck with this.

trapacska commented 8 months ago

OMG, took me 1 day to figure out that it is not possible to add controls on the device screen arbitrarily. These input stuff also hardcoded in home-assistant repo(s). This thing not gonna scale well I guess.

Closing this issue as it provides a partial solution to my original problem but still looking after putting in interlock and pulse_length somewhere else in HA's sources.

https://github.com/zigpy/zha-device-handlers/pull/2939

TheJulianJES commented 8 months ago

The custom entities are added here for now: https://github.com/home-assistant/core/pull/106492/files The file you linked is for initializing (reading) the attributes on pairing, as ZHA only creates the defined custom entities for the custom attributes if there's a value for the attribute in the attribute cache.