Improve pairing performance and reliablity

Open bdraco opened this issue 1 year ago • 2 comments

https://community.home-assistant.io/t/2022-8-you-can-fix-it/446505/133?u=bdraco

Aug 04 '22 05:08 bdraco

Codecov Report

Merging #130 (85f206f) into main (ae1c3cc) will decrease coverage by 0.30%. The diff coverage is 23.13%.

@@            Coverage Diff             @@
##             main     #130      +/-   ##
==========================================
- Coverage   71.24%   70.93%   -0.31%     
==========================================
  Files          69       69              
  Lines        5759     5794      +35     
==========================================
+ Hits         4103     4110       +7     
- Misses       1656     1684      +28

Flag	Coverage Δ
unittests	`70.93% <23.13%> (-0.31%)`	:arrow_down:

Flags with carried forward coverage won't be shown. Click here to find out more.

Impacted Files	Coverage Δ
aiohomekit/controller/ble/client.py	`30.48% <0.00%> (-1.04%)`	:arrow_down:
aiohomekit/controller/ble/controller.py	`48.51% <0.00%> (ø)`
aiohomekit/controller/ble/pairing.py	`24.44% <5.33%> (-0.72%)`	:arrow_down:
aiohomekit/controller/ble/bleak.py	`41.46% <20.00%> (-20.45%)`	:arrow_down:
aiohomekit/controller/ble/discovery.py	`37.20% <23.52%> (-3.06%)`	:arrow_down:
aiohomekit/controller/abstract.py	`81.97% <100.00%> (ø)`
aiohomekit/controller/controller.py	`71.87% <100.00%> (ø)`
aiohomekit/model/__init__.py	`96.41% <100.00%> (ø)`
aiohomekit/pdu.py	`100.00% <100.00%> (ø)`
aiohomekit/uuid.py	`100.00% <100.00%> (ø)`

Help us with your feedback. Take ten seconds to tell us how you rate us. Have a feature suggestion? Share it here.

Aug 04 '22 06:08 codecov[bot]

SYLVANIA Outlet is pairing reliability now.

Unfortunately the switch/outlet service is only appearing on mac and not linux. Trying to figure out what is different

Aug 04 '22 07:08 bdraco

So I think we are holding on to the original entity map on the home assistant side and not removing it on unpair

Aug 04 '22 08:08 bdraco

2022-08-03 22:57:04.450 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] Eve Button (EE:5B:3A:2E:EC:28): Connection closed from close call
2022-08-03 22:57:04.464 DEBUG (MainThread) [homeassistant.components.homekit_controller.storage] Deleting entity map for DD:C4:7A:59:6B:1D
2022-08-03 22:57:04.465 DEBUG (MainThread) [bleak_retry_connector] Eve Button (EE:5B:3A:2E:EC:28): Connecting (attempt: 1)

Aug 04 '22 08:08 bdraco

So we have the pairing in the map file twice

  "dd:c4:7a:59:6b:1d": {                                       

  "DD:C4:7A:59:6B:1D": {

Aug 04 '22 09:08 bdraco

Fixed that on the hass side

Aug 04 '22 09:08 bdraco

Gatt db on linux with the missing switch

2022-08-03 23:25:33.069 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): Fetching gatt database because, cached_config_num: -1, adv config_num: 0
2022-08-03 23:25:33.069 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): Fetching GATT database
2022-08-03 23:25:33.337 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 89 (Expected: 89), Status:0, Len:53
2022-08-03 23:25:33.337 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000014-0000-1000-8000-0026bb765291 (Handle: 43): Hardcopy Data Channel decoded: {'type': '140000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'bool'}
2022-08-03 23:25:33.741 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID a2 (Expected: a2), Status:0, Len:53
2022-08-03 23:25:33.741 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000020-0000-1000-8000-0026bb765291 (Handle: 46): Unknown decoded: {'type': '200000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:25:34.011 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 81 (Expected: 81), Status:0, Len:53
2022-08-03 23:25:34.012 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000021-0000-1000-8000-0026bb765291 (Handle: 49): Unknown decoded: {'type': '210000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:25:34.282 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 79 (Expected: 79), Status:0, Len:53
2022-08-03 23:25:34.282 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 52): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:25:34.596 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d2 (Expected: d2), Status:0, Len:53
2022-08-03 23:25:34.596 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000030-0000-1000-8000-0026bb765291 (Handle: 55): Unknown decoded: {'type': '300000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:25:34.867 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6b (Expected: 6b), Status:0, Len:53
2022-08-03 23:25:34.867 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000052-0000-1000-8000-0026bb765291 (Handle: 58): Unknown decoded: {'type': '520000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:25:35.136 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID aa (Expected: aa), Status:0, Len:53
2022-08-03 23:25:35.137 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 67): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:25:35.137 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for 00000037-0000-1000-8000-0026bb765291
2022-08-03 23:25:35.317 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID fd (Expected: fd), Status:0, Len:53
2022-08-03 23:25:35.318 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 0000004c-0000-1000-8000-0026bb765291 (Handle: 243): Unknown decoded: {'type': '4C0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:25:35.676 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID fc (Expected: fc), Status:0, Len:53
2022-08-03 23:25:35.676 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 0000004e-0000-1000-8000-0026bb765291 (Handle: 246): Unknown decoded: {'type': '4E0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:25:35.901 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d6 (Expected: d6), Status:0, Len:53
2022-08-03 23:25:35.902 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 0000004f-0000-1000-8000-0026bb765291 (Handle: 249): Unknown decoded: {'type': '4F0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'uint8'}
2022-08-03 23:25:36.217 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6d (Expected: 6d), Status:0, Len:53
2022-08-03 23:25:36.217 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 00000050-0000-1000-8000-0026bb765291 (Handle: 252): Unknown decoded: {'type': '500000100080000026BB765291', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'data'}
2022-08-03 23:25:36.217 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for a3dd50bf-f7a7-4e99-838e-570a086c661b
2022-08-03 23:25:36.217 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for a2e86c7a-d961-4091-b74f-2409e72efe26
2022-08-03 23:25:36.217 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for a47f7608-2e2d-47eb-913b-75d4edc4de4b
2022-08-03 23:25:36.487 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID a8 (Expected: a8), Status:0, Len:53
2022-08-03 23:25:36.487 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 65300): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:25:36.802 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID ce (Expected: ce), Status:0, Len:53
2022-08-03 23:25:36.802 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: b176bd7f-4148-47bd-a6c6-9d0796e96183 (Handle: 65303): Unknown decoded: {'type': 'B176BD7F414847BDA6C69D0796E96183', 'iid': None, 'perms': ['pr', 'pw', 'ev'], 'format': 'data'}
2022-08-03 23:25:37.161 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 4e (Expected: 4e), Status:0, Len:53
2022-08-03 23:25:37.161 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: b2fd7f2d-ead3-4f17-b16c-202ec758c697 (Handle: 65307): Unknown decoded: {'type': 'B2FD7F2DEAD34F17B16C202EC758C697', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-03 23:25:37.522 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 38 (Expected: 38), Status:0, Len:53
2022-08-03 23:25:37.522 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): char: b31259a5-9acc-45c2-838a-956f57825196 (Handle: 65310): Unknown decoded: {'type': 'B31259A59ACC45C2838A956F57825196', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-03 23:25:37.522 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for 5e9bf2a8-f93f-4481-a67e-3b2f4a07891a
2022-08-03 23:25:37.522 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): No iid for 8ac32d3f-5cb9-4d44-bec2-ee689169f626
2022-08-03 23:25:37.523 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet (FF:19:B0:B2:DF:85): Completed fetching GATT database

Aug 04 '22 09:08 bdraco

gatt db on mac with the working switch


2022-08-03 23:17:03.464 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): Fetching gatt database because, cached_config_num: -1, adv config_num: 0
2022-08-03 23:17:03.464 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): Fetching GATT database
2022-08-03 23:17:03.548 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 51 (Expected: 51), Status:0, Len:53
2022-08-03 23:17:03.548 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000014-0000-1000-8000-0026bb765291 (Handle: 43): Hardcopy Data Channel decoded: {'type': '140000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'bool'}
2022-08-03 23:17:03.652 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 80 (Expected: 80), Status:0, Len:53
2022-08-03 23:17:03.653 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000020-0000-1000-8000-0026bb765291 (Handle: 46): Unknown decoded: {'type': '200000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:03.743 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 5b (Expected: 5b), Status:0, Len:53
2022-08-03 23:17:03.743 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000021-0000-1000-8000-0026bb765291 (Handle: 49): Unknown decoded: {'type': '210000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:03.833 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 08 (Expected: 08), Status:0, Len:53
2022-08-03 23:17:03.833 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 52): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:03.940 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID e3 (Expected: e3), Status:0, Len:53
2022-08-03 23:17:03.940 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000030-0000-1000-8000-0026bb765291 (Handle: 55): Unknown decoded: {'type': '300000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.060 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 59 (Expected: 59), Status:0, Len:53
2022-08-03 23:17:04.061 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000052-0000-1000-8000-0026bb765291 (Handle: 58): Unknown decoded: {'type': '520000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.180 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 3f (Expected: 3f), Status:0, Len:53
2022-08-03 23:17:04.181 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 67): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:04.267 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 55 (Expected: 55), Status:0, Len:53
2022-08-03 23:17:04.268 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000037-0000-1000-8000-0026bb765291 (Handle: 70): Unknown decoded: {'type': '370000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.374 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 2b (Expected: 2b), Status:0, Len:53
2022-08-03 23:17:04.374 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 125): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:04.464 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID a8 (Expected: a8), Status:0, Len:53
2022-08-03 23:17:04.465 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000025-0000-1000-8000-0026bb765291 (Handle: 128): Unknown decoded: {'type': '250000100080000026BB765291', 'iid': None, 'perms': ['pr', 'pw', 'ev'], 'format': 'bool'}
2022-08-03 23:17:04.553 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d0 (Expected: d0), Status:0, Len:53
2022-08-03 23:17:04.553 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000026-0000-1000-8000-0026bb765291 (Handle: 115): Unknown decoded: {'type': '260000100080000026BB765291', 'iid': None, 'perms': ['pr', 'ev'], 'format': 'bool'}
2022-08-03 23:17:04.643 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 19 (Expected: 19), Status:0, Len:53
2022-08-03 23:17:04.643 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 132): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.703 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d0 (Expected: d0), Status:0, Len:53
2022-08-03 23:17:04.703 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 0000004c-0000-1000-8000-0026bb765291 (Handle: 243): Unknown decoded: {'type': '4C0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:04.795 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 8c (Expected: 8c), Status:0, Len:53
2022-08-03 23:17:04.795 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 0000004e-0000-1000-8000-0026bb765291 (Handle: 246): Unknown decoded: {'type': '4E0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:04.853 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 3e (Expected: 3e), Status:0, Len:53
2022-08-03 23:17:04.853 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 0000004f-0000-1000-8000-0026bb765291 (Handle: 249): Unknown decoded: {'type': '4F0000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'uint8'}
2022-08-03 23:17:04.943 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 6e (Expected: 6e), Status:0, Len:53
2022-08-03 23:17:04.943 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000050-0000-1000-8000-0026bb765291 (Handle: 252): Unknown decoded: {'type': '500000100080000026BB765291', 'iid': None, 'perms': ['pr', 'pw'], 'format': 'data'}
2022-08-03 23:17:04.943 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): No iid for a3dd50bf-f7a7-4e99-838e-570a086c661b
2022-08-03 23:17:04.944 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): No iid for a2e86c7a-d961-4091-b74f-2409e72efe26
2022-08-03 23:17:04.944 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): No iid for a47f7608-2e2d-47eb-913b-75d4edc4de4b
2022-08-03 23:17:05.047 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 4e (Expected: 4e), Status:0, Len:53
2022-08-03 23:17:05.048 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 65300): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:05.138 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 8a (Expected: 8a), Status:0, Len:53
2022-08-03 23:17:05.138 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: b176bd7f-4148-47bd-a6c6-9d0796e96183 (Handle: 65303): Unknown decoded: {'type': 'B176BD7F414847BDA6C69D0796E96183', 'iid': None, 'perms': ['pr', 'pw', 'ev'], 'format': 'data'}
2022-08-03 23:17:05.244 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID de (Expected: de), Status:0, Len:53
2022-08-03 23:17:05.245 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: b2fd7f2d-ead3-4f17-b16c-202ec758c697 (Handle: 65307): Unknown decoded: {'type': 'B2FD7F2DEAD34F17B16C202EC758C697', 'iid': None, 'perms': ['pw'], 'format': 'data'}
2022-08-03 23:17:05.332 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID e8 (Expected: e8), Status:0, Len:53
2022-08-03 23:17:05.333 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: b31259a5-9acc-45c2-838a-956f57825196 (Handle: 65310): Unknown decoded: {'type': 'B31259A59ACC45C2838A956F57825196', 'iid': None, 'perms': ['pr'], 'format': 'data'}
2022-08-03 23:17:05.333 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): No iid for 5e9bf2a8-f93f-4481-a67e-3b2f4a07891a
2022-08-03 23:17:05.333 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): No iid for 8ac32d3f-5cb9-4d44-bec2-ee689169f626
2022-08-03 23:17:05.333 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): Completed fetching GATT database

Aug 04 '22 09:08 bdraco

on linux we are missing

2022-08-03 23:17:04.267 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 55 (Expected: 55), Status:0, Len:53
2022-08-03 23:17:04.268 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000037-0000-1000-8000-0026bb765291 (Handle: 70): Unknown decoded: {'type': '370000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.374 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 2b (Expected: 2b), Status:0, Len:53
2022-08-03 23:17:04.374 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 000000a5-0000-1000-8000-0026bb765291 (Handle: 125): Unknown decoded: {'type': 'A50000100080000026BB765291', 'iid': None, 'perms': [], 'format': 'data'}
2022-08-03 23:17:04.464 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID a8 (Expected: a8), Status:0, Len:53
2022-08-03 23:17:04.465 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000025-0000-1000-8000-0026bb765291 (Handle: 128): Unknown decoded: {'type': '250000100080000026BB765291', 'iid': None, 'perms': ['pr', 'pw', 'ev'], 'format': 'bool'}
2022-08-03 23:17:04.553 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d0 (Expected: d0), Status:0, Len:53
2022-08-03 23:17:04.553 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000026-0000-1000-8000-0026bb765291 (Handle: 115): Unknown decoded: {'type': '260000100080000026BB765291', 'iid': None, 'perms': ['pr', 'ev'], 'format': 'bool'}
2022-08-03 23:17:04.643 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID 19 (Expected: 19), Status:0, Len:53
2022-08-03 23:17:04.643 DEBUG (MainThread) [aiohomekit.controller.ble.pairing] SYLVANIA Outlet-3180 (15725DB4-15E1-A589-7A9D-918FF6628C0C): char: 00000023-0000-1000-8000-0026bb765291 (Handle: 132): Unknown decoded: {'type': '230000100080000026BB765291', 'iid': None, 'perms': ['pr'], 'format': 'string'}
2022-08-03 23:17:04.703 DEBUG (MainThread) [aiohomekit.pdu] Got PDU 2: TID d0 (Expected: d0), Status:0, Len:53

Aug 04 '22 09:08 bdraco

INFO:__main__:[Service] 00000047-0000-1000-8000-0026bb765291 (Handle: 112): Unknown
ERROR:__main__:	[Characteristic] e604e95d-a759-4817-87d3-aa005083a0d1 (Handle: 113): Unknown (read), Value: Multiple Characteristics with this UUID, refer to your desired characteristic by the `handle` attribute instead.
ERROR:__main__:	[Characteristic] 000000a5-0000-1000-8000-0026bb765291 (Handle: 125): Unknown (read,write), Value: Multiple Characteristics with this UUID, refer to your desired characteristic by the `handle` attribute instead.
INFO:__main__:		[Descriptor] dc46f0fe-81d2-4616-b5d9-6abdd796939a (Handle: 127): None) | Value: b'\x13\x00'
ERROR:__main__:	[Characteristic] 00000025-0000-1000-8000-0026bb765291 (Handle: 128): Unknown (read,write,indicate), Value: Failed to read characteristic 128: Error Domain=CBATTErrorDomain Code=2 "Reading is not permitted." UserInfo={NSLocalizedDescription=Reading is not permitted.}
INFO:__main__:		[Descriptor] dc46f0fe-81d2-4616-b5d9-6abdd796939a (Handle: 130): None) | Value: b'\x0f\x00'
INFO:__main__:		[Descriptor] 00002902-0000-1000-8000-00805f9b34fb (Handle: 131): Client Characteristic Configuration) | Value: b'\x00\x00'
ERROR:__main__:	[Characteristic] 00000026-0000-1000-8000-0026bb765291 (Handle: 115): Unknown (read,write,indicate), Value: Failed to read characteristic 115: Error Domain=CBATTErrorDomain Code=2 "Reading is not permitted." UserInfo={NSLocalizedDescription=Reading is not permitted.}
INFO:__main__:		[Descriptor] dc46f0fe-81d2-4616-b5d9-6abdd796939a (Handle: 117): None) | Value: b'\x1b\x00'
INFO:__main__:		[Descriptor] 00002902-0000-1000-8000-00805f9b34fb (Handle: 118): Client Characteristic Configuration) | Value: b'\x00\x00'
ERROR:__main__:	[Characteristic] 00000023-0000-1000-8000-0026bb765291 (Handle: 132): Unknown (read,write), Value: Multiple Characteristics with this UUID, refer to your desired characteristic by the `handle` attribute instead.
INFO:__main__:		[Descriptor] dc46f0fe-81d2-4616-b5d9-6abdd796939a (Handle: 134): None) | Value: b'\x10\x00'

On linux its just skipped over

Aug 04 '22 09:08 bdraco

FF:19:B0:B2:DF:85

Aug 04 '22 10:08 bdraco

[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0001
	00001801-0000-1000-8000-00805f9b34fb
	Generic Attribute Profile
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028
	0000003e-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0029
	e604e95d-a759-4817-87d3-aa005083a0d1
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char002b
	00000014-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char002b/desc002d
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char002e
	00000020-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char002e/desc0030
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0031
	00000021-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0031/desc0033
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0034
	00000023-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0034/desc0036
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0037
	00000030-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char0037/desc0039
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char003a
	00000052-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0028/char003a/desc003c
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040
	000000a2-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040/char0041
	e604e95d-a759-4817-87d3-aa005083a0d1
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040/char0043
	000000a5-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040/char0043/desc0045
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040/char0046
	00000037-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service0040/char0046/desc0048
	00002902-0000-1000-8000-00805f9b34fb
	Client Characteristic Configuration
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0
	00000055-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f1
	e604e95d-a759-4817-87d3-aa005083a0d1
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f3
	0000004c-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f3/desc00f5
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f6
	0000004e-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f6/desc00f8
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f9
	0000004f-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00f9/desc00fb
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00fc
	00000050-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/service00f0/char00fc/desc00fe
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff00
	ae5d1e47-5c13-43a0-8635-82ad38a1381f
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff00/charff01
	a3dd50bf-f7a7-4e99-838e-570a086c661b
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff00/charff01/descff03
	00002902-0000-1000-8000-00805f9b34fb
	Client Characteristic Configuration
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff00/charff04
	a2e86c7a-d961-4091-b74f-2409e72efe26
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff00/charff06
	a47f7608-2e2d-47eb-913b-75d4edc4de4b
	Vendor specific
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11
	b0733e83-8434-4c00-a344-25d1c982a0ef
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff12
	e604e95d-a759-4817-87d3-aa005083a0d1
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff14
	000000a5-0000-1000-8000-0026bb765291
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff14/descff16
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff17
	b176bd7f-4148-47bd-a6c6-9d0796e96183
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff17/descff19
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff17/descff1a
	00002902-0000-1000-8000-00805f9b34fb
	Client Characteristic Configuration
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff1b
	b2fd7f2d-ead3-4f17-b16c-202ec758c697
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff1b/descff1d
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff1e
	b31259a5-9acc-45c2-838a-956f57825196
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff11/charff1e/descff20
	dc46f0fe-81d2-4616-b5d9-6abdd796939a
	Vendor specific
[NEW] Primary Service (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff3a
	1b7e8251-2877-41c3-b46e-cf057c562023
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff3a/charff3b
	5e9bf2a8-f93f-4481-a67e-3b2f4a07891a
	Vendor specific
[NEW] Characteristic (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff3a/charff3e
	8ac32d3f-5cb9-4d44-bec2-ee689169f626
	Vendor specific
[NEW] Descriptor (Handle 0x0000)
	/org/bluez/hci0/dev_EC_84_2A_DC_26_A8/serviceff3a/charff3e/descff40
	00002902-0000-1000-8000-00805f9b34fb
	Client Characteristic Configuration
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 0000003e-0000-1000-8000-0026bb765291
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 00000047-0000-1000-8000-0026bb765291
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 00000055-0000-1000-8000-0026bb765291
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 000000a2-0000-1000-8000-0026bb765291
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 00001800-0000-1000-8000-00805f9b34fb
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 00001801-0000-1000-8000-00805f9b34fb
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: 1b7e8251-2877-41c3-b46e-cf057c562023
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: ae5d1e47-5c13-43a0-8635-82ad38a1381f
[CHG] Device EC:84:2A:DC:26:A8 UUIDs: b0733e83-8434-4c00-a344-25d1c982a0ef
[CHG] Device EC:84:2A:DC:26:A8 ServicesResolved: yes
[CHG] Device EC:84:2A:DC:26:A8 Name: SYLVANIA Outlet
[CHG] Device EC:84:2A:DC:26:A8 Alias: SYLVANIA Outlet

bluetoothctl connect can't see it either

Aug 04 '22 10:08 bdraco

I ordered another one for testing

https://www.amazon.com/SYLVANIA-Bluetooth-Compatible-Assistant-Required/dp/B09L5B4XBZ/ref=sr_1_7?crid=2W4IRTKL9UDG2&keywords=sylvania+plug&qid=1659608862&sprefix=sylvania+plu%2Caps%2C201&sr=8-7

Aug 04 '22 10:08 bdraco

aiohomekit aiohomekit copied to clipboard

Improve pairing performance and reliablity

Codecov Report

aiohomekit
aiohomekit copied to clipboard