Migrating to ZHA for Xiaomi Switch issue

[csacre]

First, I used to work with Doudz integration for a year now. Thank you very much for the great work & time you spent on this Doudz! I am considering creating a github myself to share some of my home work on to deal with YAML inspired but you ;-)

Then as I understand the situation and started the migration towards ZHA.

I have 3 different type of Xiaomi devices (Thermosta, Motion Detection & Switch). No problem for the 2 first ones but I experience issues with the Switch.

1) It is not recognized using the standard pairing. => I solved it by using the procedure described in https://github.com/home-assistant/core/issues/37947 2) After pairing I only see the "battery" sensor. Not that useful for a switch...

There is a log console during pairing where I can see my click being processed but nothing more. Would you have any method to troubleshoot & solve this ?

From the signature, it seems recognized as : "zhaquirks.xiaomi.mija.sensor_switch.MijaButton" and tis sounds correct to me.

Any suggestion is welcomed...

I know this is not an issue for Doudz great plugin but I use it as a way to reach the population that could help ;-)

Thank you!

{ "node_descriptor": "NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=128, manufacturer_code=4151, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=0, maximum_outgoing_transfer_size=100, descriptor_capability_field=0)", "endpoints": { "1": { "profile_id": 260, "device_type": "0x0006", "in_clusters": [ "0x0000", "0x0001", "0x0003" ], "out_clusters": [ "0x0000", "0x0004", "0x0005", "0x0006", "0x0008", "0x0019" ] } }, "manufacturer": "LUMI", "model": "lumi.sensor_switch", "class": "zhaquirks.xiaomi.mija.sensor_switch.MijaButton" }

[doudz]

Thanks all ! Since it's related to zha and zigpy could you also open an issue on HA repo and/or zigpy ?

[doudz]

And could you post log at debug level , it could help a lot

[csacre]

What I did:

• Remove the device

• Activate log

  logs: homeassistant.components.shell_command: debug homeassistant.components.zha: debug zigpy_zigate: debug zhaquirks: debug

• Rebooted HA

• Pairing again (very close to the Zigate)

• After device with only the battery appeared, I did press once, then double click then triple click several times

Zigbee Info in ZHA screen after pairing I have created also an issue in ZHA repo: https://github.com/zigpy/zha-device-handlers/issues/593

IEEE: 00:15:8d:00:03:60:fd:a3 Nwk: 0x0289 Device Type: EndDevice LQI: 180 RSSI: Unknown Last Seen: 2020-11-21T17:37:26 Power Source: Battery or Unknown Quirk: zhaquirks.xiaomi.mija.sensor_switch.MijaButton

Log coming from the ZHA screen during & after pairing:

Device 0x0000 (00:15:8d:00:03:60:fd:a3) left the network Device 0x1209 (00:15:8d:00:03:60:fd:a3) joined the network [0x1209] Requesting 'Node Descriptor' Tries remaining: 2 [0x1209] Extending timeout for 0x0c request [0x1209:zdo] ZDO request ZDOCmd.Device_annce: [0x1209, 00:15:8d:00:03:60:fd:a3, 128] Ignoring message (b'18140a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18140a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18150a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18150a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 [0x1209] Node Descriptor: NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=128, manufacturer_code=4151, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=0, maximum_outgoing_transfer_size=100, descriptor_capability_field=0) [0x1209] Discovering endpoints Tries remaining: 3 [0x1209] Extending timeout for 0x0d request Ignoring message (b'18160a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18160a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18170a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18170a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18180a00001001') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18180a00001001') on cluster 6: unknown endpoint or cluster id: 1 Device 0x0000 (00:15:8d:00:03:60:fd:a3) left the network Device 0x0289 (00:15:8d:00:03:60:fd:a3) joined the network Device 00:15:8d:00:03:60:fd:a3 changed id (0x1209 => 0x0289) Canceling old initialize call [0x0289] Requesting 'Node Descriptor' Tries remaining: 2 [0x0289] Extending timeout for 0x0e request [0x0289:zdo] ZDO request ZDOCmd.Device_annce: [0x0289, 00:15:8d:00:03:60:fd:a3, 128] Ignoring message (b'18000a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18000a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18010a0100200a') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18010a0100200a') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'1c3412020a02ff4c0600100121f60b21a8012400000000002126022063') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'1c3412020a02ff4c0600100121f60b21a8012400000000002126022063') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18030a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18030a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18040a00001001') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18040a00001001') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18050a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18050a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 [0x0289] Node Descriptor: NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=128, manufacturer_code=4151, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=0, maximum_outgoing_transfer_size=100, descriptor_capability_field=0) [0x0289] Discovering endpoints Tries remaining: 3 [0x0289] Extending timeout for 0x0f request Ignoring message (b'18060a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18060a00001000') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18070a00001001') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18070a00001001') on cluster 6: unknown endpoint or cluster id: 1 Ignoring message (b'18080a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 Ignoring message (b'18080a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 [0x0289] Discovered endpoints: [1] [0x0289:1] Discovering endpoint information Tries remaining: 3 [0x0289] Extending timeout for 0x10 request Ignoring message (b'18090a00001000') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' Ignoring message (b'18090a00001000') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' Ignoring message (b'180a0a00001001') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' Ignoring message (b'180a0a00001001') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' Ignoring message (b'180b0a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 'No cluster ID 0x0000 on (00:15:8d:00:03:60:fd:a3, 1)' Ignoring message (b'180b0a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 'No cluster ID 0x0000 on (00:15:8d:00:03:60:fd:a3, 1)' [0x0289:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=260, device_version=1, input_clusters=[0, 3, 65535, 25], output_clusters=[0, 4, 3, 6, 8, 5, 25]) [0x0289] Extending timeout for 0x11 request [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=12 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=12 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=13 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=13 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=14 command_id=Command.Report_Attributes> [0x0289:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=5, value=)]] [0x0289:1:0x0000] Attribute report received: model=lumi.sensor_switch [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=14 command_id=Command.Report_Attributes> [0x0289:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=5, value=)]] [0x0289:1:0x0000] Attribute report received: model=lumi.sensor_switch [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> [0x0289:1] Manufacturer: LUMI [0x0289:1] Model: lumi.sensor_switch Checking quirks for LUMI lumi.sensor_switch (00:15:8d:00:03:60:fd:a3) Considering <class 'zhaquirks.xiaomi.mija.sensor_switch.MijaButton'> Found custom device replacement for 00:15:8d:00:03:60:fd:a3: <class 'zhaquirks.xiaomi.mija.sensor_switch.MijaButton'> device - 0x0289:00:15:8d:00:03:60:fd:a3 entering async_device_initialized - is_new_join: True device - 0x0289:00:15:8d:00:03:60:fd:a3 has joined the ZHA zigbee network 0x0289: started configuration 0x0289:ZDO: 'async_configure' stage succeeded [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> [0x0289:1:0x0000] ZCL request 0x0001: [[ReadAttributeRecord(attrid=4, status=<Status.SUCCESS: 0>, value=), ReadAttributeRecord(attrid=5, status=<Status.SUCCESS: 0>, value=)]] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> [0x0289:1:0x0000] ZCL request 0x0001: [[ReadAttributeRecord(attrid=4, status=<Status.SUCCESS: 0>, value=), ReadAttributeRecord(attrid=5, status=<Status.SUCCESS: 0>, value=)]] [0x0289:1:0x0001]: skipping channel configuration [0x0289:1:0x0000]: skipping channel configuration [0x0289:1:0x0008]: skipping channel configuration [0x0289:1:0x0006]: skipping channel configuration [0x0289:1:0x0019]: skipping channel configuration [0x0289:1:0x0005]: skipping channel configuration [0x0289:1:0x0001]: 'async_configure' stage succeeded [0x0289:1:0x0000]: 'async_configure' stage succeeded [0x0289:1:0x0008]: 'async_configure' stage succeeded [0x0289:1:0x0006]: 'async_configure' stage succeeded [0x0289:1:0x0019]: 'async_configure' stage succeeded [0x0289:1:0x0005]: 'async_configure' stage succeeded 0x0289: completed configuration 0x0289: stored in registry: ZhaDeviceEntry(name='LUMI lumi.sensor_switch', ieee='00:15:8d:00:03:60:fd:a3', last_seen=1605976571.296336) 0x0289: started initialization 0x0289:ZDO: 'async_initialize' stage succeeded [0x0289:1:0x0001]: 'async_initialize' stage succeeded [0x0289:1:0x0000]: 'async_initialize' stage succeeded [0x0289:1:0x0008]: 'async_initialize' stage succeeded [0x0289:1:0x0006]: 'async_initialize' stage succeeded [0x0289:1:0x0019]: 'async_initialize' stage succeeded [0x0289:1:0x0005]: 'async_initialize' stage succeeded 0x0289: power source: Battery or Unknown 0x0289: completed initialization [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=15 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=15 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=16 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=16 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=18 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=18 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=19 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=19 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=20 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=20 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=21 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=21 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=22 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=22 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=23 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=23 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=24 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=24 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=25 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=25 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=26 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=26 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0x5a89:1:0x0400] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=198 command_id=Command.Report_Attributes> [0x5a89:1:0x0400] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x5a89:1:0x0400] Attribute report received: measured_value=3 [0x5a89:1:0x0400] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=198 command_id=Command.Report_Attributes> [0x5a89:1:0x0400] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x5a89:1:0x0400] Attribute report received: measured_value=3 [0x5a89:1:0x0406] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=199 command_id=Command.Report_Attributes> [0x5a89:1:0x0406] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x5a89:1:0x0406] Attribute report received: occupancy=bitmap8.1 [0x5A89:1:0x0500]: Updated alarm state: 1 [0x5a89:1:0x0406] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=199 command_id=Command.Report_Attributes> [0x5a89:1:0x0406] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x5a89:1:0x0406] Attribute report received: occupancy=bitmap8.1 [0x5A89:1:0x0500]: Updated alarm state: 1 [0x1335:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=106 command_id=Command.Report_Attributes> [0x1335:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�!�!>)]] [0x1335:1:0x0000] Attribute report received: 65281=
!�!�! [0x1335:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=106 command_id=Command.Report_Attributes> [0x1335:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�!�!>)]] [0x1335:1:0x0000] Attribute report received: 65281=
!�!�! [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=27 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=27 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=0 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=28 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=28 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] [0x0289:1:0x0006] Attribute report received: on_off=1 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=29 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=29 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=2 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=30 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=30 command_id=Command.Report_Attributes> [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] [0x0289:1:0x0006] Attribute report received: 32768=3 [0xb332:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=4447 tsn=132 command_id=Command.Report_Attributes> [0xb332:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�(!�!>)]] [0xb332:1:0x0000] Attribute report received: 65281=
!�(!�! [0xb332:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=4447 tsn=132 command_id=Command.Report_Attributes> [0xb332:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�(!�!>)]] [0xb332:1:0x0000] Attribute report received: 65281=
!�(!�!

Log of HA:

2020-11-21 17:35:06 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant. 2020-11-21 17:35:07 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for sonoff which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant. 2020-11-21 17:35:19 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 5 seconds 2020-11-21 17:35:21 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for places which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant. 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] ZiGate WiFi detected 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Connection made 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0002 b'01' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00\x02\x00\x01\x02\x01' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10\x02\x12\x02\x10\x02\x11\x02\x12\x02\x11' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078500000002000000 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'000000020000' LQI:0 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 2, b'\x00\x00'] 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0016 b'274c0c59' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b"\x00\x16\x00\x04,'L\x0cY" 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b"\x02\x10\x16\x02\x10\x02\x14,'L\x02\x1cY" 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0010 b'' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00\x10\x00\x00\x10' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10\x10\x02\x10\x02\x10\x10' 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000079100000016000000 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'000000160000' LQI:0 2020-11-21 17:35:21 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 22, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000079700000010000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'000000100000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 16, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80100005880003031d00 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8010 b'0003031d' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [3, 797] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0009 b'' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00\t\x00\x00\t' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10\x02\x19\x02\x10\x02\x10\x02\x19' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078e00000009000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'000000090000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 9, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80090016cc000000158d0001edeaa7d72c5743b1e903263ecd0b00 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8009 b'000000158d0001edeaa7d72c5743b1e903263ecd0b' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0x0000, 00:15:8d:00:01:ed:ea:a7, 55084, 6288065119077678797, 11] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x5A89](LUMI lumi.sensor_motion.aq2) restored as 'available', last seen: 0:01:00 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x054A](LUMI lumi.sens) restored as 'available', last seen: 0:12:24 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x37B6](Philips LWE002) restored as 'available', last seen: 0:04:03 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x6706](Philips LWE002) restored as 'available', last seen: 0:04:27 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x52A7](Philips LLC010) restored as 'available', last seen: 0:02:06 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x27BF](LUMI lumi.sensor_motion.aq2) restored as 'available', last seen: 0:27:55 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0xE44A](LUMI lumi.sens) restored as 'available', last seen: 0:04:03 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0xB332](LUMI lumi.sensor_motion.aq2) restored as 'available', last seen: 0:02:48 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x1335](LUMI lumi.sens) restored as 'available', last seen: 0:37:04 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x083C](LUMI lumi.sens) restored as 'available', last seen: 0:51:16 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x741C](LUMI lumi.sens) restored as 'available', last seen: 0:10:20 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0xEE86](LUMI lumi.sens) restored as 'available', last seen: 0:37:16 ago 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] [0x0000](ZiGate ZiGate WiFi 3.1d) restored as 'unavailable', last seen: not known 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Loading battery powered devices 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x5A89: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x5A89:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x054A: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x054A:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0406]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0400]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0406]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0400]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x054A:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x5A89: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x5A89: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x054A: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x054A: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x52A7: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x52A7:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x27BF: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x27BF:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0006]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0008]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0300]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x1000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0406]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0400]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0500]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0006]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0008]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0300]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x1000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0406]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0400]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0500]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x27BF:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x52A7: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x52A7: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x27BF: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x27BF: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xE44A: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0xE44A:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xB332: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0xB332:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0406]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0400]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0500]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xE44A:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0406]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0400]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0500]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xB332:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xE44A: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xE44A: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xB332: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xB332: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x1335: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x1335:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x083C: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x083C:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x1335:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x083C:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x1335: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x1335: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x083C: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x083C: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x741C: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x741C:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xEE86: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0xEE86:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0405]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0001]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0402]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0000]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0019]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:2:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:3:0x0005]: initializing channel: from_cache: True 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x741C:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0405]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0402]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:2:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xEE86:3:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x741C: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x741C: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xEE86: power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0xEE86: completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x0000](ZiGate WiFi 3.1d): started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0000:ZDO](ZiGate WiFi 3.1d): 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x0000](ZiGate WiFi 3.1d): power source: Battery or Unknown 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x0000](ZiGate WiFi 3.1d): completed initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] Loading mains powered devices 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x37B6: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x37B6:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x6706: started initialization 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x6706:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0006]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 6, 1, 11, 1, b'\x00\x01\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000601040000050001000000' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xaa\x027\xb6\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\x01\x00\x00\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xaa\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x11\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 8, 1, 11, 2, b'\x00\x02\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x1000]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 0, 1, 11, 3, b'\x00\x03\x00\x07\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0006]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 6, 1, 11, 4, b'\x00\x04\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 8, 1, 11, 5, b'\x00\x05\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x1000]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 0, 1, 11, 6, b'\x00\x06\x00\x07\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000079c002e0530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'002e05300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 46, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016d600010400060b010237b60200001801010000001001c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001801010000001001' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x01\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016d600010400060b010237b60200001801010000001001c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001801010000001001' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x01\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000801040000050002000000' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xa7\x027\xb6\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x02\x00\x00\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xa7\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x12\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0019]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000079d002f0530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'002f05300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 47, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000001040000050003000700' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xa9\x027\xb6\x01\x0b\x00\x00\x01\x04\x00\x00\x05\x00\x03\x00\x07\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xa9\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x13\x02\x10\x02\x17\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078200300530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003005300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 48, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000601040000050004000000' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11O\x02g\x06\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\x04\x00\x00\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11O\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x14\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164a00010400080b010237b602000018020100000020a0c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018020100000020a0' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x02\x01\x00\x00\x00 \xa0'] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0008]: received attribute: 0 update with value: 160 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0008]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 8, 1, 11, 7, b'\x00\x07\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164a00010400080b010237b602000018020100000020a0c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018020100000020a0' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x02\x01\x00\x00\x00 \xa0'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016f500010400000b010237b60200001803010700003001c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000b010237b60200001803010700003001' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 11, 1,

,

, b'\x18\x03\x01\x07\x00\x000\x01'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016f500010400000b010237b60200001803010700003001c3 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000b010237b60200001803010700003001' LQI:195 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 11, 1,

,

, b'\x18\x03\x01\x07\x00\x000\x01'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078300310530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003105300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 49, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0000]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000801040000050005000000' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11@\x02g\x06\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x05\x00\x00\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11@\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x15\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200169e00010400060b0102670602000018040100000010006f 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010267060200001804010000001000' LQI:111 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x04\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200169e00010400060b0102670602000018040100000010006f 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010267060200001804010000001000' LQI:111 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x04\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0019]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078000320530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003205300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 50, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000001040000050006000700' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11L\x02g\x06\x01\x0b\x00\x00\x01\x04\x00\x00\x05\x00\x06\x00\x07\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11L\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x16\x02\x10\x02\x17\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164800010400080b0102670602000018050100000020fe78 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018050100000020fe' LQI:120 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x05\x01\x00\x00\x00 \xfe'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164800010400080b0102670602000018050100000020fe78 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018050100000020fe' LQI:120 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x05\x01\x00\x00\x00 \xfe'] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: initializing channel: from_cache: False 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 8, 1, 11, 8, b'\x00\x08\x00\x00\x00', True, False) 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078100330530000000 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003305300000' LQI:0 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 51, 1328, b'\x00\x00'] 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000801040000050007000000' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xa2\x027\xb6\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x07\x00\x00\x00' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xa2\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x17\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016ab00010400000b01026706020000180601070000300178 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000b010267060200001806010700003001' LQI:120 2020-11-21 17:35:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 11, 1,

,

, b'\x18\x06\x01\x07\x00\x000\x01'] 2020-11-21 17:35:22 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0000]: initializing channel: from_cache: False 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016ab00010400000b01026706020000180601070000300178 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000b010267060200001806010700003001' LQI:120 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 11, 1,

,

, b'\x18\x06\x01\x07\x00\x000\x01'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078600340530000000 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003405300000' LQI:0 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 52, 1328, b'\x00\x00'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200163100010400080b010237b602000018070100000020a0bd 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018070100000020a0' LQI:189 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x07\x01\x00\x00\x00 \xa0'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200163100010400080b010237b602000018070100000020a0bd 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018070100000020a0' LQI:189 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x07\x01\x00\x00\x00 \xa0'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000801040000050008000000' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11M\x02g\x06\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x08\x00\x00\x00' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11M\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x18\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0008]: received attribute: 0 update with value: 160 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0006]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0008]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x1000]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x37B6: power source: Mains 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x37B6: completed initialization 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078700350530000000 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003505300000' LQI:0 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 53, 1328, b'\x00\x00'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164500010400080b0102670602000018080100000020fe78 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018080100000020fe' LQI:120 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x08\x01\x00\x00\x00 \xfe'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164500010400080b0102670602000018080100000020fe78 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018080100000020fe' LQI:120 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x08\x01\x00\x00\x00 \xfe'] 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0006]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x1000]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x6706: power source: Mains 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x6706: completed initialization 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0006]: attempting to update onoff state - from cache: False 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 6, 1, 11, 9, b'\x00\t\x00\x00\x00', True, False) 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000601040000050009000000' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xa2\x027\xb6\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\t\x00\x00\x00' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xa2\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x19\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0006]: attempting to update onoff state - from cache: False 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 6, 1, 11, 10, b'\x00\n\x00\x00\x00', True, False) 2020-11-21 17:35:23 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0006]: attempting to update onoff state - from cache: True 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078400360530000000 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003605300000' LQI:0 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 54, 1328, b'\x00\x00'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b00060104000005000a000000' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11A\x02g\x06\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\n\x00\x00\x00' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11A\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x1a\x02\x10\x02\x10\x02\x10' 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016db00010400060b010237b60200001809010000001001c6 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001809010000001001' LQI:198 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\t\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016db00010400060b010237b60200001809010000001001c6 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001809010000001001' LQI:198 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\t\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078500370530000000 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003705300000' LQI:0 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 55, 1328, b'\x00\x00'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200168d00010400060b01026706020000180a01000000100072 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b01026706020000180a010000001000' LQI:114 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\n\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200168d00010400060b01026706020000180a01000000100072 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b01026706020000180a010000001000' LQI:114 2020-11-21 17:35:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\n\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:35:24 WARNING (SyncWorker_23) [homeassistant.components.waze_travel_time.sensor] Error on retrieving data: empty response 2020-11-21 17:35:24 WARNING (SyncWorker_19) [homeassistant.components.waze_travel_time.sensor] Error on retrieving data: empty response 2020-11-21 17:35:24 WARNING (SyncWorker_21) [homeassistant.components.waze_travel_time.sensor] Error on retrieving data: empty response 2020-11-21 17:35:24 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 10 seconds 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200158200010400080b0102670602000018d00a000020fe6f 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018d00a000020fe' LQI:111 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\xd0\n\x00\x00 \xfe'] 2020-11-21 17:35:32 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200158200010400080b0102670602000018d00a000020fe6f 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018d00a000020fe' LQI:111 2020-11-21 17:35:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\xd0\n\x00\x00 \xfe'] 2020-11-21 17:35:32 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:35:34 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 20 seconds 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016de00010404000101025a8902000018c40a00002100006f 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404000101025a8902000018c40a0000210000' LQI:111 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1024, 1, 1,

,

, b'\x18\xc4\n\x00\x00!\x00\x00'] 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016de00010404000101025a8902000018c40a00002100006f 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404000101025a8902000018c40a0000210000' LQI:111 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1024, 1, 1,

,

, b'\x18\xc4\n\x00\x00!\x00\x00'] 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ff00010404060101025a8902000018c50a0000180172 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404060101025a8902000018c50a00001801' LQI:114 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1030, 1, 1,

,

, b'\x18\xc5\n\x00\x00\x18\x01'] 2020-11-21 17:35:35 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: Updated alarm state: 1 2020-11-21 17:35:35 DEBUG (MainThread) [zhaquirks] 00:15:8d:00:04:66:6a:39 - Received motion event message 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ff00010404060101025a8902000018c50a0000180172 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404060101025a8902000018c50a00001801' LQI:114 2020-11-21 17:35:35 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1030, 1, 1,

,

, b'\x18\xc5\n\x00\x00\x18\x01'] 2020-11-21 17:35:35 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: Updated alarm state: 1 2020-11-21 17:35:35 DEBUG (MainThread) [zhaquirks] 00:15:8d:00:04:66:6a:39 - Received motion event message 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.zigbee.application] Broadcast not implemented. 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0049 b'fffc3c00' 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00I\x00\x04r\xff\xfc<\x00' 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10I\x02\x10\x02\x14r\xff\xfc<\x02\x10' 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000077500810049023800 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'008100490238' LQI:0 2020-11-21 17:35:39 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 129, 73, b'\x028'] 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027520001040000010102120902000018130a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102120902000018130a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x13\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.zigbee.application] No such device 0x1209 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027520001040000010102120902000018130a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102120902000018130a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x13\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:43 DEBUG (MainThread) [zigpy_zigate.zigbee.application] No such device 0x1209 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8048000a6600158d000360fda30100 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8048 b'00158d000360fda301' LQI:0 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [00:15:8d:00:03:60:fd:a3, 1] 2020-11-21 17:35:45 INFO (MainThread) [zigpy.application] Device 0x0000 (00:15:8d:00:03:60:fd:a3) left the network 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 004d000dfc120900158d000360fda3000200 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x4d b'120900158d000360fda30002' LQI:0 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0x1209, 00:15:8d:00:03:60:fd:a3, 0, 2] 2020-11-21 17:35:45 INFO (MainThread) [zigpy.application] Device 0x1209 (00:15:8d:00:03:60:fd:a3) joined the network 2020-11-21 17:35:45 INFO (MainThread) [zigpy.device] [0x1209] Requesting 'Node Descriptor' 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy.util] Tries remaining: 2 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy.device] [0x1209] Extending timeout for 0x0c request 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1209, 0, <ZDOCmd.Node_Desc_req: 0x0002>, 0, 0, 12, b'\x0c\t\x12', True, False) 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0212090000000200000000030c0912' 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f5\x02\x12\t\x00\x00\x00\x02\x00\x00\x00\x00\x03\x0c\t\x12' 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f5\x02\x12\x12\x02\x19\x02\x10\x02\x10\x02\x10\x02\x12\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x1c\x02\x19\x12' 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001ae50000000013000002120902fffd9c0912a3fd6003008d150080d5 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0000000013000002120902fffd9c0912a3fd6003008d150080' LQI:213 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 19, 0, 0,

,

, b'\x9c\t\x12\xa3\xfd\x03\x00\x8d\x15\x00\x80'] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy.zdo] [0x1209:zdo] ZDO request ZDOCmd.Device_annce: [0x1209, 00:15:8d:00:03:60:fd:a3, 128] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 87010005870000040000 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8701 b'00000400' LQI:0 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078b00390530000000 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003905300000' LQI:0 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 57, 1328, b'\x00\x00'] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015410001040006010102120902000018140a00001000d8 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018140a00001000' LQI:216 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x14\n\x00\x00\x10\x00'] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18140a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015410001040006010102120902000018140a00001000d8 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018140a00001000' LQI:216 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x14\n\x00\x00\x10\x00'] 2020-11-21 17:35:45 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18140a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027590001040000010102120902000018150a050042126c756d692e73656e736f725f737769746368d8 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102120902000018150a050042126c756d692e73656e736f725f737769746368' LQI:216 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x15\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18150a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027590001040000010102120902000018150a050042126c756d692e73656e736f725f737769746368d8 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102120902000018150a050042126c756d692e73656e736f725f737769746368' LQI:216 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x15\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:46 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18150a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001f5c000000800200000212090200000c00091202408037107f64000000640000d5 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'000000800200000212090200000c00091202408037107f64000000640000' LQI:213 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32770, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x0c\x00\t\x12\x02@\x807\x10\x7fd\x00\x00\x00d\x00\x00'] 2020-11-21 17:35:47 INFO (MainThread) [zigpy.device] [0x1209] Node Descriptor: NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=128, manufacturer_code=4151, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=0, maximum_outgoing_transfer_size=100, descriptor_capability_field=0) 2020-11-21 17:35:47 INFO (MainThread) [zigpy.device] [0x1209] Discovering endpoints 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy.util] Tries remaining: 3 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy.device] [0x1209] Extending timeout for 0x0d request 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1209, 0, <ZDOCmd.Active_EP_req: 0x0005>, 0, 0, 13, b'\r\t\x12', True, False) 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0212090000000500000000030d0912' 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f3\x02\x12\t\x00\x00\x00\x05\x00\x00\x00\x00\x03\r\t\x12' 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f3\x02\x12\x12\x02\x19\x02\x10\x02\x10\x02\x10\x02\x15\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x1d\x02\x19\x12' 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000788003a0530000000 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003a05300000' LQI:0 2020-11-21 17:35:47 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 58, 1328, b'\x00\x00'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154e0001040006010102120902000018160a00001000d5 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018160a00001000' LQI:213 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x16\n\x00\x00\x10\x00'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18160a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154e0001040006010102120902000018160a00001000d5 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018160a00001000' LQI:213 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x16\n\x00\x00\x10\x00'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18160a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154f0001040006010102120902000018170a00001000d5 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018170a00001000' LQI:213 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x17\n\x00\x00\x10\x00'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18170a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154f0001040006010102120902000018170a00001000d5 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018170a00001000' LQI:213 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x17\n\x00\x00\x10\x00'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18170a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154c0001040006010102120902000018180a00001001d8 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018180a00001001' LQI:216 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x18\n\x00\x00\x10\x01'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18180a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200154c0001040006010102120902000018180a00001001d8 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102120902000018180a00001001' LQI:216 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1, <Address address_mode=ADDRESS_MODE.NWK address=0x1209>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x18\x18\n\x00\x00\x10\x01'] 2020-11-21 17:35:48 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18180a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:54 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 40 seconds 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8048000a6700158d000360fda30000 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8048 b'00158d000360fda300' LQI:0 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [00:15:8d:00:03:60:fd:a3, 0] 2020-11-21 17:35:55 INFO (MainThread) [zigpy.application] Device 0x0000 (00:15:8d:00:03:60:fd:a3) left the network 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 004d000dee028900158d000360fda3800000 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.api] data received 0x4d b'028900158d000360fda38000' LQI:0 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0x0289, 00:15:8d:00:03:60:fd:a3, 128, 0] 2020-11-21 17:35:55 INFO (MainThread) [zigpy.application] Device 0x0289 (00:15:8d:00:03:60:fd:a3) joined the network 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy.application] Device 00:15:8d:00:03:60:fd:a3 changed id (0x1209 => 0x0289) 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy.device] Canceling old initialize call 2020-11-21 17:35:55 INFO (MainThread) [zigpy.device] [0x0289] Requesting 'Node Descriptor' 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy.util] Tries remaining: 2 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy.device] [0x0289] Extending timeout for 0x0e request 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x0289, 0, <ZDOCmd.Node_Desc_req: 0x0002>, 0, 0, 14, b'\x0e\x89\x02', True, False) 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0202890000000200000000030e8902' 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f7\x02\x02\x89\x00\x00\x00\x02\x00\x00\x00\x00\x03\x0e\x89\x02' 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f7\x02\x12\x02\x12\x89\x02\x10\x02\x10\x02\x10\x02\x12\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x1e\x89\x02\x12' 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078e003c0530000000 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003c05300000' LQI:0 2020-11-21 17:35:55 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 60, 1328, b'\x00\x00'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001a800000000013000002028902fffdfe8902a3fd6003008d150080d2 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0000000013000002028902fffdfe8902a3fd6003008d150080' LQI:210 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 19, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x0289>, <Address address_mode=ADDRESS_MODE.NWK address=0xfffd>, b'\xfe\x89\x02\xa3\xfd\x03\x00\x8d\x15\x00\x80'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.zdo] [0x0289:zdo] ZDO request ZDOCmd.Device_annce: [0x0289, 00:15:8d:00:03:60:fd:a3, 128] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 87010005870000040000 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8701 b'00000400' LQI:0 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d10001040000010102028902000018000a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018000a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x00\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18000a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d10001040000010102028902000018000a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018000a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x00\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18000a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015f40001040000010102028902000018010a0100200ad5 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018010a0100200a' LQI:213 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x01\n\x01\x00 \n'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18010a0100200a') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015f40001040000010102028902000018010a0100200ad5 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018010a0100200a' LQI:213 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x01\n\x01\x00 \n'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18010a0100200a') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002002b57000104000001010202890200001c3412020a02ff4c0600100121f60b21a8012400000000002126022063d2 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'000104000001010202890200001c3412020a02ff4c0600100121f60b21a8012400000000002126022063' LQI:210 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x1c4\x12\x02\n\x02\xffL\x06\x00\x10\x01!\xf6\x0b!\xa8\x01$\x00\x00\x00\x00\x00!&\x02 c'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'1c3412020a02ff4c0600100121f60b21a8012400000000002126022063') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002002b57000104000001010202890200001c3412020a02ff4c0600100121f60b21a8012400000000002126022063d2 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'000104000001010202890200001c3412020a02ff4c0600100121f60b21a8012400000000002126022063' LQI:210 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x1c4\x12\x02\n\x02\xffL\x06\x00\x10\x01!\xf6\x0b!\xa8\x01$\x00\x00\x00\x00\x00!&\x02 c'] 2020-11-21 17:35:56 DEBUG (MainThread) [zigpy.device] Ignoring message (b'1c3412020a02ff4c0600100121f60b21a8012400000000002126022063') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015cb0001040006010102028902000018030a00001000d5 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018030a00001000' LQI:213 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x03\n\x00\x00\x10\x00'] 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18030a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015cb0001040006010102028902000018030a00001000d5 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018030a00001000' LQI:213 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x03\n\x00\x00\x10\x00'] 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18030a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ca0001040006010102028902000018040a00001001d2 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018040a00001001' LQI:210 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x04\n\x00\x00\x10\x01'] 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18040a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ca0001040006010102028902000018040a00001001d2 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018040a00001001' LQI:210 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x04\n\x00\x00\x10\x01'] 2020-11-21 17:35:58 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18040a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d40001040000010102028902000018050a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018050a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x05\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18050a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d40001040000010102028902000018050a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018050a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x05\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:00 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18050a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001f5e000000800200000202890200000e00890202408037107f64000000640000d5 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'000000800200000202890200000e00890202408037107f64000000640000' LQI:213 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32770, 0, 0,

,

, b'\x0e\x00\x89\x02\x02@\x807\x10\x7fd\x00\x00\x00d\x00\x00'] 2020-11-21 17:36:01 INFO (MainThread) [zigpy.device] [0x0289] Node Descriptor: NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=128, manufacturer_code=4151, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=0, maximum_outgoing_transfer_size=100, descriptor_capability_field=0) 2020-11-21 17:36:01 INFO (MainThread) [zigpy.device] [0x0289] Discovering endpoints 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy.util] Tries remaining: 3 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy.device] [0x0289] Extending timeout for 0x0f request 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x0289, 0, <ZDOCmd.Active_EP_req: 0x0005>, 0, 0, 15, b'\x0f\x89\x02', True, False) 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0202890000000500000000030f8902' 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f1\x02\x02\x89\x00\x00\x00\x05\x00\x00\x00\x00\x03\x0f\x89\x02' 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f1\x02\x12\x02\x12\x89\x02\x10\x02\x10\x02\x10\x02\x15\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x1f\x89\x02\x12' 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078c003e0530000000 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003e05300000' LQI:0 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 62, 1328, b'\x00\x00'] 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 801100082e0002890100003d00 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8011 b'0002890100003d' LQI:0 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0x0289, 1, 0, 61] 2020-11-21 17:36:01 DEBUG (MainThread) [zigpy_zigate.zigbee.application] ACK Data received 61 0 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ce0001040006010102028902000018060a00001000d5 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018060a00001000' LQI:213 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x06\n\x00\x00\x10\x00'] 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18060a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015ce0001040006010102028902000018060a00001000d5 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018060a00001000' LQI:213 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x06\n\x00\x00\x10\x00'] 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18060a00001000') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c90001040006010102028902000018070a00001001d2 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018070a00001001' LQI:210 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x07\n\x00\x00\x10\x01'] 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18070a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c90001040006010102028902000018070a00001001d2 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018070a00001001' LQI:210 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x07\n\x00\x00\x10\x01'] 2020-11-21 17:36:02 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18070a00001001') on cluster 6: unknown endpoint or cluster id: 1 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027de0001040000010102028902000018080a050042126c756d692e73656e736f725f737769746368d2 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018080a050042126c756d692e73656e736f725f737769746368' LQI:210 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x08\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18080a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027de0001040000010102028902000018080a050042126c756d692e73656e736f725f737769746368d2 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018080a050042126c756d692e73656e736f725f737769746368' LQI:210 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x08\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18080a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 1 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020014c9000000800500000202890200000f0089020101d5 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'000000800500000202890200000f0089020101' LQI:213 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32773, 0, 0,

,

, b'\x0f\x00\x89\x02\x01\x01'] 2020-11-21 17:36:03 INFO (MainThread) [zigpy.device] [0x0289] Discovered endpoints: [1] 2020-11-21 17:36:03 INFO (MainThread) [zigpy.endpoint] [0x0289:1] Discovering endpoint information 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy.util] Tries remaining: 3 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy.device] [0x0289] Extending timeout for 0x10 request 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x0289, 0, <ZDOCmd.Simple_Desc_req: 0x0004>, 0, 0, 16, b'\x10\x89\x02\x01', True, False) 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'02028900000004000000000410890201' 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x106\x02\x02\x89\x00\x00\x00\x04\x00\x00\x00\x00\x04\x10\x89\x02\x01' 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x106\x02\x12\x02\x12\x89\x02\x10\x02\x10\x02\x10\x02\x14\x02\x10\x02\x10\x02\x10\x02\x10\x02\x14\x10\x89\x02\x12\x02\x11' 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000078d003f0530000000 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'003f05300000' LQI:0 2020-11-21 17:36:03 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 63, 1328, b'\x00\x00'] 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c10001040006010102028902000018090a00001000d5 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018090a00001000' LQI:213 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\t\n\x00\x00\x10\x00'] 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18090a00001000') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c10001040006010102028902000018090a00001000d5 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018090a00001000' LQI:213 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\t\n\x00\x00\x10\x00'] 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy.device] Ignoring message (b'18090a00001000') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c300010400060101020289020000180a0a00001001d5 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180a0a00001001' LQI:213 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\n\n\x00\x00\x10\x01'] 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy.device] Ignoring message (b'180a0a00001001') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c300010400060101020289020000180a0a00001001d5 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180a0a00001001' LQI:213 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\n\n\x00\x00\x10\x01'] 2020-11-21 17:36:04 DEBUG (MainThread) [zigpy.device] Ignoring message (b'180a0a00001001') on cluster 6: unknown endpoint or cluster id: 'No cluster ID 0x0006 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027da00010400000101020289020000180b0a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101020289020000180b0a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x0b\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy.device] Ignoring message (b'180b0a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 'No cluster ID 0x0000 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027da00010400000101020289020000180b0a050042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101020289020000180b0a050042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x0b\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:05 DEBUG (MainThread) [zigpy.device] Ignoring message (b'180b0a050042126c756d692e73656e736f725f737769746368') on cluster 0: unknown endpoint or cluster id: 'No cluster ID 0x0000 on (00:15:8d:00:03:60:fd:a3, 1)' 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020031e000000080040000020289020000100089021e0104010401010400000300ffff1900070000040003000600080005001900d5 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080040000020289020000100089021e0104010401010400000300ffff1900070000040003000600080005001900' LQI:213 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32772, 0, 0,

,

, b'\x10\x00\x89\x02\x1e\x01\x04\x01\x04\x01\x01\x04\x00\x00\x03\x00\xff\xff\x19\x00\x07\x00\x00\x04\x00\x03\x00\x06\x00\x08\x00\x05\x00\x19\x00'] 2020-11-21 17:36:06 INFO (MainThread) [zigpy.endpoint] [0x0289:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=260, device_version=1, input_clusters=[0, 3, 65535, 25], output_clusters=[0, 4, 3, 6, 8, 5, 25]) 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy.device] [0x0289] Extending timeout for 0x11 request 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x0289, 260, 0, 1, 1, 17, b'\x00\x11\x00\x04\x00\x05\x00', True, False) 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'02028901010000010400000700110004000500' 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x13\xbd\x02\x02\x89\x01\x01\x00\x00\x01\x04\x00\x00\x07\x00\x11\x00\x04\x00\x05\x00' 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x13\xbd\x02\x12\x02\x12\x89\x02\x11\x02\x11\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x17\x02\x10\x11\x02\x10\x02\x14\x02\x10\x02\x15\x02\x10' 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f200400530000000 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004005300000' LQI:0 2020-11-21 17:36:06 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 64, 1328, b'\x00\x00'] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c400010400060101020289020000180c0a00001000d5 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180c0a00001000' LQI:213 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x0c\n\x00\x00\x10\x00'] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=12 command_id=Command.Report_Attributes> 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c400010400060101020289020000180c0a00001000d5 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180c0a00001000' LQI:213 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x0c\n\x00\x00\x10\x00'] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=12 command_id=Command.Report_Attributes> 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c300010400060101020289020000180d0a00001001d2 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180d0a00001001' LQI:210 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\r\n\x00\x00\x10\x01'] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=13 command_id=Command.Report_Attributes> 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c300010400060101020289020000180d0a00001001d2 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180d0a00001001' LQI:210 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\r\n\x00\x00\x10\x01'] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=13 command_id=Command.Report_Attributes> 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:07 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d800010400000101020289020000180e0a050042126c756d692e73656e736f725f737769746368d2 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101020289020000180e0a050042126c756d692e73656e736f725f737769746368' LQI:210 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x0e\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=14 command_id=Command.Report_Attributes> 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=5, value=)]] 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] Attribute report received: model=lumi.sensor_switch 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020027d800010400000101020289020000180e0a050042126c756d692e73656e736f725f737769746368d2 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101020289020000180e0a050042126c756d692e73656e736f725f737769746368' LQI:210 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x0e\n\x05\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=14 command_id=Command.Report_Attributes> 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=5, value=)]] 2020-11-21 17:36:09 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] Attribute report received: model=lumi.sensor_switch 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020031820001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x11\x01\x04\x00\x00B\x04LUMI\x05\x00\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.endpoint] [0x0289:1] Manufacturer: LUMI 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.endpoint] [0x0289:1] Model: lumi.sensor_switch 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for LUMI lumi.sensor_switch (00:15:8d:00:03:60:fd:a3) 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xiaomi.mija.sensor_switch.MijaButton'> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.quirks.registry] Found custom device replacement for 00:15:8d:00:03:60:fd:a3: <class 'zhaquirks.xiaomi.mija.sensor_switch.MijaButton'> 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0x0289:00:15:8d:00:03:60:fd:a3 entering async_device_initialized - is_new_join: True 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0x0289:00:15:8d:00:03:60:fd:a3 has joined the ZHA zigbee network 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: started configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x0289:ZDO: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020031820001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x11\x01\x04\x00\x00B\x04LUMI\x05\x00\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL request 0x0001: [[ReadAttributeRecord(attrid=4, status=<Status.SUCCESS: 0>, value=), ReadAttributeRecord(attrid=5, status=<Status.SUCCESS: 0>, value=)]] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020031820001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368d5 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102028902000018110104000042044c554d4905000042126c756d692e73656e736f725f737769746368' LQI:213 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18\x11\x01\x04\x00\x00B\x04LUMI\x05\x00\x00B\x12lumi.sensor_switch'] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Read_Attributes_rsp> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0000] ZCL request 0x0001: [[ReadAttributeRecord(attrid=4, status=<Status.SUCCESS: 0>, value=), ReadAttributeRecord(attrid=5, status=<Status.SUCCESS: 0>, value=)]] 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0001]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0000]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0008]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0006]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0019]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0005]: skipping channel configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0001]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0000]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0008]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0006]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0019]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0005]: 'async_configure' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: completed configuration 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: stored in registry: ZhaDeviceEntry(name='LUMI lumi.sensor_switch', ieee='00:15:8d:00:03:60:fd:a3', last_seen=1605976571.296336) 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: started initialization 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] 0x0289:ZDO: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0001]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0000]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0008]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0006]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0019]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x0289:1:0x0005]: 'async_initialize' stage succeeded 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: power source: Battery or Unknown 2020-11-21 17:36:11 DEBUG (MainThread) [homeassistant.components.zha.core.device] 0x0289: completed initialization 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c000010400060101020289020000180f0a00001000d2 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180f0a00001000' LQI:210 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x0f\n\x00\x00\x10\x00'] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=15 command_id=Command.Report_Attributes> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015c000010400060101020289020000180f0a00001000d2 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000180f0a00001000' LQI:210 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x0f\n\x00\x00\x10\x00'] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=15 command_id=Command.Report_Attributes> 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:11 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015de0001040006010102028902000018100a00001001d2 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018100a00001001' LQI:210 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x10\n\x00\x00\x10\x01'] 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=16 command_id=Command.Report_Attributes> 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015de0001040006010102028902000018100a00001001d2 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018100a00001001' LQI:210 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x10\n\x00\x00\x10\x01'] 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=16 command_id=Command.Report_Attributes> 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:12 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015de0001040006010102028902000018110a00001000d2 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018110a00001000' LQI:210 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x11\n\x00\x00\x10\x00'] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Report_Attributes> 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015de0001040006010102028902000018110a00001000d2 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018110a00001000' LQI:210 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x11\n\x00\x00\x10\x00'] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=17 command_id=Command.Report_Attributes> 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015dc0001040006010102028902000018120a00001001d2 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018120a00001001' LQI:210 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x12\n\x00\x00\x10\x01'] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=18 command_id=Command.Report_Attributes> 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015dc0001040006010102028902000018120a00001001d2 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018120a00001001' LQI:210 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x12\n\x00\x00\x10\x01'] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=18 command_id=Command.Report_Attributes> 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:15 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015dc0001040006010102028902000018130a00001000d2 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018130a00001000' LQI:210 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x13\n\x00\x00\x10\x00'] 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=19 command_id=Command.Report_Attributes> 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015dc0001040006010102028902000018130a00001000d2 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018130a00001000' LQI:210 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x13\n\x00\x00\x10\x00'] 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=19 command_id=Command.Report_Attributes> 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:16 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015da0001040006010102028902000018140a00001001d2 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018140a00001001' LQI:210 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x14\n\x00\x00\x10\x01'] 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=20 command_id=Command.Report_Attributes> 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015da0001040006010102028902000018140a00001001d2 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018140a00001001' LQI:210 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x14\n\x00\x00\x10\x01'] 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=20 command_id=Command.Report_Attributes> 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:17 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200156f0001040006010102028902000018150a00802002d5 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018150a00802002' LQI:213 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x15\n\x00\x80 \x02'] 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=21 command_id=Command.Report_Attributes> 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200156f0001040006010102028902000018150a00802002d5 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018150a00802002' LQI:213 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x15\n\x00\x80 \x02'] 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=21 command_id=Command.Report_Attributes> 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:18 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015600001040006010102028902000018160a00802003d8 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018160a00802003' LQI:216 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x16\n\x00\x80 \x03'] 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=22 command_id=Command.Report_Attributes> 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015600001040006010102028902000018160a00802003d8 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018160a00802003' LQI:216 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x16\n\x00\x80 \x03'] 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=22 command_id=Command.Report_Attributes> 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:20 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015d80001040006010102028902000018170a00001000d2 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018170a00001000' LQI:210 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x17\n\x00\x00\x10\x00'] 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=23 command_id=Command.Report_Attributes> 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015d80001040006010102028902000018170a00001000d2 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018170a00001000' LQI:210 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x17\n\x00\x00\x10\x00'] 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=23 command_id=Command.Report_Attributes> 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015d60001040006010102028902000018180a00001001d2 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018180a00001001' LQI:210 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x18\n\x00\x00\x10\x01'] 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=24 command_id=Command.Report_Attributes> 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015d60001040006010102028902000018180a00001001d2 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018180a00001001' LQI:210 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x18\n\x00\x00\x10\x01'] 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=24 command_id=Command.Report_Attributes> 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:23 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015630001040006010102028902000018190a00802002d5 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018190a00802002' LQI:213 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x19\n\x00\x80 \x02'] 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=25 command_id=Command.Report_Attributes> 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015630001040006010102028902000018190a00802002d5 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040006010102028902000018190a00802002' LQI:213 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x19\n\x00\x80 \x02'] 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=25 command_id=Command.Report_Attributes> 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200156100010400060101020289020000181a0a00802003d5 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181a0a00802003' LQI:213 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1a\n\x00\x80 \x03'] 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=26 command_id=Command.Report_Attributes> 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200156100010400060101020289020000181a0a00802003d5 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181a0a00802003' LQI:213 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1a\n\x00\x80 \x03'] 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=26 command_id=Command.Report_Attributes> 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:36:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:36:34 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 80 seconds 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016c200010404000101025a8902000018c60a000021030072 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404000101025a8902000018c60a0000210300' LQI:114 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1024, 1, 1,

,

, b'\x18\xc6\n\x00\x00!\x03\x00'] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=198 command_id=Command.Report_Attributes> 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] Attribute report received: measured_value=3 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016c200010404000101025a8902000018c60a000021030072 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404000101025a8902000018c60a0000210300' LQI:114 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1024, 1, 1,

,

, b'\x18\xc6\n\x00\x00!\x03\x00'] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=198 command_id=Command.Report_Attributes> 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0400] Attribute report received: measured_value=3 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015e000010404060101025a8902000018c70a000018016f 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404060101025a8902000018c70a00001801' LQI:111 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1030, 1, 1,

,

, b'\x18\xc7\n\x00\x00\x18\x01'] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=199 command_id=Command.Report_Attributes> 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] Attribute report received: occupancy=bitmap8.1 2020-11-21 17:36:37 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: Updated alarm state: 1 2020-11-21 17:36:37 DEBUG (MainThread) [zhaquirks] 00:15:8d:00:04:66:6a:39 - Received motion event message 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015e000010404060101025a8902000018c70a000018016f 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010404060101025a8902000018c70a00001801' LQI:111 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 1030, 1, 1,

,

, b'\x18\xc7\n\x00\x00\x18\x01'] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=199 command_id=Command.Report_Attributes> 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:36:37 DEBUG (MainThread) [zigpy.zcl] [0x5a89:1:0x0406] Attribute report received: occupancy=bitmap8.1 2020-11-21 17:36:37 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: Updated alarm state: 1 2020-11-21 17:36:37 DEBUG (MainThread) [zhaquirks] 00:15:8d:00:04:66:6a:39 - Received motion event message 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200349b00010400000101021335020000186a0a01ff421f01218b0b0421a8130521120006240100000000642953076521d61c0a21000042 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101021335020000186a0a01ff421f01218b0b0421a8130521120006240100000000642953076521d61c0a210000' LQI:66 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18j\n\x01\xffB\x1f\x01!\x8b\x0b\x04!\xa8\x13\x05!\x12\x00\x06$\x01\x00\x00\x00\x00d)S\x07e!\xd6\x1c\n!\x00\x00'] 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=106 command_id=Command.Report_Attributes> 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�!�!>)]] 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] Attribute report received: 65281=
!�!�! 2020-11-21 17:37:09 DEBUG (MainThread) [zhaquirks.xiaomi] 00:15:8d:00:03:a2:79:93 - Attribute report. attribute_id: [65281] value: [{'battery_voltage_mV': 2955, 'X-attrib-4': 5032, 'X-attrib-5': 18, 'X-attrib-6': 1, 'temperature_measurement': 1875, 'humidity_measurement': 7382, 'path': 0, 'battery_level': 155}] 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200349b00010400000101021335020000186a0a01ff421f01218b0b0421a8130521120006240100000000642953076521d61c0a21000042 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400000101021335020000186a0a01ff421f01218b0b0421a8130521120006240100000000642953076521d61c0a210000' LQI:66 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x18j\n\x01\xffB\x1f\x01!\x8b\x0b\x04!\xa8\x13\x05!\x12\x00\x06$\x01\x00\x00\x00\x00d)S\x07e!\xd6\x1c\n!\x00\x00'] 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=106 command_id=Command.Report_Attributes> 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�!�!>)]] 2020-11-21 17:37:09 DEBUG (MainThread) [zigpy.zcl] [0x1335:1:0x0000] Attribute report received: 65281=
!�!�! 2020-11-21 17:37:09 DEBUG (MainThread) [zhaquirks.xiaomi] 00:15:8d:00:03:a2:79:93 - Attribute report. attribute_id: [65281] value: [{'battery_voltage_mV': 2955, 'X-attrib-4': 5032, 'X-attrib-5': 18, 'X-attrib-6': 1, 'temperature_measurement': 1875, 'humidity_measurement': 7382, 'path': 0, 'battery_level': 155}] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015bb00010400060101020289020000181b0a00001000bd 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181b0a00001000' LQI:189 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1b\n\x00\x00\x10\x00'] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=27 command_id=Command.Report_Attributes> 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015bb00010400060101020289020000181b0a00001000bd 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181b0a00001000' LQI:189 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1b\n\x00\x00\x10\x00'] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=27 command_id=Command.Report_Attributes> 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=0 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015bd00010400060101020289020000181c0a00001001bd 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181c0a00001001' LQI:189 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1c\n\x00\x00\x10\x01'] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=28 command_id=Command.Report_Attributes> 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020015bd00010400060101020289020000181c0a00001001bd 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181c0a00001001' LQI:189 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1c\n\x00\x00\x10\x01'] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=28 command_id=Command.Report_Attributes> 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=0, value=)]] 2020-11-21 17:37:22 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: on_off=1 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200150300010400060101020289020000181d0a00802002b1 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181d0a00802002' LQI:177 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1d\n\x00\x80 \x02'] 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=29 command_id=Command.Report_Attributes> 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200150300010400060101020289020000181d0a00802002b1 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181d0a00802002' LQI:177 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1d\n\x00\x80 \x02'] 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=29 command_id=Command.Report_Attributes> 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:37:24 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=2 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200150400010400060101020289020000181e0a00802003b4 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181e0a00802003' LQI:180 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1e\n\x00\x80 \x03'] 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=30 command_id=Command.Report_Attributes> 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200150400010400060101020289020000181e0a00802003b4 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060101020289020000181e0a00802003' LQI:180 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 1, 1,

,

, b'\x18\x1e\n\x00\x80 \x03'] 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL deserialize: <ZCLHeader frame_control= manufacturer=None tsn=30 command_id=Command.Report_Attributes> 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] ZCL request 0x000a: [[Attribute(attrid=32768, value=)]] 2020-11-21 17:37:26 DEBUG (MainThread) [zigpy.zcl] [0x0289:1:0x0006] Attribute report received: 32768=3 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020038630001040000010102b3320200001c5f11840a01ff42210121c70b0328150421a8130521100006240d000000000a2100006410000b21070039 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102b3320200001c5f11840a01ff42210121c70b0328150421a8130521100006240d000000000a2100006410000b210700' LQI:57 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x1c_\x11\x84\n\x01\xffB!\x01!\xc7\x0b\x03(\x15\x04!\xa8\x13\x05!\x10\x00\x06$\r\x00\x00\x00\x00\n!\x00\x00d\x10\x00\x0b!\x07\x00'] 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=4447 tsn=132 command_id=Command.Report_Attributes> 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�(!�!>)]] 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] Attribute report received: 65281=
!�(!�! 2020-11-21 17:37:27 DEBUG (MainThread) [zhaquirks.xiaomi] 00:15:8d:00:04:66:34:2f - Attribute report. attribute_id: [65281] value: [{'battery_voltage_mV': 3015, 'temperature': 21, 'X-attrib-4': 5032, 'X-attrib-5': 16, 'X-attrib-6': 13, 'path': 0, '0xff01-100': <Bool.false: 0>, 'illuminance_measurement': 7, 'battery_level': 200}] 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020038630001040000010102b3320200001c5f11840a01ff42210121c70b0328150421a8130521100006240d000000000a2100006410000b21070039 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'0001040000010102b3320200001c5f11840a01ff42210121c70b0328150421a8130521100006240d000000000a2100006410000b210700' LQI:57 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 0, 1, 1,

,

, b'\x1c_\x11\x84\n\x01\xffB!\x01!\xc7\x0b\x03(\x15\x04!\xa8\x13\x05!\x10\x00\x06$\r\x00\x00\x00\x00\n!\x00\x00d\x10\x00\x0b!\x07\x00'] 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] ZCL deserialize: <ZCLHeader frame_control= manufacturer=4447 tsn=132 command_id=Command.Report_Attributes> 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=
!�(!�!>)]] 2020-11-21 17:37:27 DEBUG (MainThread) [zigpy.zcl] [0xb332:1:0x0000] Attribute report received: 65281=
!�(!�! 2020-11-21 17:37:27 DEBUG (MainThread) [zhaquirks.xiaomi] 00:15:8d:00:04:66:34:2f - Attribute report. attribute_id: [65281] value: [{'battery_voltage_mV': 3015, 'temperature': 21, 'X-attrib-4': 5032, 'X-attrib-5': 16, 'X-attrib-6': 13, 'path': 0, '0xff01-100': <Bool.false: 0>, 'illuminance_measurement': 7, 'battery_level': 200}] 2020-11-21 17:37:54 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 80 seconds 2020-11-21 17:38:37 DEBUG (MainThread) [zhaquirks] 00:15:8d:00:04:66:6a:39 - Resetting motion sensor 2020-11-21 17:38:37 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x5A89:1:0x0500]: Updated alarm state: 0 2020-11-21 17:39:00 DEBUG (MainThread) [homeassistant.components.zha.entity] light.0017880103324e32_level_light_color_on_off: polling current state - from cache: False 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x52A7, 260, 6, 1, 11, 18, b'\x00\x12\x00\x00\x00', True, False) 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0252a7010b000601040000050012000000' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xcd\x02R\xa7\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\x12\x00\x00\x00' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xcd\x02\x12R\xa7\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x12\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f300410530000000 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004105300000' LQI:0 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 65, 1328, b'\x00\x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200162800010400060b010252a702000018120100000010015a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010252a70200001812010000001001' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x12\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200162800010400060b010252a702000018120100000010015a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010252a70200001812010000001001' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x12\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x52A7, 260, 8, 1, 11, 19, b'\x00\x13\x00\x00\x00', True, False) 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0252a7010b000801040000050013000000' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xc2\x02R\xa7\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x13\x00\x00\x00' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xc2\x02\x12R\xa7\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x13\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f000420530000000 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004205300000' LQI:0 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 66, 1328, b'\x00\x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016e800010400080b010252a702000018130100000020fe5a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010252a702000018130100000020fe' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x13\x01\x00\x00\x00 \xfe'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016e800010400080b010252a702000018130100000020fe5a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010252a702000018130100000020fe' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x13\x01\x00\x00\x00 \xfe'] 2020-11-21 17:39:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x52A7:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x52A7, 260, 768, 1, 11, 20, b'\x00\x14\x00\x03\x00\x04\x00\x02@', True, False) 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0252a7010b03000104000009001400030004000240' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x15\x83\x02R\xa7\x01\x0b\x03\x00\x01\x04\x00\x00\t\x00\x14\x00\x03\x00\x04\x00\x02@' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x15\x83\x02\x12R\xa7\x02\x11\x02\x1b\x02\x13\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x19\x02\x10\x14\x02\x10\x02\x13\x02\x10\x02\x14\x02\x10\x02\x12@' 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f100430530000000 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004305300000' LQI:0 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 67, 1328, b'\x00\x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200227500010403000b010252a70200001814010300002166b304000021874c02400020005a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010403000b010252a70200001814010300002166b304000021874c0240002000' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 768, 11, 1,

,

, b'\x18\x14\x01\x03\x00\x00!f\xb3\x04\x00\x00!\x87L\x02@\x00 \x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200227500010403000b010252a70200001814010300002166b304000021874c02400020005a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010403000b010252a70200001814010300002166b304000021874c0240002000' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 768, 11, 1,

,

, b'\x18\x14\x01\x03\x00\x00!f\xb3\x04\x00\x00!\x87L\x02@\x00 \x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200227500010403000b010252a70200001814010300002166b304000021874c02400020005a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010403000b010252a70200001814010300002166b304000021874c0240002000' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 768, 11, 1,

,

, b'\x18\x14\x01\x03\x00\x00!f\xb3\x04\x00\x00!\x87L\x02@\x00 \x00'] 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200227500010403000b010252a70200001814010300002166b304000021874c02400020005a 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010403000b010252a70200001814010300002166b304000021874c0240002000' LQI:90 2020-11-21 17:39:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 768, 11, 1,

,

, b'\x18\x14\x01\x03\x00\x00!f\xb3\x04\x00\x00!\x87L\x02@\x00 \x00'] 2020-11-21 17:39:14 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 80 seconds 2020-11-21 17:39:17 DEBUG (MainThread) [homeassistant.components.zha.entity] light.0017880106c1d10e_level_on_off: polling current state - from cache: False 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 6, 1, 11, 21, b'\x00\x15\x00\x00\x00', True, False) 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000601040000050015000000' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11^\x02g\x06\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\x15\x00\x00\x00' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11^\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x15\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f600440530000000 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004405300000' LQI:0 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 68, 1328, b'\x00\x00'] 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200169200010400060b01026706020000181501000000100072 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010267060200001815010000001000' LQI:114 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x15\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200169200010400060b01026706020000181501000000100072 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010267060200001815010000001000' LQI:114 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x15\x01\x00\x00\x00\x10\x00'] 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x6706, 260, 8, 1, 11, 22, b'\x00\x16\x00\x00\x00', True, False) 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'026706010b000801040000050016000000' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11S\x02g\x06\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x16\x00\x00\x00' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11S\x02\x12g\x02\x16\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x16\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f700450530000000 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004505300000' LQI:0 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 69, 1328, b'\x00\x00'] 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164c00010400080b0102670602000018160100000020fe6f 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018160100000020fe' LQI:111 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x16\x01\x00\x00\x00 \xfe'] 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200164c00010400080b0102670602000018160100000020fe6f 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b0102670602000018160100000020fe' LQI:111 2020-11-21 17:39:17 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x16\x01\x00\x00\x00 \xfe'] 2020-11-21 17:39:17 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x6706:11:0x0008]: received attribute: 0 update with value: 254 2020-11-21 17:39:32 DEBUG (MainThread) [homeassistant.components.zha.entity] light.0017880106c18108_level_on_off: polling current state - from cache: False 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 6, 1, 11, 23, b'\x00\x17\x00\x00\x00', True, False) 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000601040000050017000000' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xbc\x027\xb6\x01\x0b\x00\x06\x01\x04\x00\x00\x05\x00\x17\x00\x00\x00' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xbc\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x17\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f400460530000000 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004605300000' LQI:0 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 70, 1328, b'\x00\x00'] 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016c000010400060b010237b60200001817010000001001c3 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001817010000001001' LQI:195 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x17\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80020016c000010400060b010237b60200001817010000001001c3 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400060b010237b60200001817010000001001' LQI:195 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 6, 11, 1,

,

, b'\x18\x17\x01\x00\x00\x00\x10\x01'] 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x37B6, 260, 8, 1, 11, 24, b'\x00\x18\x00\x00\x00', True, False) 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x0530 b'0237b6010b000801040000050018000000' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\xbd\x027\xb6\x01\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x18\x00\x00\x00' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\xbd\x02\x127\xb6\x02\x11\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x18\x02\x10\x02\x10\x02\x10' 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000007f500470530000000 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'004705300000' LQI:0 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 71, 1328, b'\x00\x00'] 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200165500010400080b010237b602000018180100000020a0c6 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018180100000020a0' LQI:198 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x18\x01\x00\x00\x00 \xa0'] 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200165500010400080b010237b602000018180100000020a0c6 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00010400080b010237b602000018180100000020a0' LQI:198 2020-11-21 17:39:32 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 260, 8, 11, 1,

,

, b'\x18\x18\x01\x00\x00\x00 \xa0'] 2020-11-21 17:39:32 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x37B6:11:0x0008]: received attribute: 0 update with value: 160 2020-11-21 17:40:27 WARNING (SyncWorker_44) [homeassistant.components.waze_travel_time.sensor] Error on retrieving data: empty response 2020-11-21 17:40:34 WARNING (MainThread) [homeassistant.config_entries] Config entry for kodi not ready yet. Retrying in 80 seconds

Thank you for your help!

[csacre]

Here is the corresponding signature I found in the previous zigate file of Doudz ;-)

    {

"addr": "664e", "discovery": "auto-discovered", "endpoints": [ { "clusters": [ { "attributes": [ { "attribute": 5, "data": "lumi.sensor_switch", "name": "type", "type": "str", "value": "lumi.sensor_switch" }, { "attribute": 1, "data": 10, "name": "application_version", "value": 10 }, { "attribute": 65282, "data": "100121c40b21a813240a00000104217c022060", "name": "battery_voltage", "type": "float", "unit": "V", "value": 3.012 } ], "cluster": 0 }, { "attributes": [ { "attribute": 0, "data": true, "name": "onoff", "type": "bool", "value": true }, { "attribute": 32768, "data": 0, "expire": 2, "name": "multiclick", "type": "int", "value": 0 } ], "cluster": 6 } ], "device": 0, "endpoint": 1, "in_clusters": [], "out_clusters": [], "profile": 0 } ], "generictype": "", "info": { "addr": "664e", "ieee": "00158d0004081a14", "last_seen": "2020-11-20 17:22:19", "lqi": 66, "mac_capability": "10000000" }, "name": "" }, { "addr": "63b9", "discovery": "auto-discovered", "endpoints": [ { "clusters": [ { "attributes": [ { "attribute": 5, "data": "lumi.sensor_switch", "name": "type", "type": "str", "value": "lumi.sensor_switch" }, { "attribute": 1, "data": 10, "name": "application_version", "value": 10 }, { "attribute": 65282, "data": "100121ce0b21a81324010000000021ce002066", "name": "battery_voltage", "type": "float", "unit": "V", "value": 3.022 } ], "cluster": 0 }, { "attributes": [ { "attribute": 0, "data": true, "name": "onoff", "type": "bool", "value": true }, { "attribute": 32768, "data": 0, "expire": 2, "name": "multiclick", "type": "int", "value": 0 } ], "cluster": 6 } ], "device": 0, "endpoint": 1, "in_clusters": [], "out_clusters": [], "profile": 0 } ], "generictype": "", "info": { "addr": "63b9", "ieee": "00158d0004026add", "last_seen": "2020-11-20 17:07:38", "lqi": 54, "mac_capability": "10000000" }, "name": "" }, { "addr": "a679", "discovery": "", "endpoints": [ { "clusters": [ { "attributes": [ { "attribute": 5, "data": "lumi.sensor_switch", "name": "type", "type": "str", "value": "lumi.sensor_switch" }, { "attribute": 1, "data": 10, "name": "application_version", "value": 10 }, { "attribute": 65282, "data": "100121f60b21a8132401000000002108022068", "name": "battery_voltage", "type": "float", "unit": "V", "value": 3.062 } ], "cluster": 0 }, { "attributes": [ { "attribute": 0, "data": true, "name": "onoff", "type": "bool", "value": true }, { "attribute": 32768, "data": 0, "expire": 2, "name": "multiclick", "type": "int", "value": 0 } ], "cluster": 6 } ], "device": 0, "endpoint": 1, "in_clusters": [], "out_clusters": [], "profile": 0 } ], "generictype": "", "info": { "addr": "a679", "ieee": "00158d000360fda3", "last_seen": "2020-11-20 17:29:19", "lqi": 72, "mac_capability": "10000000" }, "name": "" }