home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
72.42k stars 30.31k forks source link

HomeKit controller fails to pair with schlage SENSE lock due to missing format in one of the tlv responses #76104

Closed TravisRoy closed 2 years ago

TravisRoy commented 2 years ago

The problem

When I go to add a HomeKit lock, I get an error in the UI that the device is already paired, even after factory resetting it.

What version of Home Assistant Core has the issue?

core-2022.8.0b6

What was the last working version of Home Assistant Core?

No response

What type of installation are you running?

Home Assistant OS

Integration causing the issue

HomeKit Controller

Link to integration documentation on our website

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

Diagnostics information

No response

Example YAML snippet

No response

Anything in the logs that might be useful for us?

Logger: homeassistant.components.homekit_controller.config_flow
Source: components/homekit_controller/config_flow.py:561
Integration: homekit_controller (documentation, issues)
First occurred: 7:42:04 PM (1 occurrences)
Last logged: 7:42:04 PM

Pairing attempt failed with an unhandled exception
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 447, in async_step_pair
    return await self._entry_from_accessory(pairing)
  File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 561, in _entry_from_accessory
    name = await pairing.get_primary_name()
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/abstract.py", line 143, in get_primary_name
    accessories = await self.list_accessories_and_characteristics()
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 102, in _async_wrap
    return await func(self, *args, **kwargs)
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/client.py", line 63, in _async_wrap
    return await func(*args, **kwargs)
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 503, in list_accessories_and_characteristics
    await self._populate_accessories_and_characteristics()
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 575, in _populate_accessories_and_characteristics
    accessories = await self._async_fetch_gatt_database()
  File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 468, in _async_fetch_gatt_database
    hap_char.format = decoded["format"]
KeyError: 'format'

Additional information

No response

probot-home-assistant[bot] commented 2 years ago

homekit_controller documentation homekit_controller source (message by IssueLinks)

probot-home-assistant[bot] commented 2 years ago

Hey there @jc2k, @bdraco, mind taking a look at this issue as it has been labeled with an integration (homekit_controller) you are listed as a code owner for? Thanks! (message by CodeOwnersMention)

TravisRoy commented 2 years ago

I am Sc00ter on Discord, and I'm on the HA server, feel free to reach out to me directly there if you want to do some live troubleshooting.

bdraco commented 2 years ago

It would be helpful to get debug logs for aiohomekit, and to know which brand/model of lock you are trying to pair.

TravisRoy commented 2 years ago

@bdraco How do I get the debugging on for aiohomekit? The lock is a Schlage Sense. Link to the user guide - https://www.schlage.com/content/dam/sch-us/documents/pdf/installation-manuals/Schlage-Sense-User-Guide-P516-991.pdf

Jc2k commented 2 years ago

There is documentation on configuring logging here:

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

You need to turn it to debug for aiohomekit and homeassistant.components.homekit_controller.

At a glance I think it is pairing with your lock, but when its trying to fetch the GATT data its failing before it saves the pairing keys. It could be we are trying to fetch info on a non homekit bluetooth characteristic or that your device doesn't have a full GATT database and we need to fallback to a sensible default. Then either its auto retrying or you are retrying and it reports its already paired. But that is a stab in the dark without the full logs.

TravisRoy commented 2 years ago

I'll get the logs and report back, thanks @Jc2k

TravisRoy commented 2 years ago
2022-08-03 08:52:12.647 DEBUG (MainThread) [aiohomekit.controller.ble.controller] Starting BLE controller with instance: <homeassistant.components.bluetooth.models.HaBleakScannerWrapper object at 0x7f573c1660>
2022-08-03 08:52:26.571 DEBUG (MainThread) [aiohomekit.controller.ble.discovery] Ensure connected with device DD:07:2C:27:5A:3C: SENSE
2022-08-03 08:52:38.772 ERROR (MainThread) [homeassistant] Error doing job: Task was destroyed but it is pending!
2022-08-03 08:52:41.873 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:52:41.873 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x03\xd9/\x00'
2022-08-03 08:52:42.039 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\xd9\x00\x03\x00\x01\x01\x01')
2022-08-03 08:52:42.042 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d9 (Expected: d9), Status:0, Len:3
2022-08-03 08:52:42.043 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-03 08:52:42.113 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x01
0: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-03 08:52:42.114 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:52:42.114 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02\x1a-\x00\x0b\x00\t\x01\x01\x01\x06\x06\x01\x01\x00\x01\x01'
2022-08-03 08:52:47.026 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\x1a\x00\x9d\x01\x01\xff\x06\x01\x02\x03\xff\xbf\x11\x16\xd4d\x8a\x88H\xe3WqV \xadUQ\x91kuvqC\xff\xa2pQ\x9d{\xfaVE\x1c\x8d\x1f5LC\xd9I\xa6~]3Yd\xb9Q\xef\x83\x90\xf8t\xf5\xdd>\xc45\x12\xe3\xde\xcd\xaf\x040\xc4\x89\x93\xd6\x1a\x10\xac\xa4\x9e\to\xc0\xa0SI\x1f!pB\xd2/-\x8a_')
2022-08-03 08:52:47.026 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 1a (Expected: 1a), Status:0, Len:95
2022-08-03 08:52:47.107 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x1as^!\xc7\xd3\x8d\x0c}\xc7S\xb30}\xf1Xb\xf9\xd7\xc0\xb23\x03\r\x944X\x1cz\x0c\xb5\xd5\xd0/\xe0\x12yjm\xe3\x9f\xdaJs\x88_(\xf3\xb9\xc1t\x83\xb0\xbe\xb0\x808\xae&BV\x0eY6E\x01\xdd\xd3\xac\x88s`\xc1g\xf7\x8d\xeb\x81\xd8\x0c\xfe\xb4\x19\xf4^\x98\xf5p\xb5\xab\xc8\xa4\x1d\xd5\xba\xect\xaab')
2022-08-03 08:52:47.107 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 1a (Expected: 1a) Len:98
2022-08-03 08:52:47.189 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x1a\x1d\xb7\xe3\xe7\n\\\xcf-\x96\xfd\xb8\xb0Jh\x86\xf7\xda\x8f&\x0c\x9a\x13\x1b\xbfSo\xf1\x025-L\xfa\x8a\xa3\x9cB\xe0,I\xa8\xcec\xdc3]\xa9kX\xd6@n\xb0\\\xf7A\x14\xfc\x03\xd01^\xdc\xe2}\x01\x9a\xb0\xae;\xd5r\x03\x81\x85\xd3\xc6\xb6\x16\xaa\x03\xb3\x90\x03CC\xf9\xaa7\xf5\x8c\xb7\xf4DK4\xe6\xe3\x90')
2022-08-03 08:52:47.189 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 1a (Expected: 1a) Len:98
2022-08-03 08:52:47.271 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b"\x82\x1a\xaa\xd6H\x8bi\xff\xaaMg\x99-\t\xf1N\xab\xa4\xf7\xa7\xe7,\x0f~\x16\xcf\xbfS\x00b\xbb\x8f{?\x14\xa4\x8b\x820\xdc\x13_t\xddX\xbcryl\x8aJ\xae\x0f\x8c\xa2f\x16\x06\x91\xe2]\x84\xf3\xe5\xa6n\xc90\xeb\xf5\x95\xfe\xcb[\xb4@j\xf0!\x95\xe7\x81\xb2~bO\rY\xc4\x97\x90\xe8\x83H1O\xd8\'\xf0\x80")
2022-08-03 08:52:47.272 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 1a (Expected: 1a) Len:98
2022-08-03 08:52:47.353 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x1a\xcfj\xf0a\xf5\x85\x02\x10\x15\x8aT\x1eu\x986Sp#]\xae\xbe\xaf\xb7\x8d')
2022-08-03 08:52:47.353 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 1a (Expected: 1a) Len:24
2022-08-03 08:52:47.353 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (409 bytes/<class 'bytearray'>) 0x06010203ffbf1116d4648a8848e357715620ad5551916b75767143ffa270519d7bfa56451c8d1f354c43d949a67e5d335964b951ef8390f874f5dd3ec43512e3decdaf0430c48993d61a10aca49e096fc0a053491f217042d22f2d8a5f735e21c7d38d0c7dc753b3307df15862f9d7c0b233030d9434581c7a0cb5d5d02fe012796a6de39fda4a73885f28f3b9c17483b0beb08038ae2642560e59364501ddd3ac887360c167f78deb81d80cfeb419f45e98f570b5abc8a41dd5baec74aa621db7e3e70a5ccf2d96fdb8b04a6886f7da8f260c9a131bbf536ff102352d4cfa8aa39c42e02c49a8ce63dc335da96b58d6406eb05cf74114fc03d0315edce27db0ae3bd572038185d3c6b616aa03b390034343f9aa37f58cb7f4444b34e6e390aad6488b69ffaa4d67992d09f14eaba4f7a7e72c0f7e16cfbf530062bb8f7b3f14a48b8230dc135f74dd58bc72796c8a4aae0f8ca266160691e25d84f3e5a66ec930ebf595fecb5bb4406af02195e781b27e624f0d59c49790e88348314fd827f080cf6af061f5850210158a541e7598365370235daebeafb78d
]
2022-08-03 08:52:47.354 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x02
3: (384 bytes/<class 'bytearray'>) 0xbf1116d4648a8848e357715620ad5551916b75767143ffa270519d7bfa56451c8d1f354c43d949a67e5d335964b951ef8390f874f5dd3ec43512e3decdaf0430c48993d61a10aca49e096fc0a053491f217042d22f2d8a5f735e21c7d38d0c7dc753b3307df15862f9d7c0b233030d9434581c7a0cb5d5d02fe012796a6de39fda4a73885f28f3b9c17483b0beb08038ae2642560e59364501ddd3ac887360c167f78deb81d80cfeb419f45e98f570b5abc8a41dd5baec74aa621db7e3e70a5ccf2d96fdb8b04a6886f7da8f260c9a131bbf536ff102352d4cfa8aa39c42e02c49a8ce63dc335da96b58d6406eb05cf74114fc03d0315edce27db0ae3bd57285d3c6b616aa03b390034343f9aa37f58cb7f4444b34e6e390aad6488b69ffaa4d67992d09f14eaba4f7a7e72c0f7e16cfbf530062bb8f7b3f14a48b8230dc135f74dd58bc72796c8a4aae0f8ca266160691e25d84f3e5a66ec930ebf595fecb5bb4406af02195e781b27e624f0d59c49790e88348314fd827f080cf6af061f585
2: (16 bytes/<class 'bytearray'>) 0x158a541e7598365370235daebeafb78d
]
2022-08-03 08:53:00.914 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x03
3: (384 bytes/<class 'bytearray'>) 0x94acca4f0d179c4b9602ae485c2cd75ed4d758ce20517b61d699b2ef4964fe50c391ba98778a5e5a022225d103bc75af8dfae631238aa19d09232698f45b19fab5c90d5555ea4a76b0b01b177b756917047b633d09347218692b5ea3ff9fe234dd2951db63948a2954fe97953c67a98db4b099d369cac1abea113af62212e90f08b085879536360be9f924daca9e38ce390d59493e0805a0972c65dfa02043416f3f34f311f48df36f2e8c41ba2fe2c63e17867385627a5eb5f2f857daf7f5163441af5799c435a7eaf1520670952edf0f710a2d40ca3f9f38eb92957182b4cf47ae4c72bf0d47c2119a6b4463a11d4249920775b556bc3c4dad95aa08f96f62e240d1bc581a1c17f42a2e0e36422b72035c55ade9f7f050b093d2668e7b0197287ff84500d3d2c4b083f1f29c25eb09cdb52bcd2caa9e2638bbd7aeef89a4d875a9a1aea23dd62ac28a31911ecf607141a873e659f347003648d18cf129a1506c5d6e89271d12e98158ddb6fe4b3a09b2eb398c64153e1f834a5f77317f3680
4: (64 bytes/<class 'bytearray'>) 0xf789c19bba70bb553309c9bb17a18cdd6d3591d1dc59b26c6d5aa6e49fa0478d9678efcfcd33fa64b6227e571407cf00725466892a0bd459d28273c3be773e18
]
2022-08-03 08:53:00.915 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:53:00.915 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02k-\x00\xd0\x01\t\x01\x01\x01\xff\x06\x01\x03\x03\xff\x94\xac\xcaO\r\x17\x9cK\x96\x02\xaeH\\,\xd7^\xd4\xd7X\xce Q{a\xd6\x99\xb2\xefId\xfeP\xc3\x91\xba\x98w\x8a^Z\x02"%\xd1\x03\xbcu\xaf\x8d\xfa\xe61#\x8a\xa1\x9d\t#&\x98\xf4[\x19\xfa\xb5\xc9\rUU\xeaJv\xb0\xb0\x1b\x17{ui\x17'
2022-08-03 08:53:00.916 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x80k\x04{c=\t4r\x18i+^\xa3\xff\x9f\xe24\xdd)Q\xdbc\x94\x8a)T\xfe\x97\x95<g\xa9\x8d\xb4\xb0\x99\xd3i\xca\xc1\xab\xea\x11:\xf6"\x12\xe9\x0f\x08\xb0\x85\x87\x9566\x0b\xe9\xf9$\xda\xca\x9e8\xce9\rYI>\x08\x05\xa0\x97,e\xdf\xa0 CAo?4\xf3\x11\xf4\x8d\xf3o.\x8cA\xba/\xe2'
2022-08-03 08:53:00.916 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x80k\xc6>\x17\x86s\x85bz^\xb5\xf2\xf8W\xda\xf7\xf5\x164A\xafW\x99\xc45\xa7\xea\xf1R\x06p\x95.\xdf\x0fq\n-@\xca?\x9f8\xeb\x92\x95q\x82\xb4\xcfG\xaeLr\xbf\rG\xc2\x11\x9akDc\xa1\x1dBI\x92\x07u\xb5V\xbc<M\xad\x01\xca\x95\xaa\x08\xf9o\x03\x81b\xe2@\xd1\xbcX\x1a\x1c\x17\xf4*'
2022-08-03 08:53:00.916 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b"\x80k.\x0e6B+r\x03\\U\xad\xe9\xf7\xf0P\xb0\x93\xd2f\x8e{\x01\x97(\x7f\xf8E\x00\xd3\xd2\xc4\xb0\x83\xf1\xf2\x9c%\xeb\t\xcd\xb5+\xcd,\xaa\x9e&8\xbb\xd7\xae\xef\x89\xa4\xd8u\xa9\xa1\xae\xa2=\xd6*\xc2\x8a1\x91\x1e\xcf`qA\xa8s\xe6Y\xf3G\x006H\xd1\x8c\xf1)\xa1Pl]n\x89'\x1d\x12\xe9\x81"
2022-08-03 08:53:00.916 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x80kX\xdd\xb6\xfeK:\t\xb2\xeb9\x8cd\x15>\x1f\x83J_w1\x7f6\x80\x04@\xf7\x89\xc1\x9b\xbap\xbbU3\t\xc9\xbb\x17\xa1\x8c\xddm5\x91\xd1\xdcY\xb2lmZ\xa6\xe4\x9f\xa0G\x8d\x96x\xef\xcf\xcd3\xfad\xb6"~W\x14\x07\xcf\x00rTf\x89*\x0b\xd4Y\xd2\x82s\xc3\xbew>\x18'
2022-08-03 08:53:01.416 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.rest
2022-08-03 08:53:11.417 WARNING (MainThread) [homeassistant.components.sensor] Setup of sensor platform rest is taking over 10 seconds.
2022-08-03 08:53:15.941 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02k\x00\x7f\x04\x01\xff\x06\x01\x04\x04@\xca\x8c bq\x83\xba\xd4pf\xf3\x03\xa3\xeb\x8f\x02\x12\x8d\x1bd\x1a\xf2jN\xa2\xac\x9dG\xfaY\xb1\x8f=ES\xea\x031UL\xac8-#!\xd3\x80\x08nq\x87\x07\x06\xff1\xb8\x7fb\xb2\xd4BA#v\x05\xff\x9d\xd8\xaf\x01\xc8\xad\xb5\xfd\x87\xe6\xbbr\x80M\xa5\x05\xfd<\xd0\x1f\xc4\x9d')
2022-08-03 08:53:15.941 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6b (Expected: 6b), Status:0, Len:95
2022-08-03 08:53:16.027 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b"\x82k@\xfc\t1A\xd5^\xfb\xeb\xcdP\x9eLJ\xf9\xd8\x0e\xb1\xea\xd3\n\xe7\xd1\xbf1\xa5&\'\xd6\x9b\x90\xa6\x032\x9a\x17\xa1\xb1\x90<d\xab\x08\xf7\xf2\xc0V\x19\xb8j\x0f;\x80F3\xcd\xe3Uh\xe4{\x91u\xf9\xd5\xe2\xd3\xcb\x116\x97O\xaau\xeb\xd6K\xa8?\xfa\x82\xfcl\xd8\xbeG\xe8\x0ft1\xcf_\xad\ro\xc2\xd9\xc7")
2022-08-03 08:53:16.027 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.147 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\xa8/\x87\x8b\x84\xd1\xb26\xb0k\xc4\x1e\xca\xb1@o\x99J\x98\x88uhU\xfd<\xbeNJ\x1f\x1f\x99\x11u\xf0\xf3\xe9W\x80\xef\xfee\xc8\x8b\xb6\x9f\xf2\x85\xfe\x19V\x1cq\xad\x18\xcb2\x16\xff\x7fR\xba!Pe\x01\xff\xf83V\xef1b\xee1\xd1\xabt%}\x92\xf9\n\x1f`\xb2n\x1b\xf9#\n\xf3\xf3\xac\xa4\xbe\xbf\xab\xe7')
2022-08-03 08:53:16.147 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.271 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b"\x82k\xf4J\xc7\xec\xe4\'\x99Gc\xedUL\xc8=\x1e\x92D\xf4X\xa6\xad\xa6\xa1\xe2\xaa\xde\xad5`\x7f\xb9\xbc\xc9!\xc1<\x10\x01\xe7\x05\xff\xb9\x8f\xcaY\x95}i\xa9\xe9\xfc\x90\xa2\x89\x19\xc1+,=4\xa1\xca\x9d\x17u\xb0\xb5 \xc7w\x12S\xd6e\r\x9e\xffs\xb9dp\x01>\x9e[\xb3\xe6\xe0?\xf5\x13\x1d\xb8\xa3\x9e\xbb3\xfb")
2022-08-03 08:53:16.271 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.353 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b"\x82k2{\x8c\xad_\xa1\xfb\xf9\xf7H\x9d \x0er&\xc0\x8c2F\xdd\x8dCK\'fE\x9c7w|r\xef-\xa8\xa39\x92\x8a5\xe0\xe6f\xbdV\tG\xf8\xd5]\x80\xeeyz\xa7\x0em\xbf\x05\xf4\xddq@\xf2\xad\xe1E\xa4t\xb0\x9e\xf1\xe1&E\xf7\xe38T\x82\xcc\xc6\xe3\xa2\t\xf9\xe4\xb1C\x9a\x03Q&\x0b\xc9kW\xbeM")
2022-08-03 08:53:16.353 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.477 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\xc6k\xde%<%7\xc8\x11\n|\xea4\xb3\xd8\xe7{r\xdfL\xb8\x91\x88\x83Q\x1f\x92\x01\xff=\xbf\x8b\x8b\xa8\x00\xba\xfa\x08\x0c3\x0c\xc0t\xc6r\xb4m\x0f\xfag\xca\xa3%gAZQ`3\xa1\x81\xd3\x18A^\x97\xcb\x9e\x9f\xd7:\xd4lrO\x0b\xcc\x0fp\x94v&\xa8e\x15\x8bW(W\x9ed?Y\x96C`\xcbm')
2022-08-03 08:53:16.477 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.602 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\x8d\xce1\x14\x05\xffit@\xd6\xb7&\xa4\t\x840\x80\x95\xb9i\x03\x9e\x9d\x9c2\x8b\x85\xb2c2\xb6LS\xe7\xb1\x9b\xb0\t\xed\xcd\xd8\xcd\xce\xd5L\x8f\xb038!\xf6U\xbd\x12\xda6\x98\xdc\x1e\x15[\x02\x7f!\xa9l\xc4A%UjU$t3\t\x8cmb\x87\x93&\xb0O\x8c\xf0\x0c9\x85e\x1e.\x91\x00D\xda\x04=')
2022-08-03 08:53:16.602 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.724 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\x95\x95~\x9b\xb0\'\xdf\xef\xc9\x97g\x84\xc7\xff\xd0\t\x83\xa9\x98\xc9\xcc\xd9\x86\x9a\x1e\x07\x8c\xbe\x16E%\x0f\xa8s\xd5hKL\xb0\x10\x91\xa9\xffk\xeb\xeb\xe3\xdb\xb6([!1\x9d\x12\xa9"\xe0\x1b\x07\x1f\xe6\x9b/\x0b\xe9\xd1\x9b\x80_%o\xfa\xd1\xab\x0e\xed\xe2\xc66\n\xd0\xf1\x01\x1c\xdd\xb47\x01\xff\xce~1\xdc\xb2g\x91c')
2022-08-03 08:53:16.725 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.848 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k/\xfbfv_\xfa\x8d\xf4\x80S\xc7\x00\xae\x16:\xc7-\xf6\x1d?\xacf\xd9\xf8\t\xae\x03L\xd1\x1d\xe8\x08\xaa5\xfbde\xfc\xff\xaa\x07\x9a\xc6\xaa\xe4\x06M\x0f\xb8"lZ\xcc\x95d\xad\x11v\xbf\xa4W\x93\xea\x9fnR\x8f\x05\xff\\\x89\xab|\xb1=\xb7\xcb\x9d]\xa9\xb3`\xf2l#\xceQ\xfa\xad=\xfd\x9ay\xd66\x16.\xe2')
2022-08-03 08:53:16.848 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:16.971 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\xedd\xf9\xc5&\xa3-_\x1e\x03\xa8>\xee\xd4\x93\xfd\xa2\xd8h\xe9M\xf3D\xe9\xfc\xff\xb7\x01\x94\xbf\\b\xd5\xbaS\xdb\xa4\x08a\xd96\xbd\x8c\t\x01\x86b\xbbx\x0b\xa1Rg"4\xc2\x1c\x14\x8b\xe2\x10s\xe0H(\xdd"\xc0\xdc\x14\xe5\x87j\xeb\xb6AD\x01\xc2\xba\xf4\xa2Z\xfc\x87\x9b*\x96i\x8e\x94\xe5\xe0(\x0cy\x8d=')
2022-08-03 08:53:16.972 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:17.097 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82k\x8c\xec\xc5G\xbd\xe2\xa8\x9d_\x90\xe8.\xff\x1fx\x1f\x1e\x947C-T\x01.\x0b\xb8\xf80w:+\xfa\x0b\xb7\xe7\xdfk\xaeM\x07\xa8\xf4:K\xd6(\x0fX_\x8b\xa0\x01y\xb6U\xfd\x9c\xb6W\xe3\xa3\xba\x14\x93\xf7R\x1e\x9fJ\x94V$]\x8a\xe7.j\xcd\x93\x17\x0c\xba\x00ku9\xc2\x07\xc2|(\xdd\x11\xb2<\xbd.\xca')
2022-08-03 08:53:17.098 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:98
2022-08-03 08:53:17.179 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82knK@\xb7\xc0\x9e\xac\xef7\x9d\xfa0\x8e\xd2j\xa0\xba\x8edW\xb5\x1d\xe8I\xad\x0b\x15\xd3.\xc0\x86\xe6\x05*\x85\x08\xbeu\xb6\x04\x12\xbd\x93~\x82\xdf\xae\x138A\x14o\x83\xea\xd3m\xbfW\xdaP"\xb3\xb2N\xe0=\x00?\x88\x856aZ\xe0\n.')
2022-08-03 08:53:17.179 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 6b (Expected: 6b) Len:76
2022-08-03 08:53:17.180 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (1141 bytes/<class 'bytearray'>) 0x0601040440ca8c20627183bad47066f303a3eb8f02128d1b641af26a4ea2ac9d47fa59b18f3d4553ea0331554cac382d2321d380086e71870706ff31b87f62b2d44241237605ff9dd8af01c8adb5fd87e6bb72804da505fd3cd01fc49d40fc093141d55efbebcd509e4c4af9d80eb1ead30ae7d1bf31a52627d69b90a603329a17a1b1903c64ab08f7f2c05619b86a0f3b804633cde35568e47b9175f9d5e2d3cb1136974faa75ebd64ba83ffa82fc6cd8be47e80f7431cf5fad0d6fc2d9c7a82f878b84d1b236b06bc41ecab1406f994a9888756855fd3cbe4e4a1f1f991175f0f3e95780effe65c88bb69ff285fe19561c71ad18cb3216ff7f52ba215065f83356ef3162ee31d1ab74257d92f90a1f60b26e1bf9230af3f3aca4bebfabe7f44ac7ece427994763ed554cc83d1e9244f458a6ada6a1e2aadead35607fb9bcc921c13c1001e705ffb98fca59957d69a9e9fc90a28919c12b2c3d34a1ca9d1775b0b520c7771253d6650d9eff73b96470013e9e5bb3e6e03ff5131db8a39ebb33fb327b8cad5fa1fbf9f7489d200e7226c08c3246dd8d434b2766459c37777c72ef2da8a339928a35e0e666bd560947f8d55d80ee797aa70e6dbf05f4dd7140f2ade145a474b09ef1e12645f7e3385482ccc6e3a209f9e4b1439a0351260bc96b57be4dc66bde253c2537c8110a7cea34b3d8e77b72df4cb8918883511f923dbf8b8ba800bafa080c330cc074c672b46d0ffa67caa32567415a516033a181d318415e97cb9e9fd73ad46c724f0bcc0f70947626a865158b5728579e643f59964360cb6d8dce311405ff697440d6b726a40984308095b969039e9d9c328b85b26332b64c53e7b19bb009edcdd8cdced54c8fb0333821f655bd12da3698dc1e155b027f21a96cc44125556a55247433098c6d62879326b04f8cf00c3985651e2e910044da043d95957e9bb027dfefc9976784c7ffd00983a998c9ccd9869a1e078cbe1645250fa873d5684b4cb01091a9ff6bebebe3dbb6285b21319d12a922e01b071fe69b2f0be9d19b805f256ffad1ab0eede2c6360ad0f1011cddb437ce7e31dcb26791632ffb66765ffa8df48053c700ae163ac72df61d3fac66d9f809ae034cd11de808aa35fb6465fcffaa079ac6aae4064d0fb8226c5acc9564ad1176bfa45793ea9f6e528f05ff5c89ab7cb13db7cb9d5da9b360f26c23ce51faad3dfd9a79d636162ee2ed64f9c526a32d5f1e03a83eeed493fda2d868e94df344e9fcffb70194bf5c62d5ba53dba40861d936bd8c09018662bb780ba152672234c21c148be21073e04828dd22c0dc14e5876aebb6414401c2baf4a25afc879b2a96698e94e5e0280c798d3d8cecc547bde2a89d5f90e82eff1f781f1e9437432d54012e0bb8f830773a2bfa0bb7e7df6bae4d07a8f43a4bd6280f585f8ba0b655fd9cb657e3a3ba1493f7521e9f4a9456245d8ae72e6acd93170cba006b7539c207c27c28dd11b23cbd2eca6e4b40b7c09eacef379dfa308ed26aa0ba8e6457b51de849ad0b15d32ec086e6052a8508be75b60412bd937e82dfae133841146f83ead36dbf57da5022b3b24ee03d003f888536615ae00a2e
]
2022-08-03 08:53:17.180 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x04
4: (64 bytes/<class 'bytearray'>) 0xca8c20627183bad47066f303a3eb8f02128d1b641af26a4ea2ac9d47fa59b18f3d4553ea0331554cac382d2321d380086e71870706ff31b87f62b2d442412376
5: (1062 bytes/<class 'bytearray'>) 0x9dd8af01c8adb5fd87e6bb72804da505fd3cd01fc49d40fc093141d55efbebcd509e4c4af9d80eb1ead30ae7d1bf31a52627d69b90a603329a17a1b1903c64ab08f7f2c05619b86a0f3b804633cde35568e47b9175f9d5e2d3cb1136974faa75ebd64ba83ffa82fc6cd8be47e80f7431cf5fad0d6fc2d9c7a82f878b84d1b236b06bc41ecab1406f994a9888756855fd3cbe4e4a1f1f991175f0f3e95780effe65c88bb69ff285fe19561c71ad18cb3216ff7f52ba215065f83356ef3162ee31d1ab74257d92f90a1f60b26e1bf9230af3f3aca4bebfabe7f44ac7ece427994763ed554cc83d1e9244f458a6ada6a1e2aadead35607fb9bcc921c13c1001e7b98fca59957d69a9e9fc90a28919c12b2c3d34a1ca9d1775b0b520c7771253d6650d9eff73b96470013e9e5bb3e6e03ff5131db8a39ebb33fb327b8cad5fa1fbf9f7489d200e7226c08c3246dd8d434b2766459c37777c72ef2da8a339928a35e0e666bd560947f8d55d80ee797aa70e6dbf05f4dd7140f2ade145a474b09ef1e12645f7e3385482ccc6e3a209f9e4b1439a0351260bc96b57be4dc66bde253c2537c8110a7cea34b3d8e77b72df4cb8918883511f923dbf8b8ba800bafa080c330cc074c672b46d0ffa67caa32567415a516033a181d318415e97cb9e9fd73ad46c724f0bcc0f70947626a865158b5728579e643f59964360cb6d8dce3114697440d6b726a40984308095b969039e9d9c328b85b26332b64c53e7b19bb009edcdd8cdced54c8fb0333821f655bd12da3698dc1e155b027f21a96cc44125556a55247433098c6d62879326b04f8cf00c3985651e2e910044da043d95957e9bb027dfefc9976784c7ffd00983a998c9ccd9869a1e078cbe1645250fa873d5684b4cb01091a9ff6bebebe3dbb6285b21319d12a922e01b071fe69b2f0be9d19b805f256ffad1ab0eede2c6360ad0f1011cddb437ce7e31dcb26791632ffb66765ffa8df48053c700ae163ac72df61d3fac66d9f809ae034cd11de808aa35fb6465fcffaa079ac6aae4064d0fb8226c5acc9564ad1176bfa45793ea9f6e528f5c89ab7cb13db7cb9d5da9b360f26c23ce51faad3dfd9a79d636162ee2ed64f9c526a32d5f1e03a83eeed493fda2d868e94df344e9fcffb70194bf5c62d5ba53dba40861d936bd8c09018662bb780ba152672234c21c148be21073e04828dd22c0dc14e5876aebb6414401c2baf4a25afc879b2a96698e94e5e0280c798d3d8cecc547bde2a89d5f90e82eff1f781f1e9437432d54012e0bb8f830773a2bfa0bb7e7df6bae4d07a8f43a4bd6280f585f8ba0b655fd9cb657e3a3ba1493f7521e9f4a9456245d8ae72e6acd93170cba006b7539c207c27c28dd11b23cbd2eca6e4b40b7c09eacef379dfa308ed26aa0ba8e6457b51de849ad0b15d32ec086e68508be75b60412bd937e82dfae133841146f83ead36dbf57da5022b3b24ee03d003f888536615ae00a2e
]
2022-08-03 08:53:17.604 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
1: (36 bytes/<class 'bytes'>) b'2f6ffe99-250a-4185-812d-aac430188b94'
3: (32 bytes/<class 'bytes'>) b'\xffn\x14\xe2/\x90\xc3\x83>\xd8\x87\x00V\xa5\x96\xbb\xff*~\x01\x99,\x80\x91r\t\x13\xe8/\x7f*#'
10: (64 bytes/<class 'bytes'>) b'\x1eB*:{(\x80\xcc\x8a;\xf0I\xe4~F\xe6\x84\xa1\x10\x1d\xed\xb6\xee~)\xd9a?\x83\x92\xdf\xc1\xa3\xdaW\x01\xaf\xae\xfaI\x87\x19|X\xd3\x15\x9e\xe1\xe1[\xae;\xbeR\x7f\xcb{/{\x97n\x1aP\x0f'
]
2022-08-03 08:53:17.614 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x05
5: (154 bytes/<class 'bytes'>) b'\x98\xf9I\x0b\xe5\xe8\xb5`bZ4\x1d\xc4&\xa1\x93\xc8)\xe1\xc0\xb4\r\xee\xe8\x91\x19\xffn\x82&\xf1\xb2\x82\xd4aA\x19\xbdb\xfd\xc4\xea!\xe56\xc0c_es\x0f\x06R`\x9f\x0fN\xc5\xb0\x04\xde\x0eq\x0e\x8b\x1a\xae\xba\xe2Fo\xae\xf5\x80\x1d\xe3\xb2T[QL\x13zxG\xb7 \xc6\xcc\xc7qq\xeb}\xf2\xe8\x07\xa6\xa6t\xac}\\K\x90\x88\x88\x9c\xc2\x7fQerC-\x12\xd1\x97%\xf8\x10\xea\x11e\x1f\xae\xd1\xd7\x18Z\xb8(\xb9\xd1:\xc0\x8c\rA&\x853\x98%+w\xc2c\xff\x88\r\xe2\xd4\xe2'
]
2022-08-03 08:53:17.615 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:53:17.615 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02\xaf-\x00\xa4\x00\t\x01\x01\x01\x9f\x06\x01\x05\x05\x9a\x98\xf9I\x0b\xe5\xe8\xb5`bZ4\x1d\xc4&\xa1\x93\xc8)\xe1\xc0\xb4\r\xee\xe8\x91\x19\xffn\x82&\xf1\xb2\x82\xd4aA\x19\xbdb\xfd\xc4\xea!\xe56\xc0c_es\x0f\x06R`\x9f\x0fN\xc5\xb0\x04\xde\x0eq\x0e\x8b\x1a\xae\xba\xe2Fo\xae\xf5\x80\x1d\xe3\xb2T[Q'
2022-08-03 08:53:17.615 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x80\xafL\x13zxG\xb7 \xc6\xcc\xc7qq\xeb}\xf2\xe8\x07\xa6\xa6t\xac}\\K\x90\x88\x88\x9c\xc2\x7fQerC-\x12\xd1\x97%\xf8\x10\xea\x11e\x1f\xae\xd1\xd7\x18Z\xb8(\xb9\xd1:\xc0\x8c\rA&\x853\x98%+w\xc2c\xff\x88\r\xe2\xd4\xe2'
2022-08-03 08:53:18.044 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\xaf\x00\x8e\x00\x01\x8c\x06\x01\x06\x05\x87\t\x02@\xca\xab[\xbd<\xb9\xe9\xe7\x87\xf1 4\x0b\x01I\xb8\xe6pW\xfft=V?\xb0\x11U\xee\x07M\xc3\xe1\xcc\x19\xcd\x05\xc7\x0b~|]\x96F/4\xf3\xba\xffaY\xd8t\xf1\xfe\xc0\\&\x84T:H\xc0\x1d\x7f\x85\x18(9\xd5Z\xf7\xbbl,u!\xab1\xb6\xf3\xdd\x96\n\xa7\xe4')
2022-08-03 08:53:18.045 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID af (Expected: af), Status:0, Len:95
2022-08-03 08:53:18.126 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\xaf\xb9\xaf\x95\xfaPw\xa2\xa5\xf6\xd2\x8b\x80\x90\x08F\x8f\x1a\x00eRl\xdd?2\xc3\x9f\xa1*\xc7\x7f\x0b&@i\x8d;=\xfa\x19\x0eQ\x1d\xa9\xbd\xf4\xc0\x90')
2022-08-03 08:53:18.127 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID af (Expected: af) Len:47
2022-08-03 08:53:18.127 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (140 bytes/<class 'bytearray'>) 0x0601060587090240caab5bbd3cb9e9e787f120340b0149b8e67057ff743d563fb01155ee074dc3e1cc19cd05c70b7e7c5d96462f34f3baff6159d874f1fec05c2684543a48c01d7f85182839d55af7bb6c2c7521ab31b6f3dd960aa7e4b9af95fa5077a2a5f6d28b809008468f1a0065526cdd3f32c39fa12ac77f0b2640698d3b3dfa190e511da9bdf4c090
]
2022-08-03 08:53:18.127 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x06
5: (135 bytes/<class 'bytearray'>) 0x090240caab5bbd3cb9e9e787f120340b0149b8e67057ff743d563fb01155ee074dc3e1cc19cd05c70b7e7c5d96462f34f3baff6159d874f1fec05c2684543a48c01d7f85182839d55af7bb6c2c7521ab31b6f3dd960aa7e4b9af95fa5077a2a5f6d28b809008468f1a0065526cdd3f32c39fa12ac77f0b2640698d3b3dfa190e511da9bdf4c090
]
2022-08-03 08:53:18.129 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (17 bytes/<class 'bytearray'>) 0x36343a31333a33363a31303a39363a3143
3: (32 bytes/<class 'bytearray'>) 0xafe26741ed4177ddd192223c37562996863c2d40ef85c513a3a5eb1569a1be61
10: (64 bytes/<class 'bytearray'>) 0xd6ed56bc740b7ee80bdad0bf136b64e8264230edfc4b89c7070949d65eee2300b409324ac8f66304e03c86ccad263a166c1beb91f5ea9a5e003e42eb1ec1470a
]
2022-08-03 08:53:18.275 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): Fetching gatt database because, cached_config_num: 0, adv config_num: 1
2022-08-03 08:53:18.623 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID b8 (Expected: b8), Status:0, Len:67
2022-08-03 08:53:18.624 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000020-0000-1000-8000-0026bb765291 (Handle: 4): Unknown decoded: {'type': '200000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:18.952 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID b9 (Expected: b9), Status:0, Len:60
2022-08-03 08:53:18.952 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000021-0000-1000-8000-0026bb765291 (Handle: 7): Unknown decoded: {'type': '210000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:19.323 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 4f (Expected: 4f), Status:0, Len:59
2022-08-03 08:53:19.323 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 10): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:19.653 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 1e (Expected: 1e), Status:0, Len:68
2022-08-03 08:53:19.654 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000030-0000-1000-8000-0026bb765291 (Handle: 13): Unknown decoded: {'type': '300000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:20.024 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 99 (Expected: 99), Status:0, Len:63
2022-08-03 08:53:20.025 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000014-0000-1000-8000-0026bb765291 (Handle: 16): Hardcopy Data Channel decoded: {'type': '140000100080000026BB765291', 'iid': None, 'perms': ['pw'], 'format': 'bool'}
2022-08-03 08:53:20.272 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 90 (Expected: 90), Status:0, Len:72
2022-08-03 08:53:20.273 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000052-0000-1000-8000-0026bb765291 (Handle: 19): Unknown decoded: {'type': '520000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:20.601 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 7f (Expected: 7f), Status:0, Len:72
2022-08-03 08:53:20.603 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000053-0000-1000-8000-0026bb765291 (Handle: 22): Unknown decoded: {'type': '530000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:20.976 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 1d (Expected: 1d), Status:0, Len:72
2022-08-03 08:53:20.978 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 00000054-0000-1000-8000-0026bb765291 (Handle: 25): Unknown decoded: {'type': '540000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 08:53:21.303 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 83 (Expected: 83), Status:0, Len:76
2022-08-03 08:53:21.304 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 44ff6853-58db-4956-b298-5f6650dd61f6 (Handle: 31): Unknown decoded: {'type': '44FF685358DB4956B2985F6650DD61F6', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-03 08:53:21.675 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6c (Expected: 6c), Status:0, Len:77
2022-08-03 08:53:21.676 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: cf68c40f-dc6f-4f7e-918c-4c536b643a2b (Handle: 34): Unknown decoded: {'type': 'CF68C40FDC6F4F7E918C4C536B643A2B', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 0, 'maxValue': 3}
2022-08-03 08:53:22.006 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 4b (Expected: 4b), Status:0, Len:79
2022-08-03 08:53:22.006 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 4058c2b8-4545-4e77-b6b7-157c38f9718b (Handle: 37): Unknown decoded: {'type': '4058C2B845454E77B6B7157C38F9718B', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 1, 'maxValue': 5}
2022-08-03 08:53:22.394 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 8e (Expected: 8e), Status:0, Len:73
2022-08-03 08:53:22.395 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: b498f4b5-6364-4f79-b5cc-1563ade070df (Handle: 40): Unknown decoded: {'type': 'B498F4B563644F79B5CC1563ADE070DF', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minValue': 0, 'maxValue': 1}
2022-08-03 08:53:22.622 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 3c (Expected: 3c), Status:0, Len:70
2022-08-03 08:53:22.623 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: afae7ad2-8dd3-4b20-bae0-c0b18b79edb5 (Handle: 43): Unknown decoded: {'type': 'AFAE7AD28DD34B20BAE0C0B18B79EDB5', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-03 08:53:22.955 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 98 (Expected: 98), Status:0, Len:70
2022-08-03 08:53:22.965 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 87d91ec6-c508-4cad-89f1-a21b0bf179a0 (Handle: 46): Unknown decoded: {'type': '87D91EC6C5084CAD89F1A21B0BF179A0', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-03 08:53:23.323 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 1f (Expected: 1f), Status:0, Len:67
2022-08-03 08:53:23.324 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: 4c3e2641-f57f-11e3-a3ac-0800200c9a66 (Handle: 49): Unknown decoded: {'type': '4C3E2641F57F11E3A3AC0800200C9A66', 'iid': None, 'perms': ['pr'], 'format': 'uint64'}
2022-08-03 08:53:23.659 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d5 (Expected: d5), Status:0, Len:80
2022-08-03 08:53:23.660 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: eec26990-f628-11e3-a3ac-0800200c9a66 (Handle: 52): Unknown decoded: {'type': 'EEC26990F62811E3A3AC0800200C9A66', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 4, 'maxValue': 8}
2022-08-03 08:53:24.027 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 0f (Expected: 0f), Status:0, Len:71
2022-08-03 08:53:24.027 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: bcde3b9e-3963-4123-b24d-42eccbb3a9c4 (Handle: 55): Unknown decoded: {'type': 'BCDE3B9E39634123B24D42ECCBB3A9C4', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-03 08:53:24.356 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 9a (Expected: 9a), Status:0, Len:64
2022-08-03 08:53:24.356 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (DD:07:2C:27:5A:3C): char: a9464d14-6806-4375-ba53-e14f7e0a6bee (Handle: 58): Unknown decoded: {'type': 'A9464D1468064375BA53E14F7E0A6BEE', 'iid': None, 'perms': ['pr', 'pw']}
2022-08-03 08:53:24.357 ERROR (MainThread) [homeassistant.components.homekit_controller.config_flow] Pairing attempt failed with an unhandled exception
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 447, in async_step_pair
return await self._entry_from_accessory(pairing)
File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 561, in _entry_from_accessory
name = await pairing.get_primary_name()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/abstract.py", line 143, in get_primary_name
accessories = await self.list_accessories_and_characteristics()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 102, in _async_wrap
return await func(self, *args, **kwargs)
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/client.py", line 63, in _async_wrap
return await func(*args, **kwargs)
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 503, in list_accessories_and_characteristics
await self._populate_accessories_and_characteristics()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 575, in _populate_accessories_and_characteristics
accessories = await self._async_fetch_gatt_database()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 468, in _async_fetch_gatt_database
hap_char.format = decoded["format"]
KeyError: 'format'
2022-08-03 08:53:24.378 DEBUG (MainThread) [aiohomekit.controller.ble.discovery] Ensure connected with device DD:07:2C:27:5A:3C: SENSE
2022-08-03 08:53:24.479 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:53:24.479 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x03\x18/\x00'
2022-08-03 08:53:24.684 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\x18\x00\x03\x00\x01\x01\x01')
2022-08-03 08:53:24.684 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 18 (Expected: 18), Status:0, Len:3
2022-08-03 08:53:24.684 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-03 08:53:24.768 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x01
0: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-03 08:53:24.769 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-03 08:53:24.769 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02^-\x00\x0b\x00\t\x01\x01\x01\x06\x06\x01\x01\x00\x01\x01'
2022-08-03 08:53:24.931 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02^\x00\x08\x00\x01\x06\x06\x01\x02\x07\x01\x06')
2022-08-03 08:53:24.931 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 5e (Expected: 5e), Status:0, Len:8
2022-08-03 08:53:24.932 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (6 bytes/<class 'bytearray'>) 0x060102070106
]
2022-08-03 08:53:24.932 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x02
7: (1 bytes/<class 'bytearray'>) 0x06
]
TravisRoy commented 2 years ago

Tried again with 2022.8.2, New logs:

2022-08-04 21:45:13.666 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\x91\x00\x7f\x04\x01\xff\x06\x01\x04\x04@\xd9\xbc|\xfb\xe3\x07\xd6\x8c\xe5H\xbc\x99\x18\xe6_\xb5\t\x8f\xbf\xcc0*m\x99\xfe\x9e\xae\xdf\xac\x1e>\xdaZ\x82H\xc4\x19\x08\x1e#\x17&\x1c\x98\xeb)\xb4}Z\xaf\r\x17\xbb\xa4\x06\x1e\x03\x9b\xb3\xb6\xccu\x80\xa4\x05\xff\xfd\xb3%\x00\xd3i\xff\xff\xc7\x91M\xfa\x00\xef\x1d\x8dr\xfaC\x02\x01I')
2022-08-04 21:45:13.666 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 91 (Expected: 91), Status:0, Len:95
2022-08-04 21:45:13.793 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91\xc5\x87\x9cc\xa5\xbd\xe9\x05\n\xb3@D\xc7@%=n\t\\\x18\xb5\xb5(\xf5B\x93\x15\xf5\xb3j#M^\xe4\x8c*\xa6~\x7f\xef\xaf\xb8!v\xa7b?H\xe7\xdbG\x9a\x9cN\xe4Z\x08\xc7\x19\xa2\x8b\xb4\x96\x15\xcd1f\xbb\x15/\x89\x05T\xf6\x02f\x9a\x85\xf4\xe7\x9d\x86@\xdb\xf07U?\xb9\x02\xfa\x91V\xe7\x18\xcb\xae\xe8')
2022-08-04 21:45:13.794 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:13.875 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91^\xb9Q\x15_8V\xe9Q\xe6~\x16\x1ay\xd062\xda\xef_#&-\xc4`M\\\xda+\xfb\x9f*\x12\xd7\xca\xcd\xf3E\xa7\xf0\x85\x1d-3\xc8m?"\xfb\xe6\x89\x81h\x04\xe0\xce\xfb\xf3G<\xf0\xeb\xed8\x01\xff\xe7\x95m\x1e\x975z\xfb u\x1b\xce#-\xafVU(\xb4\xc3\xed\xf5d\xcf\xd2(\x9d\xfd4*\x0cw')
2022-08-04 21:45:13.875 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:13.998 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91\xd3\xe6.Qf 5\xcdM%j\xe4\xa0 lg\xb4\x01)\x83v\x08X\xe1R\x15IBq\xe3h\x95|P\x9bXiH\xeb\x05\xff\xae\x93!\x96l*\xcfp\x1b\xe3r\xb4}\x84\xe5-mB2\xe0\xff\x01\xadQ8b*\xab2\xc0\x10\x9bP\xf9\xdb{\xa7\xef\xd1Aiw\xa6\xc9%[IG$9W\x0e\xdc\x1c\x94\x0f\x92')
2022-08-04 21:45:13.999 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.080 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b"\x82\x91\x96\xba\xe1\xb5,\xc6\xde\xb9w\xbd\x93\xf4/AV|\\\x17\x89\x1d\xe5\x01a\xc1\xbf\xc0\x05\x85`5P,\xe6\xfar\xebni\x89\xd1\xbc0\x97\xaa\x19\x83M\x18\'\x19?\xa6wa\x1de\\\x9d\xb9 \xd1\x10\x9f\xdaY\xd5\x03Q\xb3`\xb0\xb1\xe8\x05\x17\x02\x0cx\xb2Z`\xe9\xd8\x8d\xd5GvP\xe6j\xc0L\x9a\xcd\xad\xdcHg")
2022-08-04 21:45:14.081 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.162 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91q|q\xc4\x98u!\xef\xa3\xf5\xaa\xd1R\xf9\nM}\xafp8\xb1,X\xa9\x8d%\\\x01\xff\x97n\xec\x84\xe0\x1dV{\x8a\x18\r\xa6\xf8@\x06\xe8/w\xe3h\xe1\x12\x99\xc0\x06Za\xf5\xbe\x96\xa5u\xcd\xcf:\xf1\xa1<\xeaJ[\xc9\xc2\xbe\x87.\xb8:\x82\xd7\xe6\x9e,\xbc\x80\xaf\x7f\x14K\xd7Z\x05OO\xd0;[l\xc5')
2022-08-04 21:45:14.163 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.245 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91\x99\xeaG\x03\x05\xffg`\xe9\xd2\xa3\x00\x8d\xaa\xfa=}k\x95\x0bk\r\x8dK\xf6\xe7\xee\x9d5\xd2\xe4\x06\x8e\xbe\xda\xe2\x039\xdf\x0b\xadt\xf7M\x0exUJ#)ZC\xc9\t\xff\x8d\xffbx\xb8\x9d\xa4\xd6$u\xafG\x89X\xf4s\xc2\xd6\xf3 O\xaa\xa1<\x8f;h\x80\xb9\xf6\xdc|\xe61^\x10\x0e\xc7\x89\xe1sv\x1e')
2022-08-04 21:45:14.246 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.409 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91i\x91[\xb2w8\x055\xaby>\xaa\xc6\xff\xad{Gb\xc9\xe6$gR\x88\x81\xa4\x90\xb3\xf9\xc9\x81\xfd\xc2D\x9f\x15_\xf8P\xa5>\xcf\xa8V\xe3\xb5v\xf3}>@\xa7\xf8\x1d\x90\x9ce\x88D!\xdb\xd5\xf5a&\xf7\xe9\xaa\x9er\xb3\x02\xd8x4\xe9\x93\xd5\x84tg\xb1\x9a\xfat\xaem\xf2\x01\xff\xe1\x8c\xc6\nBD\xca>')
2022-08-04 21:45:14.410 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.573 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91\xa2\xc9n\x10\nd\x02\x94\x01\x81\xc0\xc6\xf68:\xad\x9ar\xb8\xf6\x01\xcf\xc9\xd3\xa3\x94\xbb\x9dn\x99\xf5\xf3\xa0M\x89\x9d\x8c\x1c\xedG\xa1\xff\xe94\xbbD,\x9a\xc2w\x1bI\xc3\xb9\xb2\xd8#H\xabY\xe6+\xfa%.K\x94\x05\xff\xad\xb9\x9a\xf1\xdeXUJ\x14\xdd\xe7m\xd9\xfb\xe2$\x9d\x93\xe5\xd5\xe5\xfaB-\x8d\xd5\xae\xdf\x19')
2022-08-04 21:45:14.574 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.698 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91z\x92\xce#\x8d\xe6\x07\xc4s\x98\x85\xddf9\xbb\xe5\xd0\'\x0e\x12\x03\xdei\xa2B\x907K\x84#\xb9{j\xe7(\xba<\x12\xd9\x16\xe7\xd1\xd8"\xe8\xda[\xb8m^\x88\xee\xd23S\xa4L\xb4\xf6C\x0f\xd4\x8e\xa1\x97.\x93\xed\x89\xb9[T0\xc0{\x89W\xfbB\x89\x00\xeeP\x11\xd3\x15\xc8\x1ci\xc7:\x1a\x96\xcbh3-\xcf')
2022-08-04 21:45:14.698 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.780 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91i-d\xe1c\xf6\xd2y\xc4r\xcfj\xd0\xfa\xa3\xf7\x1b\xe4\x01/\x8f!K\xc4\x85\x05\x0e\xac!-\x1de\xba\xbe\xe1\xf7\xf0\xdd\x1dU\xc7\x9eJe\xd9EFU3o8\x01y\x03|e\xa6?^M"\xcfX\xc1\x12\xcb\xcfa;\xf4u\xbd\xd4\x1a\x8a\x0e\xca\x95\xa8s\xb2Q\xe2\xa0T`\xc5\x81\xa1A\x0bDv\\\xa5\xe9\x1b\x1a')
2022-08-04 21:45:14.781 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:98
2022-08-04 21:45:14.862 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\x91\x15On\xca\xb7B\x90Df@\x84*\t\xec\xf1\x00\xdd\xf6M\xe3os\x07|\xb0#\xfd[t\x8e\xba\x89\x05*\xa92E\xd6g\x9d:y\xf7Y\x1c\xe5x\xfeNk\xff\x92\x98\x8b8\x12\xa1i\xd3k\xa0\x9b3\x1f\x9aW/#\xe5\xc7~\xd1I\xf5\xa5Q')
2022-08-04 21:45:14.863 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID 91 (Expected: 91) Len:76
2022-08-04 21:45:14.863 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (1141 bytes/<class 'bytearray'>) 0x0601040440d9bc7cfbe307d68ce548bc9918e65fb5098fbfcc302a6d99fe9eaedfac1e3eda5a8248c419081e2317261c98eb29b47d5aaf0d17bba4061e039bb3b6cc7580a405fffdb32500d369ffffc7914dfa00ef1d8d72fa43020149c5879c63a5bde9050ab34044c740253d6e095c18b5b528f5429315f5b36a234d5ee48c2aa67e7fefafb82176a7623f48e7db479a9c4ee45a08c719a28bb49615cd3166bb152f890554f602669a85f4e79d8640dbf037553fb902fa9156e718cbaee85eb951155f3856e951e67e161a79d03632daef5f23262dc4604d5cda2bfb9f2a12d7cacdf345a7f0851d2d33c86d3f22fbe689816804e0cefbf3473cf0ebed38e7956d1e97357afb20751bce232daf565528b4c3edf564cfd2289dfd342a0c77d3e62e51662035cd4d256ae4a0206c67b4012983760858e15215494271e368957c509b586948eb05ffae9321966c2acf701be372b47d84e52d6d4232e0ff01ad5138622aab32c0109b50f9db7ba7efd1416977a6c9255b49472439570edc1c940f9296bae1b52cc6deb977bd93f42f41567c5c17891de50161c1bfc005856035502ce6fa72eb6e6989d1bc3097aa19834d1827193fa677611d655c9db920d1109fda59d50351b360b0b1e80517020c78b25a60e9d88dd5477650e66ac04c9acdaddc4867717c71c4987521efa3f5aad152f90a4d7daf7038b12c58a98d255c976eec84e01d567b8a180da6f84006e82f77e368e11299c0065a61f5be96a575cdcf3af1a13cea4a5bc9c2be872eb83a82d7e69e2cbc80af7f144bd75a054f4fd03b5b6cc599ea470305ff6760e9d2a3008daafa3d7d6b950b6b0d8d4bf6e7ee9d35d2e4068ebedae20339df0bad74f74d0e78554a23295a43c909ff8dff6278b89da4d62475af478958f473c2d6f3204faaa13c8f3b6880b9f6dc7ce6315e100ec789e173761e69915bb277380535ab793eaac6ffad7b4762c9e62467528881a490b3f9c981fdc2449f155ff850a53ecfa856e3b576f37d3e40a7f81d909c65884421dbd5f56126f7e9aa9e72b302d87834e993d5847467b19afa74ae6df2e18cc60a4244ca3ea2c96e100a6402940181c0c6f6383aad9a72b8f601cfc9d3a394bb9d6e99f5f3a04d899d8c1ced47a1ffe934bb442c9ac2771b49c3b9b2d82348ab59e62bfa252e4b9405ffadb99af1de58554a14dde76dd9fbe2249d93e5d5e5fa422d8dd5aedf197a92ce238de607c4739885dd6639bbe5d0270e1203de69a24290374b8423b97b6ae728ba3c12d916e7d1d822e8da5bb86d5e88eed23353a44cb4f6430fd48ea1972e93ed89b95b5430c07b8957fb428900ee5011d315c81c69c73a1a96cb68332dcf692d64e163f6d279c472cf6ad0faa3f71be4012f8f214bc485050eac212d1d65babee1f7f0dd1d55c79e4a65d9454655336f38037c65a63f5e4d22cf58c112cbcf613bf475bdd41a8a0eca95a873b251e2a05460c581a1410b44765ca5e91b1a154f6ecab74290446640842a09ecf100ddf64de36f73077cb023fd5b748eba89052aa93245d6679d3a79f7591ce578fe4e6bff92988b3812a169d36ba09b331f9a572f23e5c77ed149f5a551
]
2022-08-04 21:45:14.863 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x04
4: (64 bytes/<class 'bytearray'>) 0xd9bc7cfbe307d68ce548bc9918e65fb5098fbfcc302a6d99fe9eaedfac1e3eda5a8248c419081e2317261c98eb29b47d5aaf0d17bba4061e039bb3b6cc7580a4
5: (1062 bytes/<class 'bytearray'>) 0xfdb32500d369ffffc7914dfa00ef1d8d72fa43020149c5879c63a5bde9050ab34044c740253d6e095c18b5b528f5429315f5b36a234d5ee48c2aa67e7fefafb82176a7623f48e7db479a9c4ee45a08c719a28bb49615cd3166bb152f890554f602669a85f4e79d8640dbf037553fb902fa9156e718cbaee85eb951155f3856e951e67e161a79d03632daef5f23262dc4604d5cda2bfb9f2a12d7cacdf345a7f0851d2d33c86d3f22fbe689816804e0cefbf3473cf0ebed38e7956d1e97357afb20751bce232daf565528b4c3edf564cfd2289dfd342a0c77d3e62e51662035cd4d256ae4a0206c67b4012983760858e15215494271e368957c509b586948ebae9321966c2acf701be372b47d84e52d6d4232e0ff01ad5138622aab32c0109b50f9db7ba7efd1416977a6c9255b49472439570edc1c940f9296bae1b52cc6deb977bd93f42f41567c5c17891de50161c1bfc005856035502ce6fa72eb6e6989d1bc3097aa19834d1827193fa677611d655c9db920d1109fda59d50351b360b0b1e80517020c78b25a60e9d88dd5477650e66ac04c9acdaddc4867717c71c4987521efa3f5aad152f90a4d7daf7038b12c58a98d255c976eec84e01d567b8a180da6f84006e82f77e368e11299c0065a61f5be96a575cdcf3af1a13cea4a5bc9c2be872eb83a82d7e69e2cbc80af7f144bd75a054f4fd03b5b6cc599ea47036760e9d2a3008daafa3d7d6b950b6b0d8d4bf6e7ee9d35d2e4068ebedae20339df0bad74f74d0e78554a23295a43c909ff8dff6278b89da4d62475af478958f473c2d6f3204faaa13c8f3b6880b9f6dc7ce6315e100ec789e173761e69915bb277380535ab793eaac6ffad7b4762c9e62467528881a490b3f9c981fdc2449f155ff850a53ecfa856e3b576f37d3e40a7f81d909c65884421dbd5f56126f7e9aa9e72b302d87834e993d5847467b19afa74ae6df2e18cc60a4244ca3ea2c96e100a6402940181c0c6f6383aad9a72b8f601cfc9d3a394bb9d6e99f5f3a04d899d8c1ced47a1ffe934bb442c9ac2771b49c3b9b2d82348ab59e62bfa252e4b94adb99af1de58554a14dde76dd9fbe2249d93e5d5e5fa422d8dd5aedf197a92ce238de607c4739885dd6639bbe5d0270e1203de69a24290374b8423b97b6ae728ba3c12d916e7d1d822e8da5bb86d5e88eed23353a44cb4f6430fd48ea1972e93ed89b95b5430c07b8957fb428900ee5011d315c81c69c73a1a96cb68332dcf692d64e163f6d279c472cf6ad0faa3f71be4012f8f214bc485050eac212d1d65babee1f7f0dd1d55c79e4a65d9454655336f38037c65a63f5e4d22cf58c112cbcf613bf475bdd41a8a0eca95a873b251e2a05460c581a1410b44765ca5e91b1a154f6ecab74290446640842a09ecf100ddf64de36f73077cb023fd5b748eba89a93245d6679d3a79f7591ce578fe4e6bff92988b3812a169d36ba09b331f9a572f23e5c77ed149f5a551
]
2022-08-04 21:45:15.240 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
1: (36 bytes/<class 'bytes'>) b'1ddafeb7-4992-4616-995c-919270558449'
3: (32 bytes/<class 'bytes'>) b'\xdc\xb1\xeb\xa5P\xe5\x16\xf9~I\x9d\x01-4\x19<c\xdac\xbb\x93\x05\xb4B\x83]\xb7\x0e"\xad\xfe\xf6'
10: (64 bytes/<class 'bytes'>) b'yP)\x11\\\xf7D\xd9E|\xb4R\\y\xc5\x8f/=#\x965\x84\xdcwt\xcc\xdb9\x9b\xfb+`9t\xe7\xbcwv[\xcf\xdbb\xd5\xd3\xe3\x9f\xc4\xb2?\xf4V\xffu\xe6G\xa2\xc5\xe7\xef\xc8iR\xe3\x05'
]
2022-08-04 21:45:15.242 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x05
5: (154 bytes/<class 'bytes'>) b'\xe0\x0csi\xce* s\x8aS\x84\xf0\xa8\xb5\r~\xafm\xa9J\xe4\xdf\xb8\xdbE\xf8\xf6\xf6\x9ee5\x90\xcaO\xc7\x12Qp\n\xd1B\xf8\xfc?^\x85L\xf0\xaf7\xb8\xe6@\r\x1c_\xe8\xd9\xb6$c\x83\xc7P\xf4\x95\x1d\xce^\xc7e\xa2\x01Ae\x85\xf1\xfc\xd0\\\x8a\x90\xf4+`!\xa2\x06\\Zx$\x94\xb8\xdc\x98\t\x95$\x80yH\x87\xe8MeD2\xc1\x10\xbc\xfcuJ*\xff\n\x1cwV\x0f\xb2\xb3\xf10\xc2\xc9 \x0b,\x06\x18V\x9dD\x03\x07G\xd9X\x914A_* \xe28+6q2\xb9+'
]
2022-08-04 21:45:15.243 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-04 21:45:15.243 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02\xe7-\x00\xa4\x00\t\x01\x01\x01\x9f\x06\x01\x05\x05\x9a\xe0\x0csi\xce* s\x8aS\x84\xf0\xa8\xb5\r~\xafm\xa9J\xe4\xdf\xb8\xdbE\xf8\xf6\xf6\x9ee5\x90\xcaO\xc7\x12Qp\n\xd1B\xf8\xfc?^\x85L\xf0\xaf7\xb8\xe6@\r\x1c_\xe8\xd9\xb6$c\x83\xc7P\xf4\x95\x1d\xce^\xc7e\xa2\x01Ae\x85\xf1\xfc\xd0\\'
2022-08-04 21:45:15.243 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x80\xe7\x8a\x90\xf4+`!\xa2\x06\\Zx$\x94\xb8\xdc\x98\t\x95$\x80yH\x87\xe8MeD2\xc1\x10\xbc\xfcuJ*\xff\n\x1cwV\x0f\xb2\xb3\xf10\xc2\xc9 \x0b,\x06\x18V\x9dD\x03\x07G\xd9X\x914A_* \xe28+6q2\xb9+'
2022-08-04 21:45:15.771 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02\xe7\x00\x8e\x00\x01\x8c\x06\x01\x06\x05\x87\x0fV ,:j\x9ed\xf3.\t\xc8\xc1\x85\x86\xcb\x94\xa7\xca\xf2\\\n\xe3M\xb2|,\xee\xf6Gy\x10:\xb3X\xfb:\xa1\x99\x13#Z\x8e\xb5\xa9[\x11"\x97\xb7\xf4\x0c \xc8h\xb0E)\x18ns\x9f\xc2\n\xf2\x94\xbb\xf1\x03\xf6n\'\xfeCE\xf0\xb5\x00\xb5\x0b?\x06[f\xd8p7\x97')
2022-08-04 21:45:15.772 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID e7 (Expected: e7), Status:0, Len:95
2022-08-04 21:45:15.853 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x82\xe77\\\x8b}\xb8\xbb\xe0\xf2\xe3\xc1\x90s\xa0\xf7\x9b1\x19Q1\xf0\xd8\x01\xf7\xed.\xb1\xd1\xd1\xba\x8c\xa4\xb0\x04Df\x9e:\xc3\xf0\xdc\xe8\x92d\xd2\x01?<')
2022-08-04 21:45:15.853 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 82: TID e7 (Expected: e7) Len:47
2022-08-04 21:45:15.854 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (140 bytes/<class 'bytearray'>) 0x06010605870f56202c3a6a9e64f32e09c8c18586cb94a7caf25c0ae34db27c2ceef64779103ab358fb3aa19913235a8eb5a95b112297b7f40c20c868b04529186e739fc20af294bbf103f66e27fe4345f0b500b50b3f065b66d8703797375c8b7db8bbe0f2e3c19073a0f79b31195131f0d801f7ed2eb1d1d1ba8ca4b00444669e3ac3f0dce89264d2013f3c
]
2022-08-04 21:45:15.854 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x06
5: (135 bytes/<class 'bytearray'>) 0x0f56202c3a6a9e64f32e09c8c18586cb94a7caf25c0ae34db27c2ceef64779103ab358fb3aa19913235a8eb5a95b112297b7f40c20c868b04529186e739fc20af294bbf103f66e27fe4345f0b500b50b3f065b66d8703797375c8b7db8bbe0f2e3c19073a0f79b31195131f0d801f7ed2eb1d1d1ba8ca4b00444669e3ac3f0dce89264d2013f3c
]
2022-08-04 21:45:15.856 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (17 bytes/<class 'bytearray'>) 0x38323a31303a42333a42383a45423a3743
3: (32 bytes/<class 'bytearray'>) 0x1de4e1bf14bfe11c6db872675d3b7992a922343cfe670968882f6425077de09d
10: (64 bytes/<class 'bytearray'>) 0x5eb31176ccf4dfceaf62c00777b13b5e2e3d882cb576d55da61cd8b3cee4f3d9c5bd263aa19826afdcbb55be3f8fdf3909dccc6e3734123f4f6afba783c48b08
]
2022-08-04 21:45:15.979 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): Fetching gatt database because, cached_config_num: -1, adv config_num: 1
2022-08-04 21:45:15.980 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): Fetching GATT database
2022-08-04 21:45:16.389 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 44 (Expected: 44), Status:0, Len:67
2022-08-04 21:45:16.391 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000020-0000-1000-8000-0026bb765291 (Handle: 4): Unknown decoded: {'type': '200000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:16.678 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 2d (Expected: 2d), Status:0, Len:60
2022-08-04 21:45:16.679 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000021-0000-1000-8000-0026bb765291 (Handle: 7): Unknown decoded: {'type': '210000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:17.008 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 17 (Expected: 17), Status:0, Len:59
2022-08-04 21:45:17.009 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 10): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:17.298 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 28 (Expected: 28), Status:0, Len:68
2022-08-04 21:45:17.298 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000030-0000-1000-8000-0026bb765291 (Handle: 13): Unknown decoded: {'type': '300000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:17.628 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 12 (Expected: 12), Status:0, Len:63
2022-08-04 21:45:17.629 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000014-0000-1000-8000-0026bb765291 (Handle: 16): Hardcopy Data Channel decoded: {'type': '140000100080000026BB765291', 'iid': None, 'perms': ['pw'], 'format': 'bool'}
2022-08-04 21:45:17.916 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID f2 (Expected: f2), Status:0, Len:72
2022-08-04 21:45:17.917 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000052-0000-1000-8000-0026bb765291 (Handle: 19): Unknown decoded: {'type': '520000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:18.163 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 17 (Expected: 17), Status:0, Len:72
2022-08-04 21:45:18.164 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000053-0000-1000-8000-0026bb765291 (Handle: 22): Unknown decoded: {'type': '530000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:18.453 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 92 (Expected: 92), Status:0, Len:72
2022-08-04 21:45:18.454 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 00000054-0000-1000-8000-0026bb765291 (Handle: 25): Unknown decoded: {'type': '540000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-04 21:45:18.742 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 93 (Expected: 93), Status:0, Len:76
2022-08-04 21:45:18.743 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 44ff6853-58db-4956-b298-5f6650dd61f6 (Handle: 31): Unknown decoded: {'type': '44FF685358DB4956B2985F6650DD61F6', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-04 21:45:18.989 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID c3 (Expected: c3), Status:0, Len:77
2022-08-04 21:45:18.990 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: cf68c40f-dc6f-4f7e-918c-4c536b643a2b (Handle: 34): Unknown decoded: {'type': 'CF68C40FDC6F4F7E918C4C536B643A2B', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 0, 'maxValue': 3}
2022-08-04 21:45:19.278 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 67 (Expected: 67), Status:0, Len:79
2022-08-04 21:45:19.279 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 4058c2b8-4545-4e77-b6b7-157c38f9718b (Handle: 37): Unknown decoded: {'type': '4058C2B845454E77B6B7157C38F9718B', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 1, 'maxValue': 5}
2022-08-04 21:45:19.524 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 8c (Expected: 8c), Status:0, Len:73
2022-08-04 21:45:19.525 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: b498f4b5-6364-4f79-b5cc-1563ade070df (Handle: 40): Unknown decoded: {'type': 'B498F4B563644F79B5CC1563ADE070DF', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minValue': 0, 'maxValue': 1}
2022-08-04 21:45:19.772 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 61 (Expected: 61), Status:0, Len:70
2022-08-04 21:45:19.773 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: afae7ad2-8dd3-4b20-bae0-c0b18b79edb5 (Handle: 43): Unknown decoded: {'type': 'AFAE7AD28DD34B20BAE0C0B18B79EDB5', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-04 21:45:20.101 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 9e (Expected: 9e), Status:0, Len:70
2022-08-04 21:45:20.102 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 87d91ec6-c508-4cad-89f1-a21b0bf179a0 (Handle: 46): Unknown decoded: {'type': '87D91EC6C5084CAD89F1A21B0BF179A0', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-04 21:45:20.391 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID c2 (Expected: c2), Status:0, Len:67
2022-08-04 21:45:20.392 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: 4c3e2641-f57f-11e3-a3ac-0800200c9a66 (Handle: 49): Unknown decoded: {'type': '4C3E2641F57F11E3A3AC0800200C9A66', 'iid': None, 'perms': ['pr'], 'format': 'uint64'}
2022-08-04 21:45:20.576 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.rest
2022-08-04 21:45:20.682 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 20 (Expected: 20), Status:0, Len:80
2022-08-04 21:45:20.683 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: eec26990-f628-11e3-a3ac-0800200c9a66 (Handle: 52): Unknown decoded: {'type': 'EEC26990F62811E3A3AC0800200C9A66', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'uint8', 'minStep': 1, 'minValue': 4, 'maxValue': 8}
2022-08-04 21:45:20.969 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID b0 (Expected: b0), Status:0, Len:71
2022-08-04 21:45:20.970 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: bcde3b9e-3963-4123-b24d-42eccbb3a9c4 (Handle: 55): Unknown decoded: {'type': 'BCDE3B9E39634123B24D42ECCBB3A9C4', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-04 21:45:21.264 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6b (Expected: 6b), Status:0, Len:64
2022-08-04 21:45:21.265 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: a9464d14-6806-4375-ba53-e14f7e0a6bee (Handle: 58): Unknown decoded: {'type': 'A9464D1468064375BA53E14F7E0A6BEE', 'iid': None, 'perms': ['pr', 'pw']}
2022-08-04 21:45:21.265 ERROR (MainThread) [homeassistant.components.homekit_controller.config_flow] Pairing attempt failed with an unhandled exception
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 465, in async_step_pair
return await self._entry_from_accessory(pairing)
File "/usr/src/homeassistant/homeassistant/components/homekit_controller/config_flow.py", line 589, in _entry_from_accessory
name = await pairing.get_primary_name()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/abstract.py", line 143, in get_primary_name
accessories = await self.list_accessories_and_characteristics()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 100, in _async_wrap
return await func(self, *args, **kwargs)
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/client.py", line 61, in _async_wrap
return await func(*args, **kwargs)
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 504, in list_accessories_and_characteristics
await self._populate_accessories_and_characteristics()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 585, in _populate_accessories_and_characteristics
accessories = await self._async_fetch_gatt_database()
File "/usr/local/lib/python3.10/site-packages/aiohomekit/controller/ble/pairing.py", line 469, in _async_fetch_gatt_database
hap_char.format = decoded["format"]
KeyError: 'format'
2022-08-04 21:45:21.281 DEBUG (MainThread) [aiohomekit.controller.ble.discovery] Ensure connected with device 5F:A9:47:01:A0:50: SENSE
2022-08-04 21:45:21.282 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-04 21:45:21.282 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x036/\x00'
2022-08-04 21:45:21.460 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x026\x00\x03\x00\x01\x01\x01')
2022-08-04 21:45:21.460 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 36 (Expected: 36), Status:0, Len:3
2022-08-04 21:45:21.461 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-04 21:45:21.461 DEBUG (MainThread) [aiohomekit.protocol.tlv] sending [
6: (1 bytes/<class 'bytearray'>) 0x01
0: (1 bytes/<class 'bytearray'>) 0x01
]
2022-08-04 21:45:21.461 DEBUG (MainThread) [aiohomekit.controller.ble.client] Using fragment size: 97
2022-08-04 21:45:21.462 DEBUG (MainThread) [aiohomekit.controller.ble.client] Queuing fragment for write: b'\x00\x02&-\x00\x0b\x00\t\x01\x01\x01\x06\x06\x01\x01\x00\x01\x01'
2022-08-04 21:45:21.669 DEBUG (MainThread) [aiohomekit.controller.ble.client] Read fragment: bytearray(b'\x02&\x00\x08\x00\x01\x06\x06\x01\x02\x07\x01\x06')
2022-08-04 21:45:21.670 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 26 (Expected: 26), Status:0, Len:8
2022-08-04 21:45:21.671 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
1: (6 bytes/<class 'bytearray'>) 0x060102070106
]
2022-08-04 21:45:21.671 DEBUG (MainThread) [aiohomekit.protocol.tlv] receiving [
6: (1 bytes/<class 'bytearray'>) 0x02
7: (1 bytes/<class 'bytearray'>) 0x06
]
bdraco commented 2 years ago

It looks like one of the vendor provided characteristics is missing format information.

2022-08-04 21:45:21.265 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SENSE (5F:A9:47:01:A0:50): char: a9464d14-6806-4375-ba53-e14f7e0a6bee (Handle: 58): Unknown decoded: {'type': 'A9464D1468064375BA53E14F7E0A6BEE', 'iid': None, 'perms': ['pr', 'pw']}

There should be a format field in the response.

Without the format information we don't know how to decode the characteristic. This looks like a bug in the locks firmware. We might be able to make a reasonable guess, but we need to know what the data looks like.

Unfortunately, I'd need access to the lock to figure out how to handle this case.

TravisRoy commented 2 years ago

What kind of access would you need? Physical access? Admin access to my HA instance? I'm happy to work with you to get this solved.

bdraco commented 2 years ago

Physical access would be best but thats likely a big ask. I know my neighbor has one of these so I'm going to see if they are feeling generous about letting me test their lock this weekend.

TravisRoy commented 2 years ago

w00t! Just saw this. I can't wait to try it out.