Adding support for tuya TS004F dimmer switches

Adding TS004F that is one no color controller or perhaps one no color scene controller and not one HA scene controller that the other TS004X is.
Fixes #914
Fixes #897
Fixes #917
Plus HA Community thread TS004X.
@koying have doing most coding in blind but the users have problem getting events from the on/off cluster that is little strange (i think its was problem in the local installation but its not verified) but the events from light level and the device automatons was working OK.
Need more test from users that is having the device for getting the last parts it in place.
I have changing the type to NON_COLOR_CONTROLLER and adapting the device automation to it but perhaps it shall being  one NON_COLOR_SCENE_CONTROLLER but need some test if its supporting sending and receiving real Zigbee scenes commands before changing it.
The intention with this pull is getting it easy for user testing the quirk and getting feed back so we can fixing the last issues and getting it full supported.
Also if some code worrier can helping getting release from both dim up and down as separate events like its implanted in IKEA open/close button wold being great then our user have one more trigger to using in there  automation (they can never getting enough of functions to playing with !!!)
Im on the hunt for this devices in gray or black delivered in EU for fast shipping and no tax problems but i have not getting it verified if its TS0044 or TS004F and if its possible with the new hardware (its having one MG21 module the  old one MG1B).

Codecov Report

Merging #969 (b2fa672) into dev (b7e6173) will increase coverage by 0.03%.
The diff coverage is 100.00%.

@@            Coverage Diff             @@
##              dev     #969      +/-   ##
==========================================
+ Coverage   82.55%   82.59%   +0.03%
==========================================
  Files         189      190       +1
  Lines        4798     4808      +10
==========================================
+ Hits         3961     3971      +10
  Misses        837      837

Impacted Files
Coverage Δ

zhaquirks/tuya/ts004f.py
100.00% <100.00%> (ø)

Continue to review full report at Codecov.

Legend - Click here to learn more
Δ = absolute <relative> (impact), ø = not affected, ? = missing data
Powered by Codecov. Last update b7e6173...b2fa672. Read the comment docs.

Pull Request Test Coverage Report for Build<PHONE_NUMBER>

10 of 10 (100.0%)  changed or added relevant lines in 1 file are covered.
No unchanged relevant lines lost coverage.
Overall coverage increased (+0.04%) to 82.592%

Totals

Change from base Build<PHONE_NUMBER>:
0.04%

Covered Lines:
3971

Relevant Lines:
4808

💛  - Coveralls

Im on the hunt for this devices in gray or black delivered in EU for fast shipping and no tax problems but i have not getting it

I have one and live in EU. Maybe I could send it to you? Please write to me PM to arrange details :)

@smigima I pinging you from one issue that i deleting after you have getting the e.mail from gut-hub.

lets merge this puppy!... I look forward to using my switch.

@sushant40 Can you testing if zha_event and all device automatons is triggering ?
I dont have the device but i have 2 on order but they is not yet shipped :-((
2 users was having problem before with the on/off was not fired but ZHA was receiving the commands nicely.

I've just bought one of these switches and I'm a bit gutted it doesn't work with ZHA. I'm a bit of a noob with zigbee but I'm happy to help if I can.
My TS004F isn't a dimmer switch though? its a 4 button switch with each button having 3 modes. Short press, long press and double press. Same as the switch in @smigima's post (but in white).

Sorry @PRich13 as long i dont get one debug log (or one devices in ma hands) its still one dimmer switch as is sending commands to light and not "click clicks".
Look on the logs posted in the HA forum and also Z2M is exposing it like that https://www.zigbee2mqtt.io/devices/TS004F.html.
If you have pairing the switch and having debug activated you shall see the commands in the log then ZHA is receiving them.
You can also looking for the events its sending in Developer Tools > Events > Listen to events and putting in zha_event and clicking start listening and you shall see the events from the switch.

@MattWestb  until I have still button on me I've managed to record zha_events:
Left side is doing nothing (up and bottom clicks - short, long or twice)
Right UP side one click:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "step",         "args": [             0,             51,             10         ]     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:29:22.174519+00:00",     "context": {         "id": "cd6b05740a32331bdcea7c95753fc2ab",         "parent_id": null,         "user_id": null     } }
Right UP side twice click: nothing
Right UP side long click:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "move",         "args": [             0,             51         ]     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:31:05.094890+00:00",     "context": {         "id": "81798509a3bba667933074645a5d25ca",         "parent_id": null,         "user_id": null     } }
and on release:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "stop",         "args": []     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:31:06.589058+00:00",     "context": {         "id": "bb2c9a6b8cfc83f806df8450194bf1c8",         "parent_id": null,         "user_id": null     } }
Right DOWN side one click:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "step",         "args": [             1,             51,             10         ]     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:32:59.897700+00:00",     "context": {         "id": "026357f61cb448694cc6db1efd24df05",         "parent_id": null,         "user_id": null     } }
Right DOWN side twice click: nothing
Right DOWN side long click:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "move",         "args": [             1,             51         ]     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:33:53.213199+00:00",     "context": {         "id": "b88d726ee1444c546bd296c03b1a2513",         "parent_id": null,         "user_id": null     } }
and on release:
{     "event_type": "zha_event",     "data": {         "device_ieee": "60:a4:23:ff:fe:f6:f8:95",         "unique_id": "60:a4:23:ff:fe:f6:f8:95:1:0x0008",         "device_id": "7d9cc6f16b0097b2d3b51592f03988ba",         "endpoint_id": 1,         "cluster_id": 8,         "command": "step",         "args": [             1,             51,             10         ]     },     "origin": "LOCAL",     "time_fired": "2021-07-22T09:32:59.897700+00:00",     "context": {         "id": "026357f61cb448694cc6db1efd24df05",         "parent_id": null,         "user_id": null     } }

@smigima that looks very OK and it shall not being any problem getting the device automation being triggered on them (perhaps the release / stop if can implanting  the logic for the privies move direction).
The problem is the right side that shall sending On/Off and Dim up and down.
Do you getting anything in the log from them ??

By the way pleas use ``` log code / text ``` then its being easier to reading and copy to editor :-))

@MattWestb Ok I will, thanks :)
I'm a noob in HA so I don't know if I'll manage to give you logs but I'll try. I assume I need to add to cinfiguration.yaml
logger:
  default: info
  logs:
    homeassistant.components.zha: info

And then restart?
Anyway if I don't, I'll send it to you tommorow for tests so it should arrive in next week.

I think you need using debug instead of info homeassistant.components.zha: debug (fast pasting with out the good ...) that i normally using in my  test setup but is putting in more if needed.
More debug / logging https://github.com/zigpy/zigpy/wiki/Zigpy-Advanced-Configuration.
And restarting HA and pressing keys and looking in the log file (<HA config dir>/home-assistant.log)
You can also changing the debug / logging on the fly with service but its little more advance / tricky.
One package is on the way from Spain but its one with LED strip controller (with the new MG21 module) not the switches :-((

Hi @MattWestb
I have installed the quirk ts004f.py, it also load put at start but I am not able to see any button press in zha_event.
2021-07-17 15:14:58 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for _TZ3000_xabckq1v TS004F (60:a4:23:ff:fe:95:22:d7) 2021-07-17 15:14:58 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.tuya.ts004f.TuyaSmartRemote004F'> 2021-07-17 15:14:58 DEBUG (MainThread) [zigpy.quirks.registry] Found custom device replacement for 60:a4:23:ff:fe:95:22:d7: <class 'zhaquirks.tuya.ts004f.TuyaSmartRemote004F'>

First great thanks for helping testing @BUGBEAR7 !!!
So one user is getting events from the right buttons and other is getting no events at all ;-((
Possible enabling debug logging (as written 2 posts above) ?
I have seen the device sending on/off commands in the HA thread but not triggering the device automatons so something its not OK in ZHA side.
Do you have old local quirks installed that is making spooky things (is the /deps/ folder is empty or "old junk" in it ?).

Lodging setting:
logger:
  default: info
  logs:
    homeassistant.components.zha: debug
    zigpy: debug
    zhaquirks.tuya: debug

The zigpy is shoeing the received commands that is very interesting for the moment.
If working OK it shall showing somthing like this:
2021-06-28 10:36:50 DEBUG (MainThread) [zigpy.zcl] [0xbb77:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=24 command_id=1>
2021-06-28 10:36:50 DEBUG (MainThread) [zigpy.zcl] [0xbb77:1:0x0006] ZCL request 0x0001: []
2021-06-28 10:36:50 DEBUG (MainThread) [zigpy.zcl] [0xbb77:1:0x0006] No handler for cluster command 1

This is what I got in the debug log
2021-07-22 23:14:56 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Parent_annce: [[00:15:8d:00:06:f7:7d:32, 60:a4:23:ff:fe:95:22:d7, 00:12:4b:00:22:41:44:11, 00:15:8d:00:06:d6:4b:fa, 00:15:8d:00:06:f2:53:8d]] 2021-07-22 23:14:56 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] Unsupported ZDO request:ZDOCmd.Parent_annce 2021-07-22 23:16:36 DEBUG (MainThread) [zigpy.zcl] [0xf852:1:0x0402] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=72 command_id=Command.Report_Attributes> 2021-07-22 23:16:36 DEBUG (MainThread) [zigpy.zcl] [0xf852:1:0x0402] ZCL request 0x000a: [[Attribute(attrid=0, value=<TypeValue type=int16s, value=3273>)]] 2021-07-22 23:16:36 DEBUG (MainThread) [zigpy.zcl] [0xf852:1:0x0402] Attribute report received: measured_value=3273

You is getting command from one device in the log @BUGBEAR7  !!!!
The problem its looks coming from one other device then your device was (from the screen shot) 0xa8a7 and the commands is coning from device 0xf852.
Can you looking wot Nwk the TS004F is having.
And the switch dont have cluster 0x0402.
Can you also doing reconfigure of the switch (from the device card > Reconfigure this device > Start and waking up the device by pressing one button so it can receiving the commands) and then (if) its going OK doing some more button pressing and looking in the log ?

@BUGBEAR7 Can you also looking wot devices this is:
[00:15:8d:00:06:f7:7d:32, 60:a4:23:ff:fe:95:22:d7, 00:12:4b:00:22:41:44:11, 00:15:8d:00:06:d6:4b:fa, 00:15:8d:00:06:f2:53:8d] I think the 0015 is Xiaomi / Aqaras and the 60a4 is your TS004F so very likely its parent was having problems.
Its looks like they have being re powered or have the firmware restarting the device.

Yes 60:a4:23:ff:fe:95:22:d7 is the tuya TS004F device .
I will post the debug in a minute

00:12:4b:00:22:41:44:11 is one Texas Instruments device
The 00:15:8d:00:* is Jennic Ltd = i think is used of Xiaomi.

This is the reconfiguration debug log
2021-07-22 23:54:38 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): started configuration
2021-07-22 23:54:38 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](TS004F): 'async_configure' stage succeeded
2021-07-22 23:54:38 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: finished channel configuration
2021-07-22 23:54:38 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x01 request
2021-07-22 23:54:38 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x03 request
2021-07-22 23:54:38 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x05 request
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x1000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=1 command_id=Command.Default_Response>
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x07 request
2021-07-22 23:55:02 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: bound 'power' cluster: Status.SUCCESS
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x09 request
2021-07-22 23:55:02 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: bound 'on_off' cluster: Status.SUCCESS
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0b request
2021-07-22 23:55:02 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: bound 'level' cluster: Status.SUCCESS
2021-07-22 23:55:02 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: finished channel configuration
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0d request
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=9 command_id=Command.Configure_Reporting_rsp>
2021-07-22 23:55:02 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: reporting 'battery_voltage' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=0)]]'
2021-07-22 23:55:02 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0f request
2021-07-22 23:55:03 DEBUG (MainThread) [zigpy.zcl] [0xa8a7: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=11 command_id=Command.Configure_Reporting_rsp>
2021-07-22 23:55:03 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: reporting 'on_off' attr on 'on_off' cluster: 0/900/1: Result: '[[ConfigureReportingResponseRecord(status=134, direction=0, attrid=0)]]'
2021-07-22 23:55:03 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: finished channel configuration
2021-07-22 23:55:03 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: finished channel configuration
2021-07-22 23:55:03 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x11 request
2021-07-22 23:55:03 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: bound 'on_off' cluster: Status.SUCCESS
2021-07-22 23:55:03 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Mgmt_NWK_Update_rsp: [<Status.SUCCESS: 0>, <Channels.ALL_CHANNELS: 134215680>, 20, 6, [245, 196, 170, 168, 167, 166, 6, 5, 194, 168, 166, 168, 208, 184, 204, 195]]
2021-07-22 23:55:03 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] Unsupported ZDO request:ZDOCmd.Mgmt_NWK_Update_rsp
2021-07-22 23:55:04 INFO (MainThread) [zigpy.application] Device 0xa8a7 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x13 request
2021-07-22 23:55:04 INFO (MainThread) [bellows.zigbee.application] ZDO Device announce: 0xa8a7, 60:a4:23:ff:fe:95:22:d7
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.device] [0xa8a7] Cancelling old group rescan
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Device_annce: [0xA8A7, 60:a4:23:ff:fe:95:22:d7, 128]
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x15 request
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0004] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=19 command_id=2>
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0004] ZCL request 0x0002: [255, []]
2021-07-22 23:55:04 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0004] No handler for cluster command 2
2021-07-22 23:55:05 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0004] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=21 command_id=2>
2021-07-22 23:55:12 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=15 command_id=Command.Configure_Reporting_rsp>
2021-07-22 23:55:12 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: reporting 'battery_percentage_remaining' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=0)]]'
2021-07-22 23:55:12 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: finished channel configuration
2021-07-22 23:55:13 DEBUG (MainThread) [zigpy.device] [0xa8a7] Invalid state on future for 0x11 seq -- probably duplicate response
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: bound 'scenes' cluster: Status.SUCCESS
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: finished channel configuration
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: 'async_configure' stage succeeded
2021-07-22 23:55:13 WARNING (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x1000]: 'async_configure' stage failed: not enough values to unpack (expected 3, got 2)
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: 'async_configure' stage succeeded
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: 'async_configure' stage succeeded
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: 'async_configure' stage succeeded
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: 'async_configure' stage succeeded
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: 'async_configure' stage succeeded
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): completed configuration
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): stored in registry: ZhaDeviceEntry(name='_TZ3000_xabckq1v TS004F', ieee='60:a4:23:ff:fe:95:22:d7', last_seen=1626978313.1541872)
2021-07-22 23:55:13 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x17 request
2021-07-22 23:55:13 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0003] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=23 command_id=Command.Default_Response>
2021-07-22 23:55:13 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0003]: executed 'trigger_effect' command with args: '(2, 0)' kwargs: '{}' result: [64, <Status.UNSUP_CLUSTER_COMMAND: 129>]
2021-07-22 23:55:15 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Node_Desc_req: [0x0000]
2021-07-22 23:55:15 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_req

In Zigbee Home Automation it also create a switch along with BAttery percentage
If the Switch turned off and no button is pressed during that time this is the debug
2021-07-23 00:03:25 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x37 request
2021-07-23 00:03:53 DEBUG (MainThread) [zigpy.device] [0xa8a7] Delivery error for seq # 0x37, on endpoint id 1 cluster 0x0006: message send failure
2021-07-23 00:03:53 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: command failed: 'on' args: '()' kwargs '{}' exception: '[0xa8a7:1:0x0006]: Message send failure'

If the switch is off to on and the pressing a button create this debug
2021-07-23 00:05:51 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x39 request
2021-07-23 00:05:58 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=57 command_id=Command.Default_Response>
2021-07-23 00:05:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: executed 'on' command with args: '()' kwargs: '{}' result: [1, <Status.SUCCESS: 0>]

Also of the switch is turned off from on and in that time if the button is pressed ( I do. not remember which button)
2021-07-23 00:08:06 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x3b request
2021-07-23 00:08:12 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0006] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=59 command_id=Command.Default_Response>
2021-07-23 00:08:12 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: executed 'off' command with args: '()' kwargs: '{}' result: [0, <Status.SUCCESS: 0>]

From on to off no button pressed
2021-07-23 00:09:46 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x3d request
2021-07-23 00:10:14 DEBUG (MainThread) [zigpy.device] [0xa8a7] Delivery error for seq # 0x3d, on endpoint id 1 cluster 0x0006: message send failure
2021-07-23 00:10:14 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: command failed: 'on' args: '()' kwargs '{}' exception: '[0xa8a7:1:0x0006]: Message send failure'

I do not know if that helps or not

The switch on the device card shall not being there.
Then you is switching it ZHA is trying to sending one on command to the switch = not possible it can turning light on then its not one light.
So the error is normal if having the "ghost switch" on the device card.
Wot i can see in the reconfigure log that the on/off and light level luster is being OK bounded.
But i have not seen and command received from the device and its strange.
Can you deleting the device from its device card and waking it  up by pressing one button, waiting 2 minutes and restarting HA. Then HA have stabilizing  then adding the switch and looking if its sending any commands in the log.

The last updated long is having many Delivery error so you is having problem in your Zigbee network ;-((

I deleted the device but just after pressing a button it created another device with name _TZ3000_xabckq1v TS004F
2021-07-23 00:25:35 INFO (MainThread) [homeassistant.components.zha.api] Removing node 60:a4:23:ff:fe:95:22:d7
2021-07-23 00:25:35 INFO (MainThread) [zigpy.application] Removing device 0xa8a7 (60:a4:23:ff:fe:95:22:d7)
2021-07-23 00:25:35 DEBUG (MainThread) [zigpy.application] Sending leave request for 60:a4:23:ff:fe:95:22:d7 to 80:4b:50:ff:fe:0e:a5:db parent
2021-07-23 00:25:35 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x02 request
2021-07-23 00:25:35 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Mgmt_Leave_req: [60:a4:23:ff:fe:95:22:d7, <bitmap8.2: 2>]
2021-07-23 00:25:35 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] Unsupported ZDO request:ZDOCmd.Mgmt_Leave_req
2021-07-23 00:25:47 DEBUG (MainThread) [zigpy.device] [0xa8a7] Delivery error for seq # 0x02, on endpoint id 0 cluster 0x0034: message send failure
2021-07-23 00:25:47 DEBUG (MainThread) [zigpy.application] Sending 'zdo_leave_req' failed: [0xa8a7:0:0x0034]: Message send failure
2021-07-23 00:25:54 INFO (MainThread) [zigpy.application] New device 0xa8a7 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Scheduling initialization
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:25:54 INFO (MainThread) [zigpy.device] [0xa8a7] Requesting 'Node Descriptor'
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x05 request
2021-07-23 00:25:54 INFO (MainThread) [bellows.zigbee.application] ZDO Device announce: 0xa8a7, 60:a4:23:ff:fe:95:22:d7
2021-07-23 00:25:54 INFO (MainThread) [zigpy.application] Device 0xa8a7 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Scheduling initialization
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Canceling old initialize call
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 19: b'\xa6\xa7\xa8\xd7"\x95\xfe\xff#\xa4`\x80'
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Device_annce: [0xA8A7, 60:a4:23:ff:fe:95:22:d7, 128]
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:25:54 INFO (MainThread) [zigpy.device] [0xa8a7] Requesting 'Node Descriptor'
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x07 request
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x05\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Node_Desc_rsp: [<Status.SUCCESS: 0>, 0xA8A7, NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)]
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_rsp
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x07\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 00:25:54 INFO (MainThread) [zigpy.device] [0xa8a7] Got Node Descriptor: NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)
2021-07-23 00:25:54 INFO (MainThread) [zigpy.device] [0xa8a7] Discovering endpoints
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:25:54 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x09 request
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32773: b'\t\x00\xa7\xa8\x01\x01'
2021-07-23 00:25:55 INFO (MainThread) [zigpy.device] [0xa8a7] Discovered endpoints: [1]
2021-07-23 00:25:55 INFO (MainThread) [zigpy.device] [0xa8a7] Initializing endpoints [<Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>]
2021-07-23 00:25:55 INFO (MainThread) [zigpy.endpoint] [0xa8a7:1] Discovering endpoint information
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0b request
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32772: b'\x0b\x00\xa7\xa8$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10'
2021-07-23 00:25:55 INFO (MainThread) [zigpy.endpoint] [0xa8a7:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=260, device_version=1, input_clusters=[0, 1, 3, 4, 6, 4096], output_clusters=[25, 10, 3, 4, 5, 6, 8, 4096])
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0d request
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=13 command_id=Command.Read_Attributes_rsp>
2021-07-23 00:25:55 INFO (MainThread) [zigpy.device] [0xa8a7] Read model 'TS004F' and manufacturer '_TZ3000_xabckq1v' from <Endpoint id=1 in=[basic:0x0000, power:0x0001, identify:0x0003, groups:0x0004, on_off:0x0006, lightlink:0x1000] out=[ota:0x0019, time:0x000A, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, lightlink:0x1000] status=<Status.ZDO_INIT: 1>>
2021-07-23 00:25:55 INFO (MainThread) [zigpy.device] [0xa8a7] Discovered basic device information for <Device model='TS004F' manuf='_TZ3000_xabckq1v' nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=True>
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.application] Device is initialized <Device model='TS004F' manuf='_TZ3000_xabckq1v' nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=True>
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for _TZ3000_xabckq1v TS004F (60:a4:23:ff:fe:95:22:d7)
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'ts004f.TuyaSmartRemote004F'>
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.quirks.registry] Found custom device replacement for 60:a4:23:ff:fe:95:22:d7: <class 'ts004f.TuyaSmartRemote004F'>
2021-07-23 00:25:55 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 entering async_device_initialized - is_new_join: True
2021-07-23 00:25:55 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 has joined the ZHA zigbee network
2021-07-23 00:25:55 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): started configuration
2021-07-23 00:25:55 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](TS004F): 'async_configure' stage succeeded
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0f request
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x11 request
2021-07-23 00:25:55 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: finished channel configuration
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x13 request
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.appdb] Error handling '_save_attribute' event with (60:a4:23:ff:fe:95:22:d7, 1, 0, 4, '_TZ3000_xabckq1v') params: FOREIGN KEY constraint failed
2021-07-23 00:25:55 DEBUG (MainThread) [zigpy.appdb] Error handling '_save_attribute' event with (60:a4:23:ff:fe:95:22:d7, 1, 0, 5, 'TS004F') params: FOREIGN KEY constraint failed
2021-07-23 00:25:56 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x1000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=15 command_id=Command.Default_Response>
2021-07-23 00:25:56 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x15 request
2021-07-23 00:25:56 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: bound 'on_off' cluster: Status.SUCCESS
2021-07-23 00:25:56 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x17 request
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: bound 'power' cluster: Status.SUCCESS
2021-07-23 00:25:57 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x19 request
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: bound 'level' cluster: Status.SUCCESS
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: finished channel configuration
2021-07-23 00:25:57 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x1b request
2021-07-23 00:25:57 DEBUG (MainThread) [zigpy.zcl] [0xa8a7: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=23 command_id=Command.Configure_Reporting_rsp>
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: reporting 'on_off' attr on 'on_off' cluster: 0/900/1: Result: '[[ConfigureReportingResponseRecord(status=134, direction=0, attrid=0)]]'
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: finished channel configuration
2021-07-23 00:25:57 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: finished channel configuration
2021-07-23 00:25:57 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x1d request
2021-07-23 00:25:58 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=25 command_id=Command.Configure_Reporting_rsp>
2021-07-23 00:25:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: reporting 'battery_voltage' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=0)]]'
2021-07-23 00:25:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x1f request
2021-07-23 00:25:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: bound 'on_off' cluster: Status.SUCCESS
2021-07-23 00:25:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: finished channel configuration
2021-07-23 00:25:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: bound 'scenes' cluster: Status.SUCCESS
2021-07-23 00:25:58 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=31 command_id=Command.Configure_Reporting_rsp>
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: reporting 'battery_percentage_remaining' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=0)]]'
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: finished channel configuration
2021-07-23 00:25:59 WARNING (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x1000]: 'async_configure' stage failed: not enough values to unpack (expected 3, got 2)
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: 'async_configure' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): completed configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): stored in registry: ZhaDeviceEntry(name='_TZ3000_xabckq1v TS004F', ieee='60:a4:23:ff:fe:95:22:d7', last_seen=1626980159.2499955)
2021-07-23 00:25:59 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x21 request
2021-07-23 00:25:59 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0003] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=False> manufacturer=None tsn=33 command_id=Command.Default_Response>
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0003]: executed 'trigger_effect' command with args: '(2, 0)' kwargs: '{}' result: [64, <Status.UNSUP_CLUSTER_COMMAND: 129>]
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): started initialization
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](TS004F): 'async_initialize' stage succeeded
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x1000]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x1000]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x23 request
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x25 request
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: finished channel configuration
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: initializing channel: from_cache: False
2021-07-23 00:25:59 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: finished channel configuration
2021-07-23 00:26:00 DEBUG (MainThread) [zigpy.zcl] [0xa8a7: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=35 command_id=Command.Read_Attributes_rsp>
2021-07-23 00:26:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: finished channel configuration
2021-07-23 00:26:00 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=37 command_id=Command.Read_Attributes_rsp>
2021-07-23 00:26:00 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x27 request
2021-07-23 00:26:01 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=39 command_id=Command.Read_Attributes_rsp>
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: finished channel configuration
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x1000]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0000]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0001]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0008]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0019]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0005]: 'async_initialize' stage succeeded
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): power source: Battery or Unknown
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): completed initialization
2021-07-23 00:26:01 INFO (MainThread) [homeassistant.helpers.entity_registry] Registered new sensor.zha entity: sensor.tz3000_xabckq1v_ts004f_d72295fe_power
2021-07-23 00:26:01 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:1:0x0006]: attempting to update onoff state - from cache: True
2021-07-23 00:26:01 INFO (MainThread) [homeassistant.helpers.entity_registry] Registered new switch.zha entity: switch.tz3000_xabckq1v_ts004f_d72295fe_on_off

After that I deleted the _TZ3000_xabckq1v TS004F and restarted the HA . Then added the switch by putting it in pairing mode
2021-07-23 00:37:55 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'431bb1a9702ab21a8eb6dfdb557636299d4e27abe7f07e'
2021-07-23 00:37:55 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 00:37:55 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'a7a8d72295feff23a46001000000'
2021-07-23 00:37:55 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xa8a7, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 00:37:55 INFO (MainThread) [zigpy.application] New device 0xa8a7 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 00:37:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Scheduling initialization
2021-07-23 00:37:55 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 00:37:55 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:37:55 INFO (MainThread) [zigpy.device] [0xa8a7] Requesting 'Node Descriptor'
2021-07-23 00:37:55 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 00:37:55 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x05 request
2021-07-23 00:37:55 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'357d3821a9212ac290cc6ab5060e35938db17e'
2021-07-23 00:37:55 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=5), 6, b'\x05\xa7\xa8')
2021-07-23 00:37:56 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5418a1a9212aea50d27e'
2021-07-23 00:37:56 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 00:37:56 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'461921a9602a1515f1944a27aa5592099d4e27aeebcd622c552a547e'
2021-07-23 00:37:56 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 00:37:56 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'6519a1a9602a15ef268d7e'
2021-07-23 00:37:56 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 00:37:56 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'005d'
2021-07-23 00:37:57 DEBUG (MainThread) [bellows.ezsp.protocol] Send command nop: ()
2021-07-23 00:37:57 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'571e21a9512aa7667e'
2021-07-23 00:37:57 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'761ea1a9512a0af67e'
2021-07-23 00:37:57 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 00:37:57 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 5 (nop) received: b''
2021-07-23 00:37:57 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'061eb1a9772a14b3fe3c9d073fab6d6a382e237e947e'
2021-07-23 00:37:57 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 00:37:57 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 35 (childJoinHandler) received: b'0101a7a8d72295feff23a46004'
2021-07-23 00:37:57 DEBUG (MainThread) [bellows.zigbee.application] Received childJoinHandler frame with [1, <Bool.true: 1>, 0xa8a7, 60:a4:23:ff:fe:95:22:d7, <EmberNodeType.SLEEPY_END_DEVICE: 4>]
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'161eb1a9702ab21a8eb6dfdb557636299d4e27ab44b17e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'a7a8d72295feff23a46001000000'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xa8a7, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 00:37:58 INFO (MainThread) [zigpy.application] Device 0xa8a7 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Scheduling initialization
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Canceling old initialize call
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:37:58 INFO (MainThread) [zigpy.device] [0xa8a7] Requesting 'Node Descriptor'
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x07 request
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=7), 8, b'\x07\xa7\xa8')
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'621f21a9212ac290cc6ab5060e3593e1a37e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'271fa1a9212aeac4707e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'731c21a9602a1515f1944a27aa5592099d4e27ace5cd602c5584da7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'371fb5a9362ac290cc6ab5060e352f0c7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 98 (incomingSenderEui64Handler) received: b'd72295feff23a460'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received incomingSenderEui64Handler frame with [60:a4:23:ff:fe:95:22:d7]
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'471fb1a9112a11b259874a25aa5596499c55bf694a669874f16ec4212b5caa5914ee7a0f0ffde0aa7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'501ca1a9602a15d2b6b67e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'04000013000000000400001b98c2a7a8ffff0ca8a7a8d72295feff23a4608002'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_BROADCAST: 4>, EmberApsFrame(profileId=0, clusterId=19, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_SOURCE_EUI64: 1024>, groupId=0, sequence=27), 152, -62, 0xa8a7, 255, 255, b'\xa8\xa7\xa8\xd7"\x95\xfe\xff#\xa4`\x80']
2021-07-23 00:37:58 INFO (MainThread) [bellows.zigbee.application] ZDO Device announce: 0xa8a7, 60:a4:23:ff:fe:95:22:d7
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 19: b'\xa8\xa7\xa8\xd7"\x95\xfe\xff#\xa4`\x80'
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Device_annce: [0xA8A7, 60:a4:23:ff:fe:95:22:d7, 128]
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0060'
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x09 request
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=9), 10, b'\t\xa7\xa8')
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'061d21a9602a1515f1944a27aa5592099d4e27a2e7cd6e2c556ce17e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'601cb1a9112a15b25996ca25aa1593499c52876f4a669874ecc1632e547c7f27e9dd8c3d8fffeb89d5d26b820e7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'00000002800000400100001ca0c4a7a8ffff110700a7a80240800210525200002c52000002'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=28), 160, -60, 0xa8a7, 255, 255, b'\x07\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x07\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'701cb1a96b2a1515f1944a27aa5592099d4e27cbe5ce672ee57e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'011da1a9602a15d392417e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a80000020000004001000060080000'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=96), 8, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0061'
2021-07-23 00:37:58 INFO (MainThread) [zigpy.device] [0xa8a7] Got Node Descriptor: NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)
2021-07-23 00:37:58 INFO (MainThread) [zigpy.device] [0xa8a7] Discovering endpoints
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0b request
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Extending timeout for 60:a4:23:ff:fe:95:22:d7/0xa8a7
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setExtendedTimeout: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'7d312221a92a2ac290cc6ab5060e359317f27e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'1222a1a92a2a00297e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 126 (setExtendedTimeout) received: b''
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=11), 12, b'\x0b\xa7\xa8')
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'222321a9602a1515f1944a20aa5592099d4e27a0e1cd6c2c55dffd7e'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'2222b1a96b2a134fa6944a36aa559249984e27b0edce672eeb7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'06fdff000013000000000400001b000000'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_BROADCAST: 6>, 65533, EmberApsFrame(profileId=0, clusterId=19, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_SOURCE_EUI64: 1024>, groupId=0, sequence=27), 0, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Unexpected message send notification tag: 0
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'3323a1a9602a15d0005d7e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0062'
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'4323b1a96b2a1515f1944a27aa5592099d4e27cae7ce6751d77e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a800000200000040010000610a0000'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=97), 10, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5323b1a9112a15b25996ca25aa1593499c53876f4a669874eccf632e547c7f27e9dd8c3d8fffeb89d5d26beb317e'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'00000002800000400100001da0c4a7a8ffff110900a7a80240800210525200002c52000002'
2021-07-23 00:37:58 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=29), 160, -60, 0xa8a7, 255, 255, b'\t\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\t\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 00:37:58 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0d request
2021-07-23 00:37:58 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'362021a92a2ac290cc6ab5060e359304b37e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'6420a1a92a2a8cd77e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 126 (setExtendedTimeout) received: b''
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=13), 14, b'\r\xa7\xa8')
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'472121a9602a1515f1944a20aa5592099d4e27a6e3cd6a2c55d1e47e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'7420b1a9112a15b25991ca25aa1593499c50bf694a669874fbcd632e547f3ea54ef17e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'0420b1a96b2a1515f1944a20aa5592099d4e27c9e1ce672c407e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'00000005800000400100001e98c2a7a8ffff060b00a7a8010102'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32773, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=30), 152, -62, 0xa8a7, 255, 255, b'\x0b\x00\xa7\xa8\x01\x01']
2021-07-23 00:37:59 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32773: b'\x0b\x00\xa7\xa8\x01\x01'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a800000500000040010000620c0000'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=98), 12, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:37:59 INFO (MainThread) [zigpy.device] [0xa8a7] Discovered endpoints: [1]
2021-07-23 00:37:59 INFO (MainThread) [zigpy.device] [0xa8a7] Initializing endpoints [<Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>]
2021-07-23 00:37:59 INFO (MainThread) [zigpy.endpoint] [0xa8a7:1] Discovering endpoint information
2021-07-23 00:37:59 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 00:37:59 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x0f request
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'1521a1a9602a15d18b3c7e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0063'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.zigbee.application] Extending timeout for 60:a4:23:ff:fe:95:22:d7/0xa8a7
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setExtendedTimeout: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'522621a92a2ac290cc6ab5060e3593237b7e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'2626a1a92a2aa0027e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=15), 16, b'\x0f\xa7\xa8\x01')
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'632721a9602a1515f1944a21aa5592099d4e27a4fdca682c55c79a987e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'3626b1a9112a15b25991ca25aa1593499c51bb684a669874fbcb632e547f3ea57c807e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'00000005800000400100001f9cc3a7a8ffff060d00a7a8010102'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32773, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=31), 156, -61, 0xa8a7, 255, 255, b'\r\x00\xa7\xa8\x01\x01']
2021-07-23 00:37:59 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32773: b'\r\x00\xa7\xa8\x01\x01'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'4626b1a96b2a1515f1944a20aa5592099d4e27c8e3ce6743ab7e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a800000500000040010000630e0000'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=99), 14, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5727a1a9602a15d623887e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0064'
2021-07-23 00:37:59 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x11 request
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'762421a92a2ac290cc6ab5060e3593d31f7e'
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'6024a1a92a2a03707e'
2021-07-23 00:37:59 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=17), 18, b'\x11\xa7\xa8\x01')
2021-07-23 00:37:59 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'072521a9602a1515f1944a21aa5592099d4e27baffca762c55c7f4857e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'7125a1a9602a15d7a8e97e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0065'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'0125b1a9112a15b25990ca25aa1593499c6e97634a669874d4c9632e545a3ea3eac9df6e89ffc7dad5d169884625a9ec6633bcea7f824298482616b1e670301c0e17b9a5f57e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000048000004001000020b0c8a7a8ffff290f00a7a824010401040101060000010003000400060000100819000a0003000400050006000800001002'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32772, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=32), 176, -56, 0xa8a7, 255, 255, b'\x0f\x00\xa7\xa8$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10']
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32772: b'\x0f\x00\xa7\xa8$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'1125b1a96b2a1515f1944a21aa5592099d4e27cffdce6725477e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a80000040000004001000064100000'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=100), 16, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:38:00 INFO (MainThread) [zigpy.endpoint] [0xa8a7:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=260, device_version=1, input_clusters=[0, 1, 3, 4, 6, 4096], output_clusters=[25, 10, 3, 4, 5, 6, 8, 4096])
2021-07-23 00:38:00 INFO (MainThread) [zigpy.device] [0xa8a7] Read model None and manufacturer None from <Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>
2021-07-23 00:38:00 INFO (MainThread) [zigpy.device] [0xa8a7] Discovered basic device information for <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.application] Device is initialized <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for None None (60:a4:23:ff:fe:95:22:d7)
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee_io.XBeeSensor'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {232, 230} {1}
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.xbee.xbee3_io.XBee3Sensor'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.smartthings.tag_v4.SmartThingsTagV4'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Fail because profile_id mismatch on at least one endpoint
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.smartthings.multi.SmartthingsMultiPurposeSensor'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.netvox.z308e3ed.Z308E3ED'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'zhaquirks.gledopto.soposhgu10.SoposhGU10'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Fail because endpoint list mismatch: {11, 13} {1}
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'bellows.zigbee.application.EZSPCoordinator'>
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'2125b1a9112a15b25990ca25aa1593499c6f836e4a669874d4d7632e545a3ea3eac9df6e89ffc7dad5d169884625a9ec6633bcea7f824298482616b1e670301c0e17b9f69b7e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'3125b1a96b2a1515f1944a21aa5592099d4e27ceffce675d7f7e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000048000004001000021a4c5a7a8ffff291100a7a824010401040101060000010003000400060000100819000a0003000400050006000800001002'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32772, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=33), 164, -59, 0xa8a7, 255, 255, b'\x11\x00\xa7\xa8$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10']
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32772: b'\x11\x00\xa7\xa8$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a80000040000004001000065120000'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=101), 18, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 entering async_device_initialized - is_new_join: True
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 has joined the ZHA zigbee network
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): started configuration
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](unk_model): 'async_configure' stage succeeded
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): completed configuration
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): stored in registry: ZhaDeviceEntry(name='_TZ3000_xabckq1v TS004F', ieee='60:a4:23:ff:fe:95:22:d7', last_seen=1626980880.450144)
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): started initialization
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](unk_model): 'async_initialize' stage succeeded
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.device] [0xa8a7] Extending timeout for 0x13 request
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Extending timeout for 60:a4:23:ff:fe:95:22:d7/0xa8a7
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setExtendedTimeout: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'142a21a92a2ac290cc6ab5060e3593c9d77e'
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): power source: Battery or Unknown
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](unk_model): completed initialization
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'422aa1a92a2a72907e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 126 (setExtendedTimeout) received: b''
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xA8A7, EmberApsFrame(profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=19), 20, b'\x00\x13\x00\x04\x00\x05\x00')
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'252b21a9602a1515f1904b25aa5493099d4e27b8f9c96798fdc2638cfccc497e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'532ba1a9602a15d45ecc7e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0066'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'632bb1a9112a15b658944a24ab5593499c6cb76b4a669874dede7088f87e3fe5fb928a35bccff7eb8aaa08ee2548d8dd003ea5ea378415cb7c1627f7e247227e'
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'00040100000101000100002290c0a7a8ffff2318130104000042105f545a333030305f786162636b713176050000420654533030344602'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY: 256>, groupId=0, sequence=34), 144, -64, 0xa8a7, 255, 255, b'\x18\x13\x01\x04\x00\x00B\x10_TZ3000_xabckq1v\x05\x00\x00B\x06TS004F']
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.zcl] [0xa8a7:1:0x0000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=19 command_id=Command.Read_Attributes_rsp>
2021-07-23 00:38:00 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'732bb1a96b2a1515f1904b25aa5493099d4e27cdf9ce676ceb7e'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a80401000001014001000066140000'
2021-07-23 00:38:00 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=102), 20, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:38:00 INFO (MainThread) [zigpy.device] [0xa8a7] Read model 'TS004F' and manufacturer '_TZ3000_xabckq1v' from <Endpoint id=1 in=[basic:0x0000, power:0x0001, identify:0x0003, groups:0x0004, on_off:0x0006, lightlink:0x1000] out=[ota:0x0019, time:0x000A, identify:0x0003, groups:0x0004, scenes:0x0005, on_off:0x0006, level:0x0008, lightlink:0x1000] status=<Status.ZDO_INIT: 1>>
2021-07-23 00:38:00 INFO (MainThread) [zigpy.device] [0xa8a7] Discovered basic device information for <Device model='TS004F' manuf='_TZ3000_xabckq1v' nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=True>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.application] Device is initialized <Device model='TS004F' manuf='_TZ3000_xabckq1v' nwk=0xA8A7 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=True>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Checking quirks for _TZ3000_xabckq1v TS004F (60:a4:23:ff:fe:95:22:d7)
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Considering <class 'ts004f.TuyaSmartRemote004F'>
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.quirks.registry] Found custom device replacement for 60:a4:23:ff:fe:95:22:d7: <class 'ts004f.TuyaSmartRemote004F'>
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 entering async_device_initialized - is_new_join: False
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] device - 0xA8A7:60:a4:23:ff:fe:95:22:d7 has been reset and re-added or its nwk address changed
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.gateway] skipping discovery for previously discovered device - 0xA8A7:60:a4:23:ff:fe:95:22:d7
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): started configuration
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](TS004F): 'async_configure' stage succeeded
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): completed configuration
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): stored in registry: ZhaDeviceEntry(name='_TZ3000_xabckq1v TS004F', ieee='60:a4:23:ff:fe:95:22:d7', last_seen=1626980880.8568182)
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): started initialization
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0xA8A7:ZDO](TS004F): 'async_initialize' stage succeeded
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): power source: Battery or Unknown
2021-07-23 00:38:00 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xA8A7](TS004F): completed initialization
2021-07-23 00:38:00 DEBUG (MainThread) [zigpy.appdb] Device 60:a4:23:ff:fe:95:22:d7 already exists. Updating it.
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'032bb1a9112a15b259964a25aa1593499c6d9f614a669874fe6f6389fe09dc7e'
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000020000004001000023b8caa7a8ffff03a9000002'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=35), 184, -54, 0xa8a7, 255, 255, b'\xa9\x00\x00']
2021-07-23 00:38:01 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Node_Desc_req: [0x0000]
2021-07-23 00:38:01 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_req
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'132bb1a9cf2ac290cc6ab5060e3594f7d97e'
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 155 (zigbeeKeyEstablishmentHandler) received: b'd72295feff23a46006'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.zigbee.application] Received zigbeeKeyEstablishmentHandler frame with [60:a4:23:ff:fe:95:22:d7, <EmberKeyStatus.TC_RESPONDED_TO_KEY_REQUEST: 6>]
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'232bb1a9cf2ac290cc6ab5060e35a632567e'
2021-07-23 00:38:01 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 155 (zigbeeKeyEstablishmentHandler) received: b'd72295feff23a46034'
2021-07-23 00:38:01 DEBUG (MainThread) [bellows.zigbee.application] Received zigbeeKeyEstablishmentHandler frame with [60:a4:23:ff:fe:95:22:d7, <EmberKeyStatus.TC_REQUESTER_VERIFY_KEY_SUCCESS: 52>]
2021-07-23 00:38:05 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'332bb1a9112a15b25996ca25aa1593499c68e3664a669874ecc3632e547c7f27e9dd8c3d8fffeb89d5d26b92237e'
2021-07-23 00:38:05 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 00:38:05 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'432bb1a96b2a1515f1944a27aa5592099d4e27f6ebce6719ce7e'
2021-07-23 00:38:05 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 00:38:05 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000028000004001000026c4cda7a8ffff110500a7a80240800210525200002c52000002'
2021-07-23 00:38:05 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=38), 196, -51, 0xa8a7, 255, 255, b'\x05\x00\xa7\xa8\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 00:38:05 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] ZDO request ZDOCmd.Node_Desc_rsp: [<Status.SUCCESS: 0>, 0xA8A7, NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)]
2021-07-23 00:38:05 DEBUG (MainThread) [zigpy.zdo] [0xa8a7:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_rsp
2021-07-23 00:38:05 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'00a7a8000002000000400100005d060000'
2021-07-23 00:38:05 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 43175, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=93), 6, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 00:38:05 DEBUG (MainThread) [bellows.zigbee.application] Unexpected message send notification tag: 6
2021-07-23 00:38:07 DEBUG (MainThread) [bellows.ezsp.protocol] Send command nop: ()
2021-07-23 00:38:07 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'352821a9512ab2557e'
2021-07-23 00:38:07 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'5428a1a9512a75d57e'
2021-07-23 00:38:07 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 00:38:07 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 5 (nop) received: b''

ZHA was re adding the device very likely because the reconfigure was not finished OK.
So the second try is not OK.
Delete the device one more time and pressing one button to waling it up so its leaving the network.
Wait 2 minutes and restarting HA.
Then HA is stable go to development tools >  Zigbee Home Automation: Remove and putting in 60:a4:23:ff:fe:95:22:d7 as IEEE and clicking call service.
Wait 2 minutes and clicking one more time on  call service.
Wait 2 minutes and restart HA.
Then HA is stable adding the switch and looking i the log.

Hi @MattWestb , sorry for the delay it was late last night so here is the debug log
This is the debug when device is added
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendBroadcast: (<BroadcastAddress.ALL_ROUTERS_AND_COORDINATOR: 65532>, EmberApsFrame(profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_NONE: 0>, groupId=0, sequence=1), 0, 2, b'\x01<\x00')
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Send command addTransientLinkKey: (ff:ff:ff:ff:ff:ff:ff:ff, [90, 105, 103, 66, 101, 101, 65, 108, 108, 105, 97, 110, 99, 101, 48, 57])
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'34c021a9622ae94d59947c25aa5592499c4e26abefcd66b7fde9467e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'44c0a1a9622a158220f77e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'45c121a9fb2aea4da66bb5da55aac820fb0c42ceaca20be29ca800eccc47098b7e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'54c0b1a9112a10b259a24a25aa5592499c7ed8abedce9874fec75f890a397e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 54 (sendBroadcast) received: b'0030'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'050000360000000000000030ff000000ffff03013c00'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_BROADCAST_LOOPBACK: 5>, EmberApsFrame(profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_NONE: 0>, groupId=0, sequence=48), 255, 0, 0x0000, 255, 255, b'\x01<\x00']
2021-07-23 13:55:31 DEBUG (MainThread) [zigpy.zdo] [0x0000:zdo] ZDO request ZDOCmd.Mgmt_Permit_Joining_req: [60, <Bool.false: 0>]
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'65c1a1a9fb2a15e1cd7e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 175 (addTransientLinkKey) received: b'00'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setPolicy: (<EzspPolicyId.TRUST_CENTER_POLICY: 0>, <EzspDecisionBitmask.ALLOW_UNSECURED_REJOINS|ALLOW_JOINS: 3>)
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'57c621a9012a15b159eafe7e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'76c6a1a9012a15e2e67e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 85 (setPolicy) received: b'00'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'06c6b1a9772a14b33b729d073fab6d6a382e236e1b7e'
2021-07-23 13:55:31 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 35 (childJoinHandler) received: b'010162e6d72295feff23a46004'
2021-07-23 13:55:31 DEBUG (MainThread) [bellows.zigbee.application] Received childJoinHandler frame with [1, <Bool.true: 1>, 0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberNodeType.SLEEPY_END_DEVICE: 4>]
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'16c6b1a9702a77548eb6dfdb557636299d4e27ab938b7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'62e6d72295feff23a46001000000'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 13:55:32 INFO (MainThread) [zigpy.application] New device 0xe662 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 13:55:32 DEBUG (MainThread) [zigpy.device] [0xe662] Scheduling initialization
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'62c721a9212ac290cc6ab5060e3593b0fe7e'
2021-07-23 13:55:32 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 13:55:32 INFO (MainThread) [zigpy.device] [0xe662] Requesting 'Node Descriptor'
2021-07-23 13:55:32 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 13:55:32 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x03 request
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=3), 4, b'\x03b\xe6')
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'26c6b1a96b2a134ea6944a13aa5592499c4e279befce6746177e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'37c7a1a9212aea5afd7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'74c421a9602a15d0bf944a27aa5592099d4e27a8e9cd64e91b07857e'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'06fcff0000360000000000000030020000'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_BROADCAST: 6>, 65532, EmberApsFrame(profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_NONE: 0>, groupId=0, sequence=48), 2, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Send command permitJoining: (60,)
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'40c4a1a9602a158133577e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'05c521a9762a29f8727e'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0033'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'51c5a1a9762a15062c7e'
2021-07-23 13:55:32 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:32 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 34 (permitJoining) received: b'00'
2021-07-23 13:55:33 DEBUG (MainThread) [bellows.ezsp.protocol] Send command nop: ()
2021-07-23 13:55:33 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'16ca21a9512a36327e'
2021-07-23 13:55:33 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'62caa1a9512aa8377e'
2021-07-23 13:55:33 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:33 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 5 (nop) received: b''
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'72cab1a9772a14b33b729d073fab6d6a382e23b65f7e'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 35 (childJoinHandler) received: b'010162e6d72295feff23a46004'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.zigbee.application] Received childJoinHandler frame with [1, <Bool.true: 1>, 0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberNodeType.SLEEPY_END_DEVICE: 4>]
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'02cab1a9702a77548eb6dfdb557636299d4e27abf6357e'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'62e6d72295feff23a46001000000'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 13:55:34 INFO (MainThread) [zigpy.application] Device 0xe662 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 13:55:34 DEBUG (MainThread) [zigpy.device] [0xe662] Scheduling initialization
2021-07-23 13:55:34 DEBUG (MainThread) [zigpy.device] [0xe662] Canceling old initialize call
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'21cb21a9212ac290cc6ab5060e35936f1c7e'
2021-07-23 13:55:34 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 13:55:34 INFO (MainThread) [zigpy.device] [0xe662] Requesting 'Node Descriptor'
2021-07-23 13:55:34 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 13:55:34 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x05 request
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=5), 6, b'\x05b\xe6')
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'13cba1a9212aeafe2e7e'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'32c821a9602a15d0bf944a27aa5592099d4e27aeebcd62e91beafb7e'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'24c8a1a9602a1584b34c7e'
2021-07-23 13:55:34 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 13:55:34 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0036'
2021-07-23 13:55:40 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'34c8b1a9772a14b33b729d073fab6d6a382e2363687e'
2021-07-23 13:55:40 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 35 (childJoinHandler) received: b'010162e6d72295feff23a46004'
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.zigbee.application] Received childJoinHandler frame with [1, <Bool.true: 1>, 0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberNodeType.SLEEPY_END_DEVICE: 4>]
2021-07-23 13:55:40 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'44c8b1a9702a77548eb6dfdb557636299d4e27ab5aed7e'
2021-07-23 13:55:40 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'62e6d72295feff23a46001000000'
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 13:55:40 INFO (MainThread) [zigpy.application] Device 0xe662 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 13:55:40 DEBUG (MainThread) [zigpy.device] [0xe662] Scheduling initialization
2021-07-23 13:55:40 DEBUG (MainThread) [zigpy.device] [0xe662] Canceling old initialize call
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:40 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'45c921a9212ac290cc6ab5060e3593b5717e'
2021-07-23 13:55:40 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 13:55:40 INFO (MainThread) [zigpy.device] [0xe662] Requesting 'Node Descriptor'
2021-07-23 13:55:40 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 13:55:40 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x07 request
2021-07-23 13:55:40 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=7), 8, b'\x07b\xe6')
2021-07-23 13:55:41 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'55c9a1a9212aea09a77e'
2021-07-23 13:55:41 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:41 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'56ce21a9602a15d0bf944a27aa5592099d4e27ace5cd60e91b2c107e'
2021-07-23 13:55:41 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 13:55:41 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'66cea1a9602a158b9af07e'
2021-07-23 13:55:41 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:41 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'0039'
2021-07-23 13:55:42 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'76ceb1a9772a14b33b729d073fab6d6a382e230ee77e'
2021-07-23 13:55:42 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 13:55:42 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 35 (childJoinHandler) received: b'010162e6d72295feff23a46004'
2021-07-23 13:55:42 DEBUG (MainThread) [bellows.zigbee.application] Received childJoinHandler frame with [1, <Bool.true: 1>, 0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberNodeType.SLEEPY_END_DEVICE: 4>]
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'06ceb1a9702a77548eb6dfdb557636299d4e27ab68e67e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 36 (trustCenterJoinHandler) received: b'62e6d72295feff23a46001000000'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Received trustCenterJoinHandler frame with [0xe662, 60:a4:23:ff:fe:95:22:d7, <EmberDeviceUpdate.STANDARD_SECURITY_UNSECURED_JOIN: 1>, <EmberJoinDecision.USE_PRECONFIGURED_KEY: 0>, 0x0000]
2021-07-23 13:55:43 INFO (MainThread) [zigpy.application] Device 0xe662 (60:a4:23:ff:fe:95:22:d7) joined the network
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.device] [0xe662] Scheduling initialization
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.device] [0xe662] Canceling old initialize call
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Send command findKeyTableEntry: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 13:55:43 INFO (MainThread) [zigpy.device] [0xe662] Requesting 'Node Descriptor'
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.util] Tries remaining: 2
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x09 request
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=9), 10, b'\tb\xe6')
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'61cf21a9212ac290cc6ab5060e3593b8b07e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'17cfa1a9212aea39497e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'72cc21a9602a15d0bf944a27aa5592099d4e27a2e7cd6ee91bac4e7e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 117 (findKeyTableEntry) received: b'ff'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'20cca1a9602a158edcad7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'003c'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'30ccb5a9362ac290cc6ab5060e35696b7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 98 (incomingSenderEui64Handler) received: b'd72295feff23a460'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Received incomingSenderEui64Handler frame with [60:a4:23:ff:fe:95:22:d7]
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'40ccb1a9112a11b259874a25aa5596499c0dff798f289874f16c016f2b5caa5914ee7a0f0ffd7b737e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'040000130000000004000043d8d262e6ffff0caa62e6d72295feff23a4608002'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_BROADCAST: 4>, EmberApsFrame(profileId=0, clusterId=19, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_SOURCE_EUI64: 1024>, groupId=0, sequence=67), 216, -46, 0xe662, 255, 255, b'\xaab\xe6\xd7"\x95\xfe\xff#\xa4`\x80']
2021-07-23 13:55:43 INFO (MainThread) [bellows.zigbee.application] ZDO Device announce: 0xe662, 60:a4:23:ff:fe:95:22:d7
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 19: b'\xaab\xe6\xd7"\x95\xfe\xff#\xa4`\x80'
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.zdo] [0xe662:zdo] ZDO request ZDOCmd.Device_annce: [0xE662, 60:a4:23:ff:fe:95:22:d7, 128]
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x0b request
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=11), 12, b'\x0bb\xe6')
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'05cd21a9602a15d0bf944a27aa5592099d4e27a0e1cd6ce91b38997e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'50ccb1a9112a15b25996ca25aa1593499c0aff798f289874eccf63eb1a7c7f27e9dd8c3d8fffeb89d5d26b66d37e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'60ccb1a96b2a15d0bf944a27aa5592099d4e2797e7ce67effb7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'71cda1a9602a158ff85a7e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000028000004001000044d8d262e6ffff11090062e60240800210525200002c52000002'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=68), 216, -46, 0xe662, 255, 255, b'\t\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\t\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.zdo] [0xe662:zdo] ZDO request ZDOCmd.Node_Desc_rsp: [<Status.SUCCESS: 0>, 0xE662, NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)]
2021-07-23 13:55:43 DEBUG (MainThread) [zigpy.zdo] [0xe662:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_rsp
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'0062e6000002000000400100003c0a0000'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 58978, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=60), 10, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.zigbee.application] Unexpected message send notification tag: 10
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'003d'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Send command nop: ()
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'10d221a9512abda47e'
2021-07-23 13:55:43 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'02d2a1a9512af1587e'
2021-07-23 13:55:43 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 5 (nop) received: b''
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'12d2b1a96b2a134fa6944a36aa559249984e27e8edce6736ad7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'82503a7e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'06fdff0000130000000004000043000000'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_BROADCAST: 6>, 65533, EmberApsFrame(profileId=0, clusterId=19, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_SOURCE_EUI64: 1024>, groupId=0, sequence=67), 0, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Unexpected message send notification tag: 0
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'22d2b1a9112a15b25996ca25aa1593499c0bfb788f289874eccd63eb1a7c7f27e9dd8c3d8fffeb89d5d26bcb2d7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'83401b7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'32d2b1a96b2a15d0bf944a27aa5592099d4e2796e1ce678f437e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'42d2b1a9112a15b25996ca25aa1593499c08ff798f289874ecc363eb1a7c7f27e9dd8c3d8fffeb89d5d26b7ec07e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'52d2b1a96b2a15d0bf944a27aa5592099d4e279debce67f7a97e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000028000004001000045dcd362e6ffff110b0062e60240800210525200002c52000002'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=69), 220, -45, 0xe662, 255, 255, b'\x0b\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x0b\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'0062e6000002000000400100003d0c0000'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 58978, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=61), 12, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000028000004001000046d8d262e6ffff11050062e60240800210525200002c52000002'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32770, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=70), 216, -46, 0xe662, 255, 255, b'\x05\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00']
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32770: b'\x05\x00b\xe6\x02@\x80\x02\x10RR\x00\x00,R\x00\x00'
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.zdo] [0xe662:zdo] ZDO request ZDOCmd.Node_Desc_rsp: [<Status.SUCCESS: 0>, 0xE662, NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)]
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.zdo] [0xe662:zdo] Unsupported ZDO request:ZDOCmd.Node_Desc_rsp
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'0062e60000020000004001000036060000'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 58978, EmberApsFrame(profileId=0, clusterId=2, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=54), 6, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Unexpected message send notification tag: 6
2021-07-23 13:55:44 INFO (MainThread) [zigpy.device] [0xe662] Got Node Descriptor: NodeDescriptor(logical_type=<LogicalType.EndDevice: 2>, complex_descriptor_available=0, user_descriptor_available=0, reserved=0, aps_flags=0, frequency_band=<FrequencyBand.Freq2400MHz: 8>, mac_capability_flags=<MACCapabilityFlags.AllocateAddress: 128>, manufacturer_code=4098, maximum_buffer_size=82, maximum_incoming_transfer_size=82, server_mask=11264, maximum_outgoing_transfer_size=82, descriptor_capability_field=<DescriptorCapability.0: 0>, *allocate_address=True, *is_alternate_pan_coordinator=False, *is_coordinator=False, *is_end_device=True, *is_full_function_device=False, *is_mains_powered=False, *is_receiver_on_when_idle=False, *is_router=False, *is_security_capable=False)
2021-07-23 13:55:44 INFO (MainThread) [zigpy.device] [0xe662] Discovering endpoints
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.util] Tries remaining: 3
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x0d request
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Extending timeout for 60:a4:23:ff:fe:95:22:d7/0xe662
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setExtendedTimeout: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'26d321a92a2ac290cc6ab5060e3593e0637e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'63d3a1a92a2a95127e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 126 (setExtendedTimeout) received: b''
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=13), 14, b'\rb\xe6')
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'37d021a9602a15d0bf944a20aa5592099d4e27a6e3cd6ae91b971c7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'74d0a1a9602a158c5df67e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8070787e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'003e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'04d0b1a9112a15b25991ca25aa1593499c09fb788f289874fbcb63eb1a7f3ea55db67e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8160597e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'14d0b1a96b2a15d0bf944a20aa5592099d4e2795e3ce6787f37e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000058000004001000047dcd362e6ffff060d0062e6010102'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32773, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=71), 220, -45, 0xe662, 255, 255, b'\r\x00b\xe6\x01\x01']
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32773: b'\r\x00b\xe6\x01\x01'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'0062e6000005000000400100003e0e0000'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 58978, EmberApsFrame(profileId=0, clusterId=5, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=62), 14, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:44 INFO (MainThread) [zigpy.device] [0xe662] Discovered endpoints: [1]
2021-07-23 13:55:44 INFO (MainThread) [zigpy.device] [0xe662] Initializing endpoints [<Endpoint id=1 in=[] out=[] status=<Status.NEW: 0>>]
2021-07-23 13:55:44 INFO (MainThread) [zigpy.endpoint] [0xe662:1] Discovering endpoint information
2021-07-23 13:55:44 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x0f request
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'42d121a92a2ac290cc6ab5060e35933a0e7e'
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'25d1a1a92a2a36607e'
2021-07-23 13:55:44 DEBUG (MainThread) [bellows.ezsp.protocol] Send command sendUnicast: (<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 0xE662, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=15), 16, b'\x0fb\xe6\x01')
2021-07-23 13:55:44 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'53d621a9602a15d0bf944a21aa5592099d4e27a4fdca68e91bc7c7d37e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'36d6a1a9602a158d95847e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8430fc7e'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 52 (sendUnicast) received: b'003f'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'46d6b1a9112a15b25990ca25aa1593499c06ff798f289874d4c963eb1a5a3ea3eac9df6e89ffc7dad5d169884625a9ec6633bcea7f824298482616b1e670301c0e17b9d82a7e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8520dd7e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'56d6b1a96b2a15d0bf944a21aa5592099d4e2794fdce67dd6f7e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'8610be7e'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 69 (incomingMessageHandler) received: b'000000048000004001000048d8d262e6ffff290f0062e624010401040101060000010003000400060000100819000a0003000400050006000800001002'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.zigbee.application] Received incomingMessageHandler frame with [<EmberIncomingMessageType.INCOMING_UNICAST: 0>, EmberApsFrame(profileId=0, clusterId=32772, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=72), 216, -46, 0xe662, 255, 255, b'\x0f\x00b\xe6$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10']
2021-07-23 13:55:45 DEBUG (MainThread) [zigpy.application] Received frame on uninitialized device <Device model=None manuf=None nwk=0xE662 ieee=60:a4:23:ff:fe:95:22:d7 is_initialized=False> from ep 0 to ep 0, cluster 32772: b'\x0f\x00b\xe6$\x01\x04\x01\x04\x01\x01\x06\x00\x00\x01\x00\x03\x00\x04\x00\x06\x00\x00\x10\x08\x19\x00\n\x00\x03\x00\x04\x00\x05\x00\x06\x00\x08\x00\x00\x10'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 63 (messageSentHandler) received: b'0062e6000004000000400100003f100000'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.zigbee.application] Received messageSentHandler frame with [<EmberOutgoingMessageType.OUTGOING_DIRECT: 0>, 58978, EmberApsFrame(profileId=0, clusterId=4, sourceEndpoint=0, destinationEndpoint=0, options=<EmberApsOption.APS_OPTION_ENABLE_ROUTE_DISCOVERY|APS_OPTION_RETRY: 320>, groupId=0, sequence=63), 16, <EmberStatus.SUCCESS: 0>, b'']
2021-07-23 13:55:45 INFO (MainThread) [zigpy.endpoint] [0xe662:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=260, device_version=1, input_clusters=[0, 1, 3, 4, 6, 4096], output_clusters=[25, 10, 3, 4, 5, 6, 8, 4096])
2021-07-23 13:55:45 DEBUG (MainThread) [zigpy.device] [0xe662] Extending timeout for 0x11 request
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.zigbee.application] Extending timeout for 60:a4:23:ff:fe:95:22:d7/0xe662
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.ezsp.protocol] Send command setExtendedTimeout: (60:a4:23:ff:fe:95:22:d7, True)
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'66d721a92a2ac290cc6ab5060e359337cf7e'
2021-07-23 13:55:45 INFO (MainThread) [pyhap.hap_protocol] ('<IP_ADDRESS>', 50916): Connection made to HASS Bridge 34SC
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Data frame: b'67d7a1a92a2a1ab57e'
2021-07-23 13:55:45 DEBUG (bellows.thread_0) [bellows.uart] Sending: b'87009f7e'
2021-07-23 13:55:45 DEBUG (MainThread) [bellows.ezsp.protocol] Application frame 126 (setExtendedTimeout) received: b''