Skip to content

Instantly share code, notes, and snippets.

@iantrich

iantrich/dining.md

Last active August 9, 2020 03:56
Show Gist options
  • Save iantrich/db28e6529e39ae8b8196b1689668e135 to your computer and use it in GitHub Desktop.
Save iantrich/db28e6529e39ae8b8196b1689668e135 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
dining.md 
motion: 0xccc5, 3326-L
dining 1: 0xd949, Ecosmart-ZBT-A19-CCT-Bulb
dining 2: 0x9a56, Ecosmart-ZBT-A19-CCT-Bulb
dining 3: 0xae3e, Ecosmart-ZBT-A19-CCT-Bulb
dining group: 0x0010

In this test, it took around 2-3 seconds for the lights to turn on and they sort of fade in as well after that. Here's what stood out to me:

Initial message
2020-08-08 22:36:21.612 DEBUG (MainThread) [bellows.zigbee.application] Received incomingRouteRecordHandler frame with [0xccc5, 00:0d:6f:00:0b:63:6f:d0, 255, -67, [0xd949]]
Motion event: 66ms
2020-08-08 22:36:21.678 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=binary_sensor.dining_room_motion, old_state=<state binary_sensor.dining_room_motion=off; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:30:25.053218-05:00>, new_state=<state binary_sensor.dining_room_motion=on; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:36:21.678395-05:00>>
Service call to turn on light: 17ms, 83ms total
2020-08-08 22:36:21.695 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=brightness_pct=20, entity_id=light.dining_room>

According to these logs, there is absolutely no delay in the receiving of the motion, processing of the autmoation and the firing of the service. Even the reporting of state changes looks quick as well for the group and each individual bulbs. Other logs are Greek to me.

2020-08-08 22:36:21.612 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received: b'c5ccd06f630b006f0d00ffbd0149d9'
2020-08-08 22:36:21.612 DEBUG (MainThread) [bellows.zigbee.application] Received incomingRouteRecordHandler frame with [0xccc5, 00:0d:6f:00:0b:63:6f:d0, 255, -67, [0xd949]]
2020-08-08 22:36:21.613 DEBUG (MainThread) [bellows.zigbee.application] Processing route record request: (0xccc5, 00:0d:6f:00:0b:63:6f:d0, 255, -67, [0xd949])
2020-08-08 22:36:21.638 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'55d6b1ed542e14b25a954b65ab55921b63f28ac412316a83cdcc6089dd4c4aa0ebecac6efd277e'
2020-08-08 22:36:21.638 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:21.638 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401000301014001000052ffbcad6fffff0d08300a03002132750700217201'
2020-08-08 22:36:21.638 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=82>, 255, -68, 0x6fad, 255, 255, b'\x080\n\x03\x00!2u\x07\x00!r\x01']
2020-08-08 22:36:21.639 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=48 command_id=Command.Report_Attributes>
2020-08-08 22:36:21.639 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] ZCL request 0x000a: [[<Attribute attrid=3 value=<TypeValue type=uint16_t, value=30002>>, <Attribute attrid=7 value=<TypeValue type=uint16_t, value=370>>]]
2020-08-08 22:36:21.639 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] Attribute report received: current_x=30002, color_temperature=370
2020-08-08 22:36:21.659 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x6fad, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=48>, 135, b'\x180\x0b\n\x00')
2020-08-08 22:36:21.660 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'56d7219c54877ab658944924ab1593499c7d5ea0aef5fe6c81fd3a277e'
2020-08-08 22:36:21.675 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'65d6b1ed542e14b25c954b65ab55929263f5e26712316e8298c64589fc7e3fa7ef0da67e'
2020-08-08 22:36:21.675 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:21.676 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'76d7a19c54e9a9bd7e'
2020-08-08 22:36:21.676 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:21.676 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'0004010005010140010000dbffbbc5ccffff0909650026000000000004'
2020-08-08 22:36:21.676 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=1280 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=219>, 255, -69, 0xccc5, 255, 255, b'\te\x00&\x00\x00\x00\x00\x00']
2020-08-08 22:36:21.676 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=101 command_id=0>
2020-08-08 22:36:21.676 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] ZCL request 0x0000: [<ZoneStatus.Restore_reports|Tamper|Alarm_2: 38>, <bitmap8.0: 0>, 0, 0]
2020-08-08 22:36:21.677 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] No handler for cluster command 0
2020-08-08 22:36:21.677 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xccc5:1:0x0500]: Updated alarm state: ZoneStatus.Alarm_2
2020-08-08 22:36:21.678 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=binary_sensor.dining_room_motion, old_state=<state binary_sensor.dining_room_motion=off; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:30:25.053218-05:00>, new_state=<state binary_sensor.dining_room_motion=on; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:36:21.678395-05:00>>
2020-08-08 22:36:21.678 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00c3'
2020-08-08 22:36:21.695 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=light, service=turn_on, service_data=brightness_pct=20, entity_id=light.dining_room>
2020-08-08 22:36:21.696 DEBUG (MainThread) [bellows.ezsp] Send command sendMulticast: (<EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=256 groupId=16 sequence=136>, 0, 3, 137, b'\x01\x88\x043\x00\x00')
2020-08-08 22:36:21.697 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'60d42190502b1db258954a24ba557d3a499fc721aa65ca548bfd4f7f7e'
2020-08-08 22:36:21.706 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'07d4a19054ee42d57e'
2020-08-08 22:36:21.706 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:21.707 DEBUG (MainThread) [bellows.ezsp] Application frame 56 (sendMulticast) received: b'00c4'
2020-08-08 22:36:21.732 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'17d4b1ed542e14b459954b65ab559206678e19051231608392cc6389ec7faf617e'
2020-08-08 22:36:21.732 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:21.732 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'00040106000101400100004ffbc03eaeffff07086f0a00001001'
2020-08-08 22:36:21.733 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=79>, 251, -64, 0xae3e, 255, 255, b'\x08o\n\x00\x00\x10\x01']
2020-08-08 22:36:21.733 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=111 command_id=Command.Report_Attributes>
2020-08-08 22:36:21.733 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] ZCL request 0x000a: [[<Attribute attrid=0 value=<TypeValue type=Bool, value=Bool.true>>]]
2020-08-08 22:36:21.733 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] Attribute report received: on_off=1
2020-08-08 22:36:21.745 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.dining_room_3, old_state=<state light.dining_room_3=off; min_mireds=153, max_mireds=370, off_brightness=None, friendly_name=Dining Room 3, supported_features=43 @ 2020-08-08T22:30:27.561160-05:00>, new_state=<state light.dining_room_3=on; min_mireds=153, max_mireds=370, brightness=51, color_temp=370, off_brightness=None, friendly_name=Dining Room 3, supported_features=43 @ 2020-08-08T22:36:21.745524-05:00>>
2020-08-08 22:36:21.745 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xae3e, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=111>, 138, b'\x18o\x0b\n\x00')
2020-08-08 22:36:21.746 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'72d5219c5414bbb658924a24ab1593499c21adaef5a16c81fdcd607e'
2020-08-08 22:36:21.750 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.dining_room, old_state=<state light.dining_room=off; min_mireds=153, max_mireds=370, off_brightness=None, friendly_name=Dining Room, icon=mdi:ceiling-light, supported_features=43 @ 2020-08-08T22:30:27.326338-05:00>, new_state=<state light.dining_room=on; min_mireds=153, max_mireds=370, brightness=51, color_temp=370, off_brightness=None, friendly_name=Dining Room, icon=mdi:ceiling-light, supported_features=43 @ 2020-08-08T22:36:21.750548-05:00>>
2020-08-08 22:36:21.755 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.lights, old_state=<state light.lights=on; min_mireds=153, max_mireds=588, effect_list=['Facebook', 'Christmas', 'Stop', 'Strobe color', 'LSD', 'WhatsApp', 'Police', 'Random Loop', 'Strobe epilepsy!', 'Disco', 'Alarm', 'Twitter', 'Slow Temp', 'Fast Random Loop', 'Slowdown', 'RGB', 'Police2'], brightness=60, color_temp=230, hs_color=(0.0, 50.0), rgb_color=(255, 127, 127), xy_color=(0.526, 0.313), entity_id=['light.family_room', 'light.garage', 'light.landing', 'light.main_bath', 'light.office', 'light.kitchen', 'light.kitchen_cabinets', 'light.living_room', 'light.living_room_front_entrance', 'light.living_room_lamp', 'light.dining_room', 'light.sunroom', 'light.hallway', 'light.hallway_stairs', 'light.girls_bath', 'light.girls_room', 'light.master', 'light.master_bath', 'light.master_closet'], friendly_name=Lights, supported_features=63 @ 2020-08-08T22:29:32.048564-05:00>, new_state=<state light.lights=on; min_mireds=153, max_mireds=588, effect_list=['Facebook', 'Christmas', 'Stop', 'Strobe color', 'LSD', 'WhatsApp', 'Police', 'Random Loop', 'Strobe epilepsy!', 'Disco', 'Alarm', 'Twitter', 'Slow Temp', 'Fast Random Loop', 'Slowdown', 'RGB', 'Police2'], brightness=58, color_temp=276, hs_color=(0.0, 50.0), rgb_color=(255, 127, 127), xy_color=(0.526, 0.313), entity_id=['light.family_room', 'light.garage', 'light.landing', 'light.main_bath', 'light.office', 'light.kitchen', 'light.kitchen_cabinets', 'light.living_room', 'light.living_room_front_entrance', 'light.living_room_lamp', 'light.dining_room', 'light.sunroom', 'light.hallway', 'light.hallway_stairs', 'light.girls_bath', 'light.girls_room', 'light.master', 'light.master_bath', 'light.master_closet'], friendly_name=Lights, supported_features=63 @ 2020-08-08T22:29:32.048564-05:00>>
2020-08-08 22:36:21.762 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'20d5a19c54ef708d7e'
2020-08-08 22:36:21.762 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:21.776 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00c5'
2020-08-08 22:36:21.783 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'30d5b1ed542e14b459954b65ab55927763f271311231608392cc6389ec7f3b62817e'
2020-08-08 22:36:21.783 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:21.783 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'40d5b19754877ab658944924ab1593499c8da0abed30e07e'
2020-08-08 22:36:21.783 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:21.783 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'00040106000101400100003effbc569affff07086f0a0000100104'
2020-08-08 22:36:21.784 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=62>, 255, -68, 0x9a56, 255, 255, b'\x08o\n\x00\x00\x10\x01']
2020-08-08 22:36:21.784 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=111 command_id=Command.Report_Attributes>
2020-08-08 22:36:21.784 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0006] ZCL request 0x000a: [[<Attribute attrid=0 value=<TypeValue type=Bool, value=Bool.true>>]]
2020-08-08 22:36:21.785 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0006] Attribute report received: on_off=1
2020-08-08 22:36:21.799 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'50d5b1ed542e14b459954b65ab55920f63f26e72123160838bcc6389ec7f3db00b7e'
2020-08-08 22:36:21.799 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:21.807 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00ad6f04010003010140010000c3870000'
2020-08-08 22:36:21.807 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 28589, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=195>, 135, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:21.808 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401060001014001000046ffbc49d9ffff0708760a0000100102'
2020-08-08 22:36:21.808 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=70>, 255, -68, 0xd949, 255, 255, b'\x08v\n\x00\x00\x10\x01']
2020-08-08 22:36:21.808 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=118 command_id=Command.Report_Attributes>
2020-08-08 22:36:21.808 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0006] ZCL request 0x000a: [[<Attribute attrid=0 value=<TypeValue type=Bool, value=Bool.true>>]]
2020-08-08 22:36:21.809 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0006] Attribute report received: on_off=1
2020-08-08 22:36:21.816 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'60d5b1ed542e14b25a954b65ab55921a63f28ac412316f83cccc6789dd8257b28c7e'
2020-08-08 22:36:21.817 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:21.830 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.dining_room_2, old_state=<state light.dining_room_2=off; min_mireds=153, max_mireds=370, off_brightness=None, friendly_name=Dining Room 2, supported_features=43 @ 2020-08-08T22:30:27.387634-05:00>, new_state=<state light.dining_room_2=on; min_mireds=153, max_mireds=370, brightness=51, color_temp=370, off_brightness=None, friendly_name=Dining Room 2, supported_features=43 @ 2020-08-08T22:36:21.830457-05:00>>
2020-08-08 22:36:21.831 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x9a56, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=111>, 139, b'\x18o\x0b\n\x00')
2020-08-08 22:36:21.832 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'07da219c547c8fb658924a24ab1593499c21acaef5a16c81fd96a27e'
2020-08-08 22:36:21.833 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401000301014001000053ffbcad6fffff0808310a040021fc68'
2020-08-08 22:36:21.834 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=83>, 255, -68, 0x6fad, 255, 255, b'\x081\n\x04\x00!\xfch']
2020-08-08 22:36:21.835 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=49 command_id=Command.Report_Attributes>
2020-08-08 22:36:21.836 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] ZCL request 0x000a: [[<Attribute attrid=4 value=<TypeValue type=uint16_t, value=26876>>]]
2020-08-08 22:36:21.836 DEBUG (MainThread) [zigpy.zcl] [0x6fad:1:0x0300] Attribute report received: current_y=26876
2020-08-08 22:36:21.842 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'71daa19c54ec10237e'
2020-08-08 22:36:21.843 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:21.857 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.dining_room_1, old_state=<state light.dining_room_1=off; min_mireds=153, max_mireds=370, off_brightness=None, friendly_name=Dining Room 1, supported_features=43 @ 2020-08-08T22:30:27.313173-05:00>, new_state=<state light.dining_room_1=on; min_mireds=153, max_mireds=370, brightness=51, color_temp=370, off_brightness=None, friendly_name=Dining Room 1, supported_features=43 @ 2020-08-08T22:36:21.857271-05:00>>
2020-08-08 22:36:21.866 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00c6'
2020-08-08 22:36:21.870 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'01dab197547c8fb658924a24ab1593499c88acabedf1647e'
2020-08-08 22:36:21.870 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:21.892 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00569a04010600010140010000c68b0000'
2020-08-08 22:36:21.892 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 39510, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=198>, 139, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:21.897 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xd949, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=118>, 140, b'\x18v\x0b\n\x00')
2020-08-08 22:36:21.898 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'7d31db219c5463ccb658924a24ab1593499c38abaef5b86c81fd4f527e'
2020-08-08 22:36:21.911 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'12dba19c54ed3bab7e'
2020-08-08 22:36:21.911 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:21.913 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00c7'
2020-08-08 22:36:21.918 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x6fad, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=49>, 141, b'\x181\x0b\n\x00')
2020-08-08 22:36:21.921 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'22d8219c54877ab658944924ab1593499c7faaaef5ff6c81fd90937e'
2020-08-08 22:36:21.939 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'23d8a59c54e2844b7e'
2020-08-08 22:36:21.939 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:21.941 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'33dbb1975463ccb658924a24ab1593499c89ababed9c747e'
2020-08-08 22:36:21.943 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:21.943 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00c8'
2020-08-08 22:36:21.949 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'0049d904010600010140010000c78c0000'
2020-08-08 22:36:21.950 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 55625, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=199>, 140, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:22.037 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'43d8b19754877ab658944924ab1593499c86aaabedd9c37e'
2020-08-08 22:36:22.038 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:22.043 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00ad6f04010003010140010000c88d0000'
2020-08-08 22:36:22.043 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 28589, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=200>, 141, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:22.655 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'53d8b19757d7eab6589c4a24555993599c8aaeabedb9cf7e'
2020-08-08 22:36:22.656 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:22.657 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'03fdff0401080001ff0c011000c4890000'
2020-08-08 22:36:22.657 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_MULTICAST: 3>, 65533, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=255 options=268 groupId=16 sequence=196>, 137, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:22.658 DEBUG (MainThread) [bellows.ezsp] Send command sendMulticast: (<EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=256 groupId=16 sequence=142>, 0, 3, 143, b'\x01\x8e\x01')
2020-08-08 22:36:22.664 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'36d92190502b7d33b258954a24ba551c499fc124aa63cf8fa87e'
2020-08-08 22:36:22.673 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'64d9a19054e323fa7e'
2020-08-08 22:36:22.673 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:22.673 DEBUG (MainThread) [bellows.ezsp] Application frame 56 (sendMulticast) received: b'00c9'
2020-08-08 22:36:22.728 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'74d9b1975414bbb658924a24ab1592499c8badabed02e47e'
2020-08-08 22:36:22.728 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:22.729 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'003eae04010600010140000000c58a0000'
2020-08-08 22:36:22.729 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 44606, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=64 groupId=0 sequence=197>, 138, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.013 DEBUG (MainThread) [bellows.ezsp] Send command nop: ()
2020-08-08 22:36:23.014 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'40de21adc5597e'
2020-08-08 22:36:23.019 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'05dea1ad0c187e'
2020-08-08 22:36:23.019 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:23.021 DEBUG (MainThread) [bellows.ezsp] Application frame 5 (nop) received: b''
2020-08-08 22:36:23.505 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'15deb1ed542e14b459954b65ab559206638e19051231608392cc6389ec7f46c07e'
2020-08-08 22:36:23.505 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:23.507 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'00040106000101400100004fffc03eaeffff07086f0a00001001'
2020-08-08 22:36:23.507 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=79>, 255, -64, 0xae3e, 255, 255, b'\x08o\n\x00\x00\x10\x01']
2020-08-08 22:36:23.507 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=111 command_id=Command.Report_Attributes>
2020-08-08 22:36:23.507 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] ZCL request 0x000a: [[<Attribute attrid=0 value=<TypeValue type=Bool, value=Bool.true>>]]
2020-08-08 22:36:23.508 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] Attribute report received: on_off=1
2020-08-08 22:36:23.522 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xae3e, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=111>, 144, b'\x18o\x0b\n\x00')
2020-08-08 22:36:23.523 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'52df219c5414bbb658924a24ab1593499c21b7aef5a16c81fdf8e27e'
2020-08-08 22:36:23.533 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'26dfa19c54e04a2d7e'
2020-08-08 22:36:23.533 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:23.534 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00ca'
2020-08-08 22:36:23.563 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'36dfb1975414bbb658924a24ab1593499c84b7abedf7d87e'
2020-08-08 22:36:23.563 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:23.564 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'003eae04010600010140010000ca900000'
2020-08-08 22:36:23.564 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 44606, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=202>, 144, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.578 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'46dfb19757d7eab658924a24555993599c87a8abed96e67e'
2020-08-08 22:36:23.578 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:23.579 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'03fdff0401060001ff0c011000c98f0000'
2020-08-08 22:36:23.579 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_MULTICAST: 3>, 65533, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=255 options=268 groupId=16 sequence=201>, 143, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.579 DEBUG (MainThread) [homeassistant.components.zha.entity] light.dining_room: turned on: {'move_to_level_with_on_off': [4, <Status.SUCCESS: 0>], 'on_off': [1, <Status.SUCCESS: 0>]}
2020-08-08 22:36:23.581 DEBUG (MainThread) [homeassistant.components.zha.entity] light.dining_room_1: polling current state - from cache: False
2020-08-08 22:36:23.582 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xd949, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=145>, 146, b'\x00\x91\x00\x00\x00')
2020-08-08 22:36:23.582 DEBUG (MainThread) [homeassistant.components.zha.entity] light.dining_room_2: polling current state - from cache: False
2020-08-08 22:36:23.582 DEBUG (MainThread) [homeassistant.components.zha.entity] light.dining_room_3: polling current state - from cache: False
2020-08-08 22:36:23.583 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'65dc219c5463ccb658924a24ab1593499cdfb5aeed5f678bfdf1ae7e'
2020-08-08 22:36:23.593 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'57dca19c54e1b4e27e'
2020-08-08 22:36:23.593 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:23.594 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00cb'
2020-08-08 22:36:23.594 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x9a56, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=147>, 148, b'\x00\x93\x00\x00\x00')
2020-08-08 22:36:23.595 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'76dd219c547c8fb658924a24ab1593499cddb3aeed5d678bfd3dd97e'
2020-08-08 22:36:23.605 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'60dda19c54e689997e'
2020-08-08 22:36:23.605 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:23.606 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00cc'
2020-08-08 22:36:23.606 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xae3e, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=149>, 150, b'\x00\x95\x00\x00\x00')
2020-08-08 22:36:23.607 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'07e2219c5414bbb658924a24ab1593499cdbb1aeed5b678bfddfcf7e'
2020-08-08 22:36:23.617 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'71e2a19c54e7af8b7e'
2020-08-08 22:36:23.617 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:23.618 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00cd'
2020-08-08 22:36:23.658 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'01e2b1975414bbb658924a24ab1593499c83b1abed7d907e'
2020-08-08 22:36:23.658 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:23.659 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'11e2b1975463ccb658924a24ab1593499c85b5abed08ad7e'
2020-08-08 22:36:23.659 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:23.660 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'003eae04010600010140010000cd960000'
2020-08-08 22:36:23.660 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 44606, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=205>, 150, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.660 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'0049d904010600010140010000cb920000'
2020-08-08 22:36:23.661 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 55625, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=203>, 146, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.684 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'21e2b1ed542e14b459954b65ab559219638f190512316f9368c76389fc6e3ea5a07e'
2020-08-08 22:36:23.684 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:23.685 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401060001014001000050ffc13eaeffff081895010000001001'
2020-08-08 22:36:23.685 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=80>, 255, -63, 0xae3e, 255, 255, b'\x18\x95\x01\x00\x00\x00\x10\x01']
2020-08-08 22:36:23.685 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=149 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.698 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xae3e, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=151>, 152, b'\x00\x97\x00\x00\x00')
2020-08-08 22:36:23.699 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'7d33e3219c5414bbb6589c4a24ab1593499cd9bfaeed59678bfd74817e'
2020-08-08 22:36:23.709 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'32e3a19c54e491497e'
2020-08-08 22:36:23.709 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:23.710 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00ce'
2020-08-08 22:36:23.715 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'42e3b197547c8fb658924a24ab1593499c82b3abedb62f7e'
2020-08-08 22:36:23.715 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:23.716 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00569a04010600010140010000cc940000'
2020-08-08 22:36:23.716 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 39510, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=204>, 148, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.723 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'52e3b1ed542e14b459954b65ab55920e63f36e7212316f936cc76389fc6e3ea536dd7e'
2020-08-08 22:36:23.723 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:23.723 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401060001014001000047ffbd49d9ffff08189101000000100102'
2020-08-08 22:36:23.724 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=71>, 255, -67, 0xd949, 255, 255, b'\x18\x91\x01\x00\x00\x00\x10\x01']
2020-08-08 22:36:23.724 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=145 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.735 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xd949, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=153>, 154, b'\x00\x99\x00\x00\x00')
2020-08-08 22:36:23.736 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'26e0219c5463ccb6589c4a24ab1593499cd7bdaeed57678bfd3d287e'
2020-08-08 22:36:23.744 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'62e3b1ed542e14ba59954b65ab559218638f190512316f936ac76389fc5e0c71d47e'
2020-08-08 22:36:23.744 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:23.745 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'72e3b1975414bbb6589c4a24ab1593499c80bfabed2e537e'
2020-08-08 22:36:23.745 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:23.745 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401080001014001000051ffc13eaeffff081897010000002033'
2020-08-08 22:36:23.745 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=81>, 255, -63, 0xae3e, 255, 255, b'\x18\x97\x01\x00\x00\x00 3']
2020-08-08 22:36:23.745 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0008] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=151 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.745 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'003eae04010800010140010000ce980000'
2020-08-08 22:36:23.745 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 44606, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=206>, 152, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.746 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'02e3b1ed542e14b459954b65ab55927663f2713112316f936ec76389fc6e3ea3850b7e'
2020-08-08 22:36:23.746 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:23.747 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'13e0a19c54e51f127e'
2020-08-08 22:36:23.747 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:23.758 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xae3e:1:0x0008]: received attribute: 0 update with value: 51
2020-08-08 22:36:23.759 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'00040106000101400100003fffbc569affff08189301000000100104'
2020-08-08 22:36:23.759 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=6 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=63>, 255, -68, 0x9a56, 255, 255, b'\x18\x93\x01\x00\x00\x00\x10\x01']
2020-08-08 22:36:23.759 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=147 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.760 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00cf'
2020-08-08 22:36:23.771 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xae3e, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=155>, 156, b'\x00\x9b\x00\x07\x00')
2020-08-08 22:36:23.772 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'32e1219c5414bbb658944924ab1593499cd5bbaeed55678cfd9ccf7e'
2020-08-08 22:36:23.783 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'24e1a19c54fab1507e'
2020-08-08 22:36:23.783 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:23.783 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00d0'
2020-08-08 22:36:23.784 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x9a56, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=157>, 158, b'\x00\x9d\x00\x00\x00')
2020-08-08 22:36:23.784 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'43e6219c547c8fb6589c4a24ab1593499cd3b9aeed53678bfd7d5d227e'
2020-08-08 22:36:23.795 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'35e6a19c54fb99817e'
2020-08-08 22:36:23.795 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:23.796 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00d1'
2020-08-08 22:36:23.826 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'45e6b1ed542e14ba59954b65ab55920163f26e7212316f9364c76389fc5e0ca599957e'
2020-08-08 22:36:23.826 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:23.827 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401080001014001000048ffbc49d9ffff08189901000000203302'
2020-08-08 22:36:23.827 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=72>, 255, -68, 0xd949, 255, 255, b'\x18\x99\x01\x00\x00\x00 3']
2020-08-08 22:36:23.828 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0008] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=153 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.849 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'55e6b1ed542e14ba59954b65ab55920963f3713112316f9360c76389fc5e0ca3d3f87e'
2020-08-08 22:36:23.849 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:23.850 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401080001014001000040ffbd569affff08189d01000000203304'
2020-08-08 22:36:23.851 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=64>, 255, -67, 0x9a56, 255, 255, b'\x18\x9d\x01\x00\x00\x00 3']
2020-08-08 22:36:23.851 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0008] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=157 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.865 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'65e6b1ed542e14b25a954b65ab55921b528f190512316e9366c76489fc5f4da670237e'
2020-08-08 22:36:23.866 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:23.866 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'75e6b1975414bbb658944924ab1593499c9ebbabedc2c37e'
2020-08-08 22:36:23.867 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:23.867 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401000301014001000052cec13eaeffff09189b01070000217201'
2020-08-08 22:36:23.867 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=82>, 206, -63, 0xae3e, 255, 255, b'\x18\x9b\x01\x07\x00\x00!r\x01']
2020-08-08 22:36:23.867 DEBUG (MainThread) [zigpy.zcl] [0xae3e:1:0x0300] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=155 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.868 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'003eae04010003010140010000d09c0000'
2020-08-08 22:36:23.868 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 44606, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=208>, 156, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.876 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'05e6b1975463ccb6589c4a24ab1593499c81bdabed44d17e'
2020-08-08 22:36:23.876 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:23.881 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'0049d904010800010140010000cf9a0000'
2020-08-08 22:36:23.881 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 55625, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=207>, 154, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.884 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'15e6b197547c8fb6589c4a24ab1593499c9fb9abed3c1d7e'
2020-08-08 22:36:23.884 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:23.891 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xd949:1:0x0008]: received attribute: 0 update with value: 51
2020-08-08 22:36:23.892 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xd949, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=159>, 160, b'\x00\x9f\x00\x07\x00')
2020-08-08 22:36:23.892 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00569a04010800010140010000d19e0000'
2020-08-08 22:36:23.892 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 39510, <EmberApsFrame profileId=260 clusterId=8 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=209>, 158, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.894 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'52e7219c5463ccb658944924ab1593499cd187aeed51678cfd9b2a7e'
2020-08-08 22:36:23.904 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'26e7a19c54f8d7d77e'
2020-08-08 22:36:23.904 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2020-08-08 22:36:23.905 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x9a56:1:0x0008]: received attribute: 0 update with value: 51
2020-08-08 22:36:23.906 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00d2'
2020-08-08 22:36:23.906 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0x9a56, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=161>, 162, b'\x00\xa1\x00\x07\x00')
2020-08-08 22:36:23.908 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'63e4219c547c8fb658944924ab1593499cef85aeed6f678cfd70cd7e'
2020-08-08 22:36:23.918 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'37e4a19c54f976007e'
2020-08-08 22:36:23.918 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2020-08-08 22:36:23.918 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received: b'00d3'
2020-08-08 22:36:23.926 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'47e4b1ed542e14b25a954b65ab55920063f26e7212316e9362c76489fc5f4da6e9cd3d7e'
2020-08-08 22:36:23.926 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2020-08-08 22:36:23.927 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401000301014001000049ffbc49d9ffff09189f0107000021720102'
2020-08-08 22:36:23.927 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=73>, 255, -68, 0xd949, 255, 255, b'\x18\x9f\x01\x07\x00\x00!r\x01']
2020-08-08 22:36:23.927 DEBUG (MainThread) [zigpy.zcl] [0xd949:1:0x0300] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=159 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.935 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'57e4b1975463ccb658944924ab1593499c9c87abed42d67e'
2020-08-08 22:36:23.935 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2020-08-08 22:36:23.936 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'0049d904010003010140010000d2a00000'
2020-08-08 22:36:23.936 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 55625, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=210>, 160, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:23.963 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'67e4b1ed542e14b25a954b65ab55920863f7713112316e935cc76489fc5f4da6effdc37e'
2020-08-08 22:36:23.964 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2020-08-08 22:36:23.964 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'000401000301014001000041ffb9569affff0918a10107000021720104'
2020-08-08 22:36:23.964 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=65>, 255, -71, 0x9a56, 255, 255, b'\x18\xa1\x01\x07\x00\x00!r\x01']
2020-08-08 22:36:23.964 DEBUG (MainThread) [zigpy.zcl] [0x9a56:1:0x0300] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=161 command_id=Command.Read_Attributes_rsp>
2020-08-08 22:36:23.970 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'77e4b197547c8fb658944924ab1593499c9d85abedc4857e'
2020-08-08 22:36:23.970 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2020-08-08 22:36:23.970 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received: b'00569a04010003010140010000d3a20000'
2020-08-08 22:36:23.971 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 39510, <EmberApsFrame profileId=260 clusterId=768 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=211>, 162, <EmberStatus.SUCCESS: 0>, b'']
2020-08-08 22:36:33.024 DEBUG (MainThread) [bellows.ezsp] Send command nop: ()
2020-08-08 22:36:33.026 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'70e521addce47e'
2020-08-08 22:36:33.031 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'00e5a1ad85097e'
2020-08-08 22:36:33.031 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2020-08-08 22:36:33.032 DEBUG (MainThread) [bellows.ezsp] Application frame 5 (nop) received: b''
2020-08-08 22:36:35.040 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'10e5b1ed542e14b25c954b65ab55929563f2e26712316e829bc64789fc7e3fa7ef72587e'
2020-08-08 22:36:35.040 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2020-08-08 22:36:35.041 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received: b'0004010005010140010000dcffbcc5ccffff0909660024000000000004'
2020-08-08 22:36:35.041 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, <EmberApsFrame profileId=260 clusterId=1280 sourceEndpoint=1 destinationEndpoint=1 options=320 groupId=0 sequence=220>, 255, -68, 0xccc5, 255, 255, b'\tf\x00$\x00\x00\x00\x00\x00']
2020-08-08 22:36:35.042 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=102 command_id=0>
2020-08-08 22:36:35.042 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] ZCL request 0x0000: [<ZoneStatus.Restore_reports|Tamper: 36>, <bitmap8.0: 0>, 0, 0]
2020-08-08 22:36:35.042 DEBUG (MainThread) [zigpy.zcl] [0xccc5:1:0x0500] No handler for cluster command 0
2020-08-08 22:36:35.042 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xccc5:1:0x0500]: Updated alarm state: ZoneStatus.0
2020-08-08 22:36:35.043 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=binary_sensor.dining_room_motion, old_state=<state binary_sensor.dining_room_motion=on; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:36:21.678395-05:00>, new_state=<state binary_sensor.dining_room_motion=off; friendly_name=Dining Room Motion, device_class=motion @ 2020-08-08T22:36:35.043720-05:00>>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment