ZHA - Zigate - Philips Hue bulb

[Adorem]

Home Assistant release with the issue:

0.100.0b1

Last working Home Assistant release (if known):

Operating environment (Hass.io/Docker/Windows/etc.):

Hass.io RPI HassOS 3.5 Zigate with FW 3.1a

Integration:

https://www.home-assistant.io/integrations/zha

Description of problem: I first add the new integration zha. Then I go to ZHA and clic on: ADD DEVICES Then I switch on a Philips bulb to try to add it but the device seems not correctly recognized.

I don't know if my problem is related to my configuration, the zigate, ZHA, zigpy-zigate, zigpy, ...

FYI I have also open an issue here: https://github.com/doudz/zigpy-zigate/issues/4#issue-484947538

Problem-relevant configuration.yaml entries and (fill out even if it seems unimportant):

NA, config done with Integration.

Traceback (if applicable):

2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] Broadcast not implemented.
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x49 b'fffc3c00'
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00I\x00\x04r\xff\xfc<\x00'
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10I\x02\x10\x02\x14r\xff\xfc<\x02\x10'
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005ed0021004900
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00210049' LQI:0
2019-10-06 11:12:00 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 33, 73, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 004d000c671a1700178801030c0e3a8e00
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x4d b'1a1700178801030c0e3a8e' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0x1a17, 00:17:88:01:03:0c:0e:3a, 142]
2019-10-06 11:12:07 INFO (MainThread) [zigpy.application] Device 0x1a17 (00:17:88:01:03:0c:0e:3a) joined the network
2019-10-06 11:12:07 INFO (MainThread) [zigpy.device] [0x1a17] Requesting 'Node Descriptor'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.device] [0x1a17] Extending timeout for 0x02 request
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0002, 0, 0, 2, b'\x02\x17\x1a', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a1700000002000000000302171a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f;\x02\x1a\x17\x00\x00\x00\x02\x00\x00\x00\x00\x03\x02\x17\x1a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f;\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10\x02\x12\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x12\x17\x1a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001adc00000000130000021a1702fffd00171a3a0e0c03018817008e7e
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000000130000021a1702fffd00171a3a0e0c03018817008e' LQI:126
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 19, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0xfffd>, b'\x00\x17\x1a:\x0e\x0c\x03\x01\x88\x17\x00\x8e']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.zdo] [0x1a17:zdo] ZDO request 0x0013: [0x1a17, 00:17:88:01:03:0c:0e:3a, 142]
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 870100037a0000ff
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8701 b'0000' LQI:255
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0]
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000053e008e053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'008e0530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 142, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001ff000000080020000021a170200000200171a01408e0b10472d0000002d00007e
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080020000021a170200000200171a01408e0b10472d0000002d0000' LQI:126
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32770, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x02\x00\x17\x1a\x01@\x8e\x0b\x10G-\x00\x00\x00-\x00\x00']
2019-10-06 11:12:07 INFO (MainThread) [zigpy.device] [0x1a17] Node Descriptor: <Optional byte1=1 byte2=64 mac_capability_flags=142 manufacturer_code=4107 maximum_buffer_size=71 maximum_incoming_transfer_size=45 server_mask=0 maximum_outgoing_transfer_size=45 descriptor_capability_field=0>
2019-10-06 11:12:07 INFO (MainThread) [zigpy.device] [0x1a17] Discovering endpoints
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0005, 0, 0, 4, b'\x04\x17\x1a', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a1700000005000000000304171a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x0f:\x02\x1a\x17\x00\x00\x00\x05\x00\x00\x00\x00\x03\x04\x17\x1a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x02\x1f:\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10\x02\x15\x02\x10\x02\x10\x02\x10\x02\x10\x02\x13\x02\x14\x17\x1a'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000053f008f053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'008f0530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 143, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200156900000080050000021a170200000400171a020bf284
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080050000021a170200000400171a020bf2' LQI:132
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32773, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x04\x00\x17\x1a\x02\x0b\xf2']
2019-10-06 11:12:07 INFO (MainThread) [zigpy.device] [0x1a17] Discovered endpoints: [11, 242]
2019-10-06 11:12:07 INFO (MainThread) [zigpy.endpoint] [0x1a17:11] Discovering endpoint information
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0004, 0, 0, 6, b'\x06\x17\x1a\x0b', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a1700000004000000000406171a0b'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x10*\x02\x1a\x17\x00\x00\x00\x04\x00\x00\x00\x00\x04\x06\x17\x1a\x0b'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x10*\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10\x02\x14\x02\x10\x02\x10\x02\x10\x02\x10\x02\x14\x02\x16\x17\x1a\x02\x1b'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005200090053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00900530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 144, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002002b2200000080040000021a170200000600171a180b5ec000010207000003000400050006000800001001190084
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080040000021a170200000600171a180b5ec0000102070000030004000500060008000010011900' LQI:132
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32772, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x06\x00\x17\x1a\x18\x0b^\xc0\x00\x01\x02\x07\x00\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10\x01\x19\x00']
2019-10-06 11:12:07 INFO (MainThread) [zigpy.endpoint] [0x1a17:11] Discovered endpoint information: <SimpleDescriptor endpoint=11 profile=49246 device_type=256 device_version=2 input_clusters=[0, 3, 4, 5, 6, 8, 4096] output_clusters=[25]>
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 0, 11, 11, 8, b'\x00\x08\x00\x04\x00\x05\x00', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b0000010400000700080004000500'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x13"\x02\x1a\x17\x0b\x0b\x00\x00\x01\x04\x00\x00\x07\x00\x08\x00\x04\x00\x05\x00'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x13"\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x17\x02\x10\x02\x18\x02\x10\x02\x14\x02\x10\x02\x15\x02\x10'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000513a300053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a3000530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [163, 0, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x08, on endpoint id 11 cluster 0x0000: Message send failure %s
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 0, 11, 11, 10, b'\x00\n\x00\x04\x00', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b00000104000005000a000400'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11%\x02\x1a\x17\x0b\x0b\x00\x00\x01\x04\x00\x00\x05\x00\n\x00\x04\x00'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11%\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x1a\x02\x10\x02\x14\x02\x10'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000513a300053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a3000530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [163, 0, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x0a, on endpoint id 11 cluster 0x0000: Message send failure %s
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 0, 11, 11, 12, b'\x00\x0c\x00\x05\x00', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b00000104000005000c000500'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11"\x02\x1a\x17\x0b\x0b\x00\x00\x01\x04\x00\x00\x05\x00\x0c\x00\x05\x00'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11"\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x02\x1c\x02\x10\x02\x15\x02\x10'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000513a300053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a3000530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [163, 0, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x0c, on endpoint id 11 cluster 0x0000: Message send failure %s
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.endpoint] [0x1a17:11] Manufacturer: None
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy.endpoint] [0x1a17:11] Model: None
2019-10-06 11:12:07 INFO (MainThread) [zigpy.endpoint] [0x1a17:242] Discovering endpoint information
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0004, 0, 0, 14, b'\x0e\x17\x1a\xf2', True, False)
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170000000400000000040e171af2'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x10\xdb\x02\x1a\x17\x00\x00\x00\x04\x00\x00\x00\x00\x04\x0e\x17\x1a\xf2'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x10\xdb\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10\x02\x14\x02\x10\x02\x10\x02\x10\x02\x10\x02\x14\x02\x1e\x17\x1a\xf2'
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005210091053000
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00910530' LQI:0
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 145, 1328, b'']
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8002001fb700000080040000021a170200000e00171a0cf2e0a16100000121000121007e
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080040000021a170200000e00171a0cf2e0a1610000012100012100' LQI:126
2019-10-06 11:12:07 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32772, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x0e\x00\x17\x1a\x0c\xf2\xe0\xa1a\x00\x00\x01!\x00\x01!\x00']
2019-10-06 11:12:07 INFO (MainThread) [zigpy.endpoint] [0x1a17:242] Discovered endpoint information: <SimpleDescriptor endpoint=242 profile=41440 device_type=97 device_version=0 input_clusters=[33] output_clusters=[33]>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for None None (00:17:88:01:03:0c:0e:3a)
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zigpy.quirks.smartthings.SmartthingsMultiPurposeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.gledopto.soposhgu10.SoposhGU10'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {11, 13} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.lutron.lzl4bwhl01remote.LutronLZL4BWHL01Remote2'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.netvox.z308e3ed.Z308E3ED'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.osram.a19twhite.A19TunableWhite'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {3} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.philips.rwl021.PhilipsRWL021'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1, 2} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.smartthings.tag_v4.SmartThingsTagV4'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee3_io.XBee3Sensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee_io.XbeeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xiaomi.mija.smoke.MijiaHoneywellSmokeDetectorSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zigpy.quirks.smartthings.SmartthingsMultiPurposeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.gledopto.soposhgu10.SoposhGU10'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {11, 13} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.lutron.lzl4bwhl01remote.LutronLZL4BWHL01Remote2'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.netvox.z308e3ed.Z308E3ED'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.osram.a19twhite.A19TunableWhite'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {3} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.philips.rwl021.PhilipsRWL021'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1, 2} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.smartthings.tag_v4.SmartThingsTagV4'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee3_io.XBee3Sensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee_io.XbeeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xiaomi.mija.smoke.MijiaHoneywellSmokeDetectorSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zigpy.quirks.smartthings.SmartthingsMultiPurposeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.gledopto.soposhgu10.SoposhGU10'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {11, 13} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.lutron.lzl4bwhl01remote.LutronLZL4BWHL01Remote2'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.netvox.z308e3ed.Z308E3ED'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.osram.a19twhite.A19TunableWhite'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {3} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.philips.rwl021.PhilipsRWL021'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1, 2} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.smartthings.tag_v4.SmartThingsTagV4'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee3_io.XBee3Sensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee_io.XbeeSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xiaomi.mija.smoke.MijiaHoneywellSmokeDetectorSensor'>
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {1} {242, 11}
2019-10-06 11:12:08 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0x1a17:00:17:88:01:03:0c:0e:3a entering async_device_initialized - is_new_join: True
2019-10-06 11:12:08 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0x1a17:00:17:88:01:03:0c:0e:3a has joined the ZHA zigbee network
2019-10-06 11:12:08 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): started configuration
2019-10-06 11:12:08 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:ZDO](unk_model): channel: 'async_configure' stage succeeded
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0021, 0, 0, 16, b'\x10\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x08\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01', True, False)
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170000002100000000161000178801030c0e3a0b08000300158d0001ed44a801'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00"\x03\x02\x1a\x17\x00\x00\x00!\x00\x00\x00\x00\x16\x10\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x08\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10"\x02\x13\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10!\x02\x10\x02\x10\x02\x10\x02\x10\x16\x10\x02\x10\x17\x88\x02\x11\x02\x13\x02\x1c\x02\x1e:\x02\x1b\x02\x18\x02\x10\x02\x13\x02\x10\x15\x8d\x02\x10\x02\x11\xedD\xa8\x02\x11'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0021, 0, 0, 18, b'\x12\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x06\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01', True, False)
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170000002100000000161200178801030c0e3a0b06000300158d0001ed44a801'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00"\x0f\x02\x1a\x17\x00\x00\x00!\x00\x00\x00\x00\x16\x12\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x06\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10"\x02\x1f\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10!\x02\x10\x02\x10\x02\x10\x02\x10\x16\x12\x02\x10\x17\x88\x02\x11\x02\x13\x02\x1c\x02\x1e:\x02\x1b\x02\x16\x02\x10\x02\x13\x02\x10\x15\x8d\x02\x10\x02\x11\xedD\xa8\x02\x11'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0021, 0, 0, 20, b'\x14\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x00\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01', True, False)
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170000002100000000161400178801030c0e3a0b00000300158d0001ed44a801'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00"\x0f\x02\x1a\x17\x00\x00\x00!\x00\x00\x00\x00\x16\x14\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x00\x00\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10"\x02\x1f\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10!\x02\x10\x02\x10\x02\x10\x02\x10\x16\x14\x02\x10\x17\x88\x02\x11\x02\x13\x02\x1c\x02\x1e:\x02\x1b\x02\x10\x02\x10\x02\x13\x02\x10\x15\x8d\x02\x10\x02\x11\xedD\xa8\x02\x11'
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005220092053000
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00920530' LQI:0
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 146, 1328, b'']
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200102e00000080210000021a17020000108484
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080210000021a170200001084' LQI:132
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32801, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x10\x84']
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005230093053000
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00930530' LQI:0
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 147, 1328, b'']
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800200102c00000080210000021a17020000128484
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8002 b'00000080210000021a170200001284' LQI:132
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 32801, 0, 0, <Address address_mode=ADDRESS_MODE.NWK address=0x1a17>, <Address address_mode=ADDRESS_MODE.NWK address=0x0000>, b'\x12\x84']
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:08 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:11 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x10, on endpoint id 0 cluster 0x0021: ZiGate doesn't answer to command
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: Failed to bind 'level' cluster: [0x1a17:0:0x0021]: Message send failure
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 8, 11, 11, 22, b'\x00\x16\x06\x00\x00\x00 \x01\x00\x84\x03\x01', True, False)
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b0008010400000c001606000000200100840301'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x18\x94\x02\x1a\x17\x0b\x0b\x00\x08\x01\x04\x00\x00\x0c\x00\x16\x06\x00\x00\x00 \x01\x00\x84\x03\x01'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x18\x94\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x1c\x02\x10\x16\x02\x16\x02\x10\x02\x10\x02\x10 \x02\x11\x02\x10\x84\x02\x13\x02\x11'
2019-10-06 11:12:11 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x12, on endpoint id 0 cluster 0x0021: ZiGate doesn't answer to command
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: Failed to bind 'on_off' cluster: [0x1a17:0:0x0021]: Message send failure
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 6, 11, 11, 24, b'\x00\x18\x06\x00\x00\x00\x10\x00\x00\x84\x03', True, False)
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b0006010400000b0018060000001000008403'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x17\xac\x02\x1a\x17\x0b\x0b\x00\x06\x01\x04\x00\x00\x0b\x00\x18\x06\x00\x00\x00\x10\x00\x00\x84\x03'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x17\xac\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x1b\x02\x10\x18\x02\x16\x02\x10\x02\x10\x02\x10\x10\x02\x10\x02\x10\x84\x02\x13'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x18, on endpoint id 11 cluster 0x0006: Message send failure %s
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: failed to set reporting for 'on_off' attr on 'on_off' cluster: [0x1a17:11:0x0006]: Message send failure
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: finished channel configuration
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: channel: 'async_configure' stage succeeded
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 0, 0x0021, 0, 0, 26, b'\x1a\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x00\x10\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01', True, False)
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170000002100000000161a00178801030c0e3a0b00100300158d0001ed44a801'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00"\x11\x02\x1a\x17\x00\x00\x00!\x00\x00\x00\x00\x16\x1a\x00\x17\x88\x01\x03\x0c\x0e:\x0b\x00\x10\x03\x00\x15\x8d\x00\x01\xedD\xa8\x01'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10"\x11\x02\x12\x1a\x17\x02\x10\x02\x10\x02\x10!\x02\x10\x02\x10\x02\x10\x02\x10\x16\x1a\x02\x10\x17\x88\x02\x11\x02\x13\x02\x1c\x02\x1e:\x02\x1b\x02\x10\x10\x02\x13\x02\x10\x15\x8d\x02\x10\x02\x11\xedD\xa8\x02\x11'
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:11 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x1a, on endpoint id 0 cluster 0x0021: Message send failure %s
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x1000]: Failed to bind 'lightlink' cluster: [0x1a17:0:0x0021]: Message send failure
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x1000]: finished channel configuration
2019-10-06 11:12:11 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x1000]: channel: 'async_configure' stage succeeded
2019-10-06 11:12:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: Failed to bind 'basic' cluster: 
2019-10-06 11:12:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: finished channel configuration
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 0, 11, 11, 28, b'\x00\x1c\x00\x07\x00', True, False)
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b00000104000005001c000700'
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x110\x02\x1a\x17\x0b\x0b\x00\x00\x01\x04\x00\x00\x05\x00\x1c\x00\x07\x00'
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x110\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x1c\x02\x10\x02\x17\x02\x10'
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:13 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x1c, on endpoint id 11 cluster 0x0000: Message send failure %s
2019-10-06 11:12:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: initializing channel: from_cache: False
2019-10-06 11:12:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: channel: 'async_configure' stage succeeded
2019-10-06 11:12:14 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:14 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x16, on endpoint id 11 cluster 0x0008: ZiGate doesn't answer to command
2019-10-06 11:12:14 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: failed to set reporting for 'current_level' attr on 'level' cluster: [0x1a17:11:0x0008]: Message send failure
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: finished channel configuration
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: channel: 'async_configure' stage succeeded
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): completed configuration
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): stored in registry: ZhaDeviceEntry(name='unk_manufacturer unk_model', ieee='00:17:88:01:03:0c:0e:3a', last_seen=1570353128.6789598)
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): started initialization
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:ZDO](unk_model): entry loaded from storage: ZhaDeviceEntry(name='unk_manufacturer unk_model', ieee='00:17:88:01:03:0c:0e:3a', last_seen=1570353128.6789598)
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:ZDO](unk_model): channel: 'async_initialize' stage succeeded
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 8, 11, 11, 30, b'\x00\x1e\x00\x00\x00', True, False)
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b00080104000005001e000000'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11=\x02\x1a\x17\x0b\x0b\x00\x08\x01\x04\x00\x00\x05\x00\x1e\x00\x00\x00'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11=\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x18\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10\x1e\x02\x10\x02\x10\x02\x10'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 6, 11, 11, 32, b'\x00 \x00\x00\x00', True, False)
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b000601040000050020000000'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\r\x02\x1a\x17\x0b\x0b\x00\x06\x01\x04\x00\x00\x05\x00 \x00\x00\x00'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\x02\x1d\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10 \x02\x10\x02\x10\x02\x10'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 0, 11, 11, 34, b'\x00"\x00\x07\x00', True, False)
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b000001040000050022000700'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\x0e\x02\x1a\x17\x0b\x0b\x00\x00\x01\x04\x00\x00\x05\x00"\x00\x07\x00'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\x02\x1e\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10"\x02\x10\x02\x17\x02\x10'
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: attempting to update onoff state - from cache: False
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] request (0x1a17, 260, 6, 11, 11, 36, b'\x00$\x00\x00\x00', True, False)
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x530 b'021a170b0b000601040000050024000000'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x050\x00\x11\t\x02\x1a\x17\x0b\x0b\x00\x06\x01\x04\x00\x00\x05\x00$\x00\x00\x00'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x150\x02\x10\x11\x02\x19\x02\x12\x1a\x17\x02\x1b\x02\x1b\x02\x10\x02\x16\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10$\x02\x10\x02\x10\x02\x10'
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x24, on endpoint id 11 cluster 0x0006: Message send failure %s
2019-10-06 11:12:15 DEBUG (MainThread) [homeassistant.components.zha.entity] light.unk_manufacturer_unk_model_01881700_11: polling current state
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8000000516a600053000
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000530' LQI:0
2019-10-06 11:12:15 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 1328, b'']
2019-10-06 11:12:18 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:18 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x1e, on endpoint id 11 cluster 0x0008: ZiGate doesn't answer to command
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: initializing channel: from_cache: False
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0008]: channel: 'async_initialize' stage succeeded
2019-10-06 11:12:18 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:18 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x20, on endpoint id 11 cluster 0x0006: ZiGate doesn't answer to command
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: initializing channel: from_cache: False
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0006]: channel: 'async_initialize' stage succeeded
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x1000]: initializing channel: from_cache: False
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x1000]: channel: 'async_initialize' stage succeeded
2019-10-06 11:12:18 WARNING (MainThread) [zigpy_zigate.api] No response to command 0x0530
2019-10-06 11:12:18 DEBUG (MainThread) [zigpy.device] [0x1a17] Delivery error for seq # 0x22, on endpoint id 11 cluster 0x0000: ZiGate doesn't answer to command
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: initializing channel: from_cache: False
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.channels] [0x1a17:11:0x0000]: channel: 'async_initialize' stage succeeded
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): power source: Mains
2019-10-06 11:12:18 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x1a17](unk_model): completed initialization
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] Broadcast not implemented.
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x49 b'fffc3c00'
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00I\x00\x04r\xff\xfc<\x00'
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10I\x02\x10\x02\x14r\xff\xfc<\x02\x10'
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 800000056aa600004900
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'a6000049' LQI:0
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [166, 0, 73, b'']
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x11 b''
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00\x11\x00\x00\x11'
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10\x11\x02\x10\x02\x10\x11'
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80000005940000001100
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8000 b'00000011' LQI:0
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [0, 0, 17, b'']
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 8024000d3f01000000158d0001ed44a80f00
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8024 b'01000000158d0001ed44a80f' LQI:0
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.zigbee.application] zigate_callback_handler [1, 0x0000, 00:15:8d:00:01:ed:44:a8, 15]
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.uart] Frame received: 80060002850100
2019-10-06 11:14:11 DEBUG (MainThread) [zigpy_zigate.api] data received 0x8006 b'01' LQI:0
2019-10-06 11:14:12 ERROR (MainThread) [zigpy_zigate.api] Received unhandled response 0x8006

Additional information:

[probot-home-assistant[bot]]

Hey there @dmulcahey, @adminiuga, mind taking a look at this issue as its been labeled with a integration (zha) you are listed as a codeowner for? Thanks!

[Adminiuga]

tracking this in https://github.com/doudz/zigpy-zigate/issues/4