This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts

"Pairing not supported" when reconnecting to multiple devices using Android BLE Library

Hi

We are seeing a strange issue when trying to use the Android BLE Library to Android BLE Library to reconnect to two devices. The phone succeeds in connecting to one device but not the other, and because of this failure it deletes the bonding information. Meaning it can not connect again until the user goes through the whole bonding procedure.

The same devices work fine when using ios, we tested the reconnecting on ios 100 times and never saw the issue.
The issue does not occur every time, but seems to only be occurring when both devices are found (and being connected to) simultaneously
The issue can be triggered by either walking in and out of range, or by turning off and on bluetooth

We would be very grateful for any help in figuring this out.
Please let us know if you require any further information

the device starting with e3 is the embedded device, running zephyr with nrf connect sdk v1.5.1, the other device is the phone


hci log

btsnoop��Dd*dw 
�Dd*i�Dd+�	�D��V (*�D�…
�D�2�
6�D�4 	
6�D�4�-�D�6* 
JJ�D�6P~EA��R���7�����X UE�v~��h��|���P�_�$��zj��8�]�`�R��v�x��v��  �D�8:Q AFs��g���{6�� D�n+�  �D�8=<�2̬�O��v�;��Ȃe�����D�8>�໡hF?UC�՝Dkr��D�8A ?�{T�@~�]�GPq	�D�8mW1�����q
6҅�D�9�8 ݅-#���r|,�����D�]�D
�}�s�i�W��N	�D֦�r 
˃e��Ԑ�w��H��D֧�c@�o(}��-�b�r��D֧��	�DnFP��D֯@�
6�D֯u� �D֯w&��*�D֯�� 
		eSeat�D֯�N��(�D֯� 	�D֯�W��(�Dְ" ?f8�����Iꐀ��Dְ&��(�Dְ\�  ';�Dְ_[(��(�Dְ� (0
1346�Dְ�7��(�Dְ�� 7=צ�N�ơLW��c��Dְ�>��(�Dֱk 	>
�Dֱ!(�DֱE� 	
�DֱGw(�Dֱ�� 	 *
)+�Dֱ�G(�Dֱ�� 
		*+�Dֱ��(�Dֱ�* 	
�Dֱ�6	�Dֲ0� 
)�Dֲ3�	(�Dֲk� 		
�Dֲm�	(�Dֲ�� 	
*
*�Dֲ��
(�Dֲ�� 
		*�Dֲ�(�Dֳ8� 	
�Dֳ=�(�Dֳs] 	
�Dֳv�(  �Dֳ�� 	%q�˿J��K&_���Dֳ��(  �Dִ� 	v�� �r��O��j�I �Dִ$a(�Dִz� 	
�Dִ}j	�Dִ�m 
)�Dִ��	�Dֵ� 
)�DֵU(�DֵGA 	
�DֵH�(�Dֵ�� 
		*�Dֵ��(�Dֵ�: 	
�Dֵ�)	�Dֵ�� 
)�Dֵ�(�Dֶ3Y 	
�Dֶ5
(�DֶnE 	�*�*�DֶpB(�Dֶ�� 	
�Dֶ�� '(�Dֶ�� 	 
�Dֶ�� '(�Dַ� 	!"++$"%,+�Dַ�%'(�Dַ�: 	%
�Dַ�s	##�Dַ�l 
#)�Dַ�o	&'�Dָ 
&)')�Dָ	y(0(�Dָ_� 	(
�Dָbr(0(�Dָ�K 	)*$*+,)*�Dָ��,0(�Dָվ 	-.&*/0'*�Dָ�P00(�Dֹ� 	0
�Dֹ�13(�DֹK 	1
�DֹM�13(�Dֹ�� 
		2
3*�Dֹ�|33(�Dֹ� 	3
�Dֹ�46(�Dֺ. 	4
�DֺB46(�DֺQ� 
		56*�DֺT,66(�Dֺ�� 	6
�Dֺ�m7=(�Dֺǧ 	7
�Dֺ��7=(  �Dֻ� 	89�ڦ�N�ơLW��c��Dֻr9=(  �Dֻ< 	;<&�mgi��H�#��
�Dֻ>�<=(�Dֻv� 	<
�Dֻyf	::�Dֻ�� 
:)�Dֻ�<	==�Dֻ�� 
=)�D؈��	

�D؉h� �D؉�B
�D؊� 
eSeat�D؊؊	

�D،(� �D،?|
�D؍�� V�D؍�y	&

�D؎�� �D؏*R"�D؏
%�DؐG_ ��Dؐa2
R"�Dؐo
%�Dؑ�! �
�D���� 
�D����D�ҋv	



typical reconnection failure log from nrf connect

nRF Connect, 2021-04-29
aname (E3:09:89:D2:8A:8C)
V	16:37:23.444	Connecting to E3:09:89:D2:8A:8C...
D	16:37:23.444	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:37:23.457	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:37:23.457	Connected to E3:09:89:D2:8A:8C
D	16:37:23.458	wait(1600ms)
V	16:37:25.059	Discovering services...
D	16:37:25.059	gatt.discoverServices()
D	16:37:25.070	[Callback] Services discovered with status: 0
I	16:37:25.070	Services discovered
V	16:37:25.100	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
- Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
   Characteristic User Description (0x2901)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
- Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
   Characteristic User Description (0x2901)
D	16:37:25.100	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	16:37:25.103	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	16:37:25.104	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	16:37:41.361	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING OFF
I	16:37:41.374	Disconnected
D	16:37:41.375	gatt.close()
D	16:37:41.378	wait(200)
D	16:37:41.793	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to OFF
D	16:37:49.427	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING ON
D	16:37:49.556	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to ON
D	16:37:51.027	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	16:37:51.051	Connecting to E3:09:89:D2:8A:8C...
D	16:37:51.051	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:37:51.065	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:37:51.065	Connected to E3:09:89:D2:8A:8C
D	16:37:51.067	wait(1600ms)
D	16:37:51.211	[Callback] Connection state changed with status: 19 and new state: DISCONNECTED (0)
W	16:37:51.211	Connection terminated by peer (status 19)
I	16:37:51.211	Disconnected
D	16:37:51.217	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	16:39:40.586	Removing bond information...
D	16:39:40.586	device.removeBond() (hidden)
D	16:39:40.650	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_NONE (10)
I	16:39:40.650	Bond information deleted
D	16:42:01.712	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	16:42:01.712	gatt.close()
D	16:42:01.734	wait(200)
V	16:42:01.938	Connecting to E3:09:89:D2:8A:8C...
D	16:42:01.938	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:42:01.969	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:42:01.969	Connected to E3:09:89:D2:8A:8C
V	16:42:01.986	Discovering services...
D	16:42:01.986	gatt.discoverServices()
I	16:42:02.156	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	16:42:03.266	[Callback] Services discovered with status: 0
I	16:42:03.266	Services discovered
V	16:42:03.285	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
- Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
   Characteristic User Description (0x2901)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
- Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
   Characteristic User Description (0x2901)
D	16:42:03.285	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	16:42:03.287	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	16:42:03.287	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
I	16:42:03.353	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
D	16:42:03.875	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	16:42:04.311	[Broadcast] Action received: android.bluetooth.device.action.PAIRING_REQUEST, pairing variant: PAIRING_VARIANT_PASSKEY_CONFIRMATION (2)
I	16:42:04.388	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	16:42:08.906	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	16:42:08.906	Device bonded
I	16:42:09.760	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	16:42:11.550	Indication received from 00002b2c-0000-1000-8000-00805f9b34fb, value: (0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-00-08
A	16:42:11.550	"(0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-00-08" received
I	16:42:12.202	Indication received from 00002b2c-0000-1000-8000-00805f9b34fb, value: (0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-00-08
A	16:42:12.202	"(0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-00-08" received
I	16:42:12.559	Indication received from 00002b2c-0000-1000-8000-00805f9b34fb, value: (0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-01-00
A	16:42:12.559	"(0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-01-00" received
I	16:42:12.737	Indication received from 00002b2c-0000-1000-8000-00805f9b34fb, value: (0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-01-08
A	16:42:12.737	"(0x) 81-00-04-00-02-02-01-00-00-00-0A-02-00-00-01-08" received
D	16:42:52.715	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING OFF
I	16:42:52.723	Disconnected
D	16:42:52.723	gatt.close()
D	16:42:52.729	wait(200)
D	16:42:53.148	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to OFF
D	16:43:18.465	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING ON
D	16:43:18.630	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to ON
D	16:43:19.911	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	16:43:19.927	Connecting to E3:09:89:D2:8A:8C...
D	16:43:19.928	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:43:19.938	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:43:19.938	Connected to E3:09:89:D2:8A:8C
D	16:43:19.940	wait(1600ms)
I	16:43:20.334	PHY updated (TX: LE 2M, RX: LE 2M)
D	16:43:20.710	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	16:43:20.710	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	16:43:20.710	Device bonded
I	16:43:21.139	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
V	16:43:21.541	Discovering services...
D	16:43:21.541	gatt.discoverServices()
D	16:43:21.875	[Callback] Services discovered with status: 0
I	16:43:21.875	Services discovered
V	16:43:21.895	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
- Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
   Characteristic User Description (0x2901)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
- Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
   Characteristic User Description (0x2901)
- Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
   Characteristic User Description (0x2901)
D	16:43:21.895	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	16:43:21.897	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	16:43:21.898	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
I	16:43:21.953	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	16:43:25.309	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
D	16:43:28.771	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING OFF
I	16:43:28.771	Disconnected
D	16:43:28.782	gatt.close()
D	16:43:28.798	wait(200)
D	16:43:29.211	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to OFF
D	16:43:37.175	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING ON
D	16:43:37.293	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to ON
D	16:43:38.916	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	16:43:38.926	Connecting to E3:09:89:D2:8A:8C...
D	16:43:38.926	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:43:38.934	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:43:38.934	Connected to E3:09:89:D2:8A:8C
D	16:43:38.935	wait(1600ms)
D	16:43:39.101	[Callback] Connection state changed with status: 19 and new state: DISCONNECTED (0)
W	16:43:39.101	Connection terminated by peer (status 19)
I	16:43:39.101	Disconnected
D	16:43:39.112	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED


Atypical reconnection failure, logs from nrf connect
nRF Connect, 2021-05-04
aname (E3:09:89:D2:8A:8C)
V	14:08:02.706	Connecting to E3:09:89:D2:8A:8C...
D	14:08:02.706	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:08:02.716	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:08:02.716	Connected to E3:09:89:D2:8A:8C
D	14:08:02.716	wait(1600ms)
V	14:08:04.318	Discovering services...
D	14:08:04.318	gatt.discoverServices()
D	14:08:04.329	[Callback] Services discovered with status: 0
I	14:08:04.329	Services discovered
V	14:08:04.345	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:08:04.345	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:08:04.347	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:08:04.349	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:08:04.351	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:08:08.968	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:08:08.968	"40%" received
I	14:08:19.001	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:08:19.001	"30%" received
D	14:08:24.421	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING OFF
I	14:08:24.435	Disconnected
D	14:08:24.436	gatt.close()
D	14:08:24.444	wait(200)
D	14:08:24.941	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to OFF
D	14:08:31.464	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING ON
D	14:08:31.597	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to ON
D	14:08:32.896	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	14:08:32.899	Connecting to E3:09:89:D2:8A:8C...
D	14:08:32.899	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:08:32.903	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:08:32.903	Connected to E3:09:89:D2:8A:8C
D	14:08:32.904	wait(1600ms)
I	14:08:33.416	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:08:33.696	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:08:33.726	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:08:33.726	Device bonded
I	14:08:34.133	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
V	14:08:34.504	Discovering services...
D	14:08:34.504	gatt.discoverServices()
D	14:08:34.809	[Callback] Services discovered with status: 0
I	14:08:34.810	Services discovered
V	14:08:34.840	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:08:34.840	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:08:34.844	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:08:34.849	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:08:34.852	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:08:34.868	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	14:08:38.439	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	14:08:38.977	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 0A
A	14:08:38.977	"10%" received
I	14:08:48.988	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 00
A	14:08:48.988	"0%" received
I	14:08:48.989	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 64, "d"
A	14:08:48.989	"100%" received
I	14:08:58.989	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:08:58.989	"90%" received
I	14:09:08.979	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 50, "P"
A	14:09:08.979	"80%" received
I	14:09:19.014	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 46, "F"
A	14:09:19.014	"70%" received
D	14:09:22.434	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING OFF
I	14:09:22.435	Disconnected
D	14:09:22.444	gatt.close()
D	14:09:22.457	wait(200)
D	14:09:22.890	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to OFF
D	14:09:30.305	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to TURNING ON
D	14:09:30.422	[Broadcast] Action received: android.bluetooth.adapter.action.STATE_CHANGED, state changed to ON
D	14:09:31.224	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	14:09:31.241	Connecting to E3:09:89:D2:8A:8C...
D	14:09:31.241	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:09:31.261	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:09:31.261	Connected to E3:09:89:D2:8A:8C
D	14:09:31.262	wait(1600ms)
I	14:09:31.666	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:09:32.030	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:09:32.046	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:09:32.046	Device bonded
I	14:09:32.478	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
V	14:09:32.863	Discovering services...
D	14:09:32.863	gatt.discoverServices()
D	14:09:33.100	[Callback] Services discovered with status: 0
I	14:09:33.100	Services discovered
V	14:09:33.129	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:09:33.129	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:09:33.130	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:09:33.131	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:09:33.132	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:09:33.184	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	14:09:36.807	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	14:09:38.969	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 32, "2"
A	14:09:38.969	"50%" received
I	14:09:49.028	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:09:49.028	"40%" received
I	14:09:59.099	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:09:59.099	"30%" received
I	14:10:09.054	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 14
A	14:10:09.054	"20%" received
D	14:10:11.098	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:10:11.098	Error 8 (0x8): GATT CONN TIMEOUT
I	14:10:11.098	Disconnected
D	14:10:11.120	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:10:11.206	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:10:11.206	gatt.close()
D	14:10:11.223	wait(200)
V	14:10:11.426	Connecting to E3:09:89:D2:8A:8C...
D	14:10:11.426	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:10:11.440	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:10:11.440	Connected to E3:09:89:D2:8A:8C
D	14:10:11.442	wait(1600ms)
I	14:10:11.736	PHY updated (TX: LE 2M, RX: LE 2M)
V	14:10:13.044	Discovering services...
D	14:10:13.044	gatt.discoverServices()
D	14:10:13.069	[Callback] Services discovered with status: 0
I	14:10:13.069	Services discovered
V	14:10:13.104	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:10:13.104	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:10:13.107	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:10:13.109	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:10:13.110	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
D	14:10:14.288	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:10:14.296	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:10:14.297	Device bonded
I	14:10:14.708	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	14:10:18.971	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 0A
A	14:10:18.971	"10%" received
I	14:10:19.023	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
D	14:10:20.199	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:10:20.199	Error 8 (0x8): GATT CONN TIMEOUT
I	14:10:20.199	Disconnected
D	14:10:20.228	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:10:20.338	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:10:20.338	gatt.close()
D	14:10:20.349	wait(200)
V	14:10:20.551	Connecting to E3:09:89:D2:8A:8C...
D	14:10:20.552	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:10:20.566	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:10:20.566	Connected to E3:09:89:D2:8A:8C
D	14:10:20.567	wait(1600ms)
I	14:10:22.133	PHY updated (TX: LE 2M, RX: LE 2M)
V	14:10:22.167	Discovering services...
D	14:10:22.168	gatt.discoverServices()
D	14:10:22.178	[Callback] Services discovered with status: 0
I	14:10:22.178	Services discovered
V	14:10:22.207	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:10:22.207	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:10:22.209	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:10:22.211	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:10:22.212	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
D	14:10:23.284	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:10:23.295	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:10:23.296	Device bonded
I	14:10:23.711	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	14:10:26.368	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	14:10:29.043	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 00
A	14:10:29.043	"0%" received
I	14:10:29.044	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 64, "d"
A	14:10:29.044	"100%" received
I	14:10:39.030	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:10:39.030	"90%" received
I	14:10:49.031	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 50, "P"
A	14:10:49.032	"80%" received
I	14:10:59.008	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 46, "F"
A	14:10:59.008	"70%" received
I	14:11:08.999	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 3C, "<"
A	14:11:08.999	"60%" received
I	14:11:18.988	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 32, "2"
A	14:11:18.988	"50%" received
I	14:11:28.979	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:11:28.979	"40%" received
I	14:11:38.968	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:11:38.968	"30%" received
I	14:11:49.004	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 14
A	14:11:49.004	"20%" received
I	14:11:59.067	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 0A
A	14:11:59.067	"10%" received
I	14:12:09.033	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 00
A	14:12:09.033	"0%" received
I	14:12:09.033	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 64, "d"
A	14:12:09.033	"100%" received
I	14:12:19.034	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:12:19.034	"90%" received
I	14:12:29.067	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 50, "P"
A	14:12:29.067	"80%" received
I	14:12:39.052	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 46, "F"
A	14:12:39.052	"70%" received
I	14:12:49.047	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 3C, "<"
A	14:12:49.047	"60%" received
I	14:12:58.980	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 32, "2"
A	14:12:58.980	"50%" received
I	14:13:09.028	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:13:09.028	"40%" received
I	14:13:19.063	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:13:19.063	"30%" received
I	14:13:29.052	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 14
A	14:13:29.052	"20%" received
I	14:13:39.044	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 0A
A	14:13:39.044	"10%" received
I	14:13:49.030	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 00
A	14:13:49.030	"0%" received
I	14:13:49.035	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 64, "d"
A	14:13:49.035	"100%" received
I	14:13:59.197	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:13:59.197	"90%" received
D	14:14:07.863	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:14:07.863	Error 8 (0x8): GATT CONN TIMEOUT
I	14:14:07.863	Disconnected
D	14:14:07.885	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:23:36.599	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:23:36.600	gatt.close()
D	14:23:36.644	wait(200)
V	14:23:36.848	Connecting to E3:09:89:D2:8A:8C...
D	14:23:36.848	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:23:36.860	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:23:36.860	Connected to E3:09:89:D2:8A:8C
D	14:23:36.868	wait(1600ms)
I	14:23:37.033	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:23:37.717	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:23:37.728	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:23:37.728	Device bonded
I	14:23:38.156	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
V	14:23:38.469	Discovering services...
D	14:23:38.469	gatt.discoverServices()
D	14:23:39.333	[Callback] Services discovered with status: 0
I	14:23:39.333	Services discovered
V	14:23:39.366	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:23:39.367	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:23:39.369	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:23:39.370	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:23:39.372	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:23:39.422	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	14:23:41.885	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
D	14:23:48.863	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:23:48.864	Error 8 (0x8): GATT CONN TIMEOUT
I	14:23:48.864	Disconnected
D	14:23:48.918	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:23:56.458	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:23:56.458	gatt.close()
D	14:23:56.483	wait(200)
V	14:23:56.686	Connecting to E3:09:89:D2:8A:8C...
D	14:23:56.687	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:23:56.696	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:23:56.696	Connected to E3:09:89:D2:8A:8C
D	14:23:56.697	wait(1600ms)
I	14:23:56.892	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:23:57.990	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:23:57.993	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:23:57.993	Device bonded
V	14:23:58.298	Discovering services...
D	14:23:58.298	gatt.discoverServices()
D	14:23:58.309	[Callback] Services discovered with status: 0
I	14:23:58.309	Services discovered
V	14:23:58.334	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:23:58.334	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:23:58.336	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:23:58.337	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:23:58.339	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:23:58.430	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	14:23:58.963	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:23:58.965	"90%" received
D	14:24:08.920	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:24:08.921	Error 8 (0x8): GATT CONN TIMEOUT
I	14:24:08.921	Disconnected
D	14:24:08.944	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:24:18.989	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:24:18.989	gatt.close()
D	14:24:18.998	wait(200)
V	14:24:19.202	Connecting to E3:09:89:D2:8A:8C...
D	14:24:19.202	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:24:19.216	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:24:19.216	Connected to E3:09:89:D2:8A:8C
D	14:24:19.218	wait(1600ms)
I	14:24:19.468	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:24:20.693	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:24:20.698	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:24:20.699	Device bonded
V	14:24:20.819	Discovering services...
D	14:24:20.819	gatt.discoverServices()
D	14:24:20.830	[Callback] Services discovered with status: 0
I	14:24:20.830	Services discovered
V	14:24:20.844	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:24:20.844	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:24:20.845	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:24:20.846	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:24:20.847	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:24:21.134	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	14:24:23.833	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	14:24:24.335	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
D	14:24:25.532	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:24:25.532	Error 8 (0x8): GATT CONN TIMEOUT
I	14:24:25.532	Disconnected
D	14:24:25.545	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:24:27.844	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:24:27.844	gatt.close()
D	14:24:27.853	wait(200)
V	14:24:28.061	Connecting to E3:09:89:D2:8A:8C...
D	14:24:28.062	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:24:28.071	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:24:28.071	Connected to E3:09:89:D2:8A:8C
D	14:24:28.072	wait(1600ms)
I	14:24:28.423	PHY updated (TX: LE 2M, RX: LE 2M)
D	14:24:29.247	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
D	14:24:29.257	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
I	14:24:29.257	Device bonded
V	14:24:29.672	Discovering services...
D	14:24:29.672	gatt.discoverServices()
I	14:24:29.683	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	14:24:31.426	[Callback] Services discovered with status: 0
I	14:24:31.426	Services discovered
V	14:24:31.447	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:24:31.447	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:24:31.449	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:24:31.450	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:24:31.451	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
I	14:24:31.534	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	14:24:33.239	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	14:24:39.022	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 32, "2"
A	14:24:39.022	"50%" received
I	14:24:49.010	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:24:49.010	"40%" received
I	14:24:58.999	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:24:58.999	"30%" received
I	14:25:08.999	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 14
A	14:25:08.999	"20%" received
I	14:25:18.982	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 0A
A	14:25:18.982	"10%" received
I	14:25:29.019	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 00
A	14:25:29.019	"0%" received
I	14:25:29.026	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 64, "d"
A	14:25:29.026	"100%" received
I	14:25:39.012	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 5A, "Z"
A	14:25:39.012	"90%" received
I	14:25:48.996	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 50, "P"
A	14:25:48.996	"80%" received
I	14:25:58.994	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 46, "F"
A	14:25:58.994	"70%" received
I	14:26:09.000	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 3C, "<"
A	14:26:09.000	"60%" received
I	14:26:19.006	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 32, "2"
A	14:26:19.006	"50%" received
I	14:26:28.978	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 28, "("
A	14:26:28.978	"40%" received
I	14:26:38.967	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 1E
A	14:26:38.967	"30%" received
I	14:26:49.122	Notification received from 00002a19-0000-1000-8000-00805f9b34fb, value: (0x) 14
A	14:26:49.123	"20%" received
D	14:26:58.389	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:26:58.389	Error 8 (0x8): GATT CONN TIMEOUT
I	14:26:58.389	Disconnected
D	14:26:58.429	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	14:26:59.547	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	14:26:59.547	gatt.close()
D	14:26:59.567	wait(200)
V	14:26:59.769	Connecting to E3:09:89:D2:8A:8C...
D	14:26:59.769	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	14:26:59.788	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	14:26:59.789	Connected to E3:09:89:D2:8A:8C
D	14:26:59.790	wait(1600ms)
I	14:27:00.072	PHY updated (TX: LE 2M, RX: LE 2M)
V	14:27:01.391	Discovering services...
D	14:27:01.391	gatt.discoverServices()
D	14:27:01.399	[Callback] Services discovered with status: 0
I	14:27:01.399	Services discovered
V	14:27:01.413	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
- Client Supported Features [R W] (0x2B29)
- Database Hash [R] (0x2B2A)
Generic Access (0x1800)
- Device Name [R] (0x2A00)
- Appearance [R] (0x2A01)
- Peripheral Preferred Connection Parameters [R] (0x2A04)
Battery Service (0x180F)
- Battery Level [N R] (0x2A19)
   Client Characteristic Configuration (0x2902)
Bond Management (0x181E)
- Bond Management Control Point [W] (0x2AA4)
- Bond Management Feature [R] (0x2AA5)
Binary Sensor (0x183B)
- BSS Control Point [W WNR] (0x2B2B)
   Client Characteristic Configuration (0x2902)
- BSS Response [I R] (0x2B2C)
   Client Characteristic Configuration (0x2902)
   Characteristic User Description (0x2901)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
Nordic LED Button Service (00001523-1212-efde-1523-785feabcd123)
- Button [N R] (00001524-1212-efde-1523-785feabcd123)
   Client Characteristic Configuration (0x2902)
- LED [W] (00001525-1212-efde-1523-785feabcd123)
Link Loss (0x1803)
- Alert Level [R W] (0x2A06)
Tx Power (0x1804)
- Tx Power Level [R] (0x2A07)
D	14:27:01.413	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	14:27:01.414	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	14:27:01.415	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
D	14:27:01.416	gatt.setCharacteristicNotification(00001524-1212-efde-1523-785feabcd123, true)
W	14:27:04.973	Connection parameters update failed with status 8 (interval: 45.0ms, latency: 0, timeout: 5000ms)
E	14:27:04.973	Error 8 (0x8): GATT INSUF AUTHORIZATION
D	14:27:04.987	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	14:27:04.987	Error 8 (0x8): GATT CONN TIMEOUT
I	14:27:04.987	Disconnected
D	14:27:04.988	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_NONE (10)
I	14:27:04.988	Bond information deleted
D	14:27:05.017	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED

Parents
  • Hi
    Thanks for getting back to me, I'm kind of pulling my hair on this one...
    To help you make sense of the logs, here are the steps I did:

    1) Connected to and bonded the device using nrf connect
    2) Launched our proprietary android app (this is what handles re-connections using the BLE library) and left nrf connect running in the background to capture logs
    3) Walked in and out of range between 5-10 times, until the bug was triggered

    For obvious reasons I configured the devices to use debug keys when sniffing.

    All of the logs below are from the same event

    Note that in the snoop log, I did NOT see any pairing failed this time. But as usual, after triggering the bug (device stops auto reconnecting), attempting to reconnect to the device using nrf connect on android and reading from a restricted attribute causes a pairing prompt.

    I'm happy to provide any information you need, please let me know if there is anything more you want. We desperately need this solved :)


    fourth.pcapng

    filteredsnooplog.log

    nRF Connect, 2021-05-07
    fakename (E3:09:89:D2:8A:8C)
    V	12:26:39.287	Connecting to E3:09:89:D2:8A:8C...
    D	12:26:39.287	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:26:39.963	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:26:39.966	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:26:39.966	Connected to E3:09:89:D2:8A:8C
    V	12:26:39.979	Discovering services...
    D	12:26:39.979	gatt.discoverServices()
    D	12:26:40.010	[Callback] Services discovered with status: 0
    I	12:26:40.010	Services discovered
    V	12:26:40.018	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:26:40.018	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:26:40.019	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:26:40.020	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    V	12:26:44.534	Reading characteristic 00002a07-0000-1000-8000-00805f9b34fb
    D	12:26:44.534	gatt.readCharacteristic(00002a07-0000-1000-8000-00805f9b34fb)
    D	12:26:45.047	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:26:45.068	[Broadcast] Action received: android.bluetooth.device.action.PAIRING_REQUEST, pairing variant: PAIRING_VARIANT_PASSKEY_CONFIRMATION (2)
    I	12:26:45.315	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    I	12:26:45.768	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    D	12:26:51.723	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:26:51.723	Device bonded
    I	12:26:51.733	Read Response received from 00002a07-0000-1000-8000-00805f9b34fb, value: (0x) 00
    A	12:26:51.733	"0 dBm" received
    I	12:26:52.604	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:28:08.213	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:28:08.214	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:28:08.214	Disconnected
    D	12:28:08.231	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:29:45.425	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:29:45.425	gatt.close()
    D	12:29:45.433	wait(200)
    V	12:29:45.634	Connecting to E3:09:89:D2:8A:8C...
    D	12:29:45.634	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:29:45.642	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:29:45.642	Connected to E3:09:89:D2:8A:8C
    D	12:29:45.642	wait(1600ms)
    I	12:29:45.948	PHY updated (TX: LE 2M, RX: LE 2M)
    D	12:29:46.232	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:29:46.257	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:29:46.257	Device bonded
    I	12:29:46.676	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	12:29:47.244	Discovering services...
    D	12:29:47.244	gatt.discoverServices()
    D	12:29:47.679	[Callback] Services discovered with status: 0
    I	12:29:47.679	Services discovered
    V	12:29:47.704	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:29:47.704	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:29:47.706	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:29:47.707	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:29:47.791	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	12:29:50.856	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:29:59.951	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:29:59.951	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:29:59.951	Disconnected
    D	12:29:59.982	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:30:29.441	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:30:29.441	gatt.close()
    D	12:30:29.451	wait(200)
    V	12:30:29.654	Connecting to E3:09:89:D2:8A:8C...
    D	12:30:29.654	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:30:29.667	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:30:29.667	Connected to E3:09:89:D2:8A:8C
    D	12:30:29.669	wait(1600ms)
    I	12:30:29.965	PHY updated (TX: LE 2M, RX: LE 2M)
    D	12:30:30.387	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:30:30.396	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:30:30.396	Device bonded
    I	12:30:30.831	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	12:30:31.276	Discovering services...
    D	12:30:31.276	gatt.discoverServices()
    D	12:30:31.891	[Callback] Services discovered with status: 0
    I	12:30:31.891	Services discovered
    V	12:30:31.921	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:30:31.921	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:30:31.923	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:30:31.924	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:30:31.996	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	12:30:34.882	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:30:35.713	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:30:35.714	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:30:35.714	Disconnected
    D	12:30:35.730	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:30:53.316	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:30:53.316	gatt.close()
    D	12:30:53.331	wait(200)
    V	12:30:53.533	Connecting to E3:09:89:D2:8A:8C...
    D	12:30:53.533	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:30:53.544	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:30:53.544	Connected to E3:09:89:D2:8A:8C
    D	12:30:53.546	wait(1600ms)
    I	12:30:53.849	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:30:55.148	Discovering services...
    D	12:30:55.148	gatt.discoverServices()
    D	12:30:55.159	[Callback] Services discovered with status: 0
    I	12:30:55.159	Services discovered
    V	12:30:55.186	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:30:55.186	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:30:55.188	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:30:55.189	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    D	12:30:55.431	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:30:55.435	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:30:55.436	Device bonded
    I	12:30:55.888	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    D	12:31:00.888	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:31:00.888	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:31:00.888	Disconnected
    D	12:31:00.901	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:31:10.884	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:31:10.884	gatt.close()
    D	12:31:10.900	wait(200)
    V	12:31:11.102	Connecting to E3:09:89:D2:8A:8C...
    D	12:31:11.102	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:31:11.109	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:31:11.109	Connected to E3:09:89:D2:8A:8C
    D	12:31:11.110	wait(1600ms)
    I	12:31:11.415	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:31:12.713	Discovering services...
    D	12:31:12.713	gatt.discoverServices()
    D	12:31:14.440	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:31:14.449	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:31:14.449	Device bonded
    I	12:31:14.875	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	12:31:15.014	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	12:31:15.510	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    D	12:31:17.429	[Callback] Services discovered with status: 0
    I	12:31:17.429	Services discovered
    V	12:31:17.455	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:31:17.455	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:31:17.457	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:31:17.458	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:31:17.526	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:31:24.832	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:31:24.832	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:31:24.832	Disconnected
    D	12:31:24.840	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:31:50.003	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:31:50.004	gatt.close()
    D	12:31:50.013	wait(200)
    V	12:31:50.215	Connecting to E3:09:89:D2:8A:8C...
    D	12:31:50.216	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:31:50.233	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:31:50.233	Connected to E3:09:89:D2:8A:8C
    D	12:31:50.235	wait(1600ms)
    I	12:31:50.576	PHY updated (TX: LE 2M, RX: LE 2M)
    D	12:31:50.948	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:31:50.957	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:31:50.957	Device bonded
    I	12:31:51.393	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	12:31:51.836	Discovering services...
    D	12:31:51.836	gatt.discoverServices()
    D	12:31:53.122	[Callback] Services discovered with status: 0
    I	12:31:53.122	Services discovered
    V	12:31:53.146	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:31:53.146	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:31:53.148	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:31:53.149	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:31:53.227	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	12:31:55.478	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:32:21.994	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:32:21.994	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:32:21.994	Disconnected
    D	12:32:22.029	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:32:32.629	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:32:32.629	gatt.close()
    D	12:32:32.634	wait(200)
    V	12:32:32.836	Connecting to E3:09:89:D2:8A:8C...
    D	12:32:32.836	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:32:32.849	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:32:32.849	Connected to E3:09:89:D2:8A:8C
    D	12:32:32.851	wait(1600ms)
    I	12:32:33.156	PHY updated (TX: LE 2M, RX: LE 2M)
    D	12:32:33.528	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:32:33.542	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:32:33.542	Device bonded
    I	12:32:33.969	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	12:32:34.452	Discovering services...
    D	12:32:34.452	gatt.discoverServices()
    D	12:32:36.744	[Callback] Services discovered with status: 0
    I	12:32:36.744	Services discovered
    V	12:32:36.775	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:32:36.776	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:32:36.777	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:32:36.779	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:32:36.857	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	12:32:38.305	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:32:39.117	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:32:39.118	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:32:39.118	Disconnected
    D	12:32:39.137	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:32:47.205	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:32:47.206	gatt.close()
    D	12:32:47.208	wait(200)
    V	12:32:47.410	Connecting to E3:09:89:D2:8A:8C...
    D	12:32:47.410	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:32:47.430	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:32:47.430	Connected to E3:09:89:D2:8A:8C
    D	12:32:47.431	wait(1600ms)
    I	12:32:48.143	PHY updated (TX: LE 2M, RX: LE 2M)
    D	12:32:49.014	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:32:49.043	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:32:49.043	Device bonded
    V	12:32:49.052	Discovering services...
    D	12:32:49.052	gatt.discoverServices()
    D	12:32:49.059	[Callback] Services discovered with status: 0
    I	12:32:49.059	Services discovered
    V	12:32:49.077	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:32:49.077	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:32:49.078	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:32:49.079	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:32:49.459	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	12:32:53.144	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:32:55.314	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:32:55.314	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:32:55.314	Disconnected
    D	12:32:55.325	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:32:57.565	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:32:57.565	gatt.close()
    D	12:32:57.573	wait(200)
    V	12:32:57.776	Connecting to E3:09:89:D2:8A:8C...
    D	12:32:57.776	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:32:57.788	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:32:57.788	Connected to E3:09:89:D2:8A:8C
    D	12:32:57.789	wait(1600ms)
    I	12:32:57.914	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:32:59.391	Discovering services...
    D	12:32:59.391	gatt.discoverServices()
    D	12:32:59.400	[Callback] Services discovered with status: 0
    I	12:32:59.401	Services discovered
    V	12:32:59.434	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:32:59.434	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:32:59.436	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:32:59.438	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    D	12:33:00.368	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:33:00.368	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:33:00.368	Device bonded
    I	12:33:00.663	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	12:33:07.282	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:33:08.058	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:33:08.058	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:33:08.058	Disconnected
    D	12:33:08.086	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:33:15.110	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:33:15.110	gatt.close()
    D	12:33:15.127	wait(200)
    V	12:33:15.329	Connecting to E3:09:89:D2:8A:8C...
    D	12:33:15.330	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:33:15.341	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:33:15.341	Connected to E3:09:89:D2:8A:8C
    D	12:33:15.343	wait(1600ms)
    I	12:33:16.905	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:33:16.946	Discovering services...
    D	12:33:16.946	gatt.discoverServices()
    D	12:33:16.958	[Callback] Services discovered with status: 0
    I	12:33:16.958	Services discovered
    V	12:33:16.994	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:33:16.994	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:33:16.996	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:33:16.998	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	12:33:21.222	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:33:21.994	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:33:21.994	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:33:21.994	Disconnected
    D	12:33:22.016	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:33:42.678	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:33:42.678	gatt.close()
    D	12:33:42.679	wait(200)
    V	12:33:42.887	Connecting to E3:09:89:D2:8A:8C...
    D	12:33:42.887	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:33:42.905	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:33:42.905	Connected to E3:09:89:D2:8A:8C
    D	12:33:42.907	wait(1600ms)
    I	12:33:44.475	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:33:44.508	Discovering services...
    D	12:33:44.508	gatt.discoverServices()
    D	12:33:44.519	[Callback] Services discovered with status: 0
    I	12:33:44.519	Services discovered
    V	12:33:44.544	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:33:44.544	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:33:44.546	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:33:44.547	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    D	12:33:47.395	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:33:47.399	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:33:47.399	Device bonded
    I	12:33:47.813	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    D	12:34:01.192	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:34:01.192	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:34:01.192	Disconnected
    D	12:34:01.206	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:34:08.437	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:34:08.437	gatt.close()
    D	12:34:08.444	wait(200)
    V	12:34:08.652	Connecting to E3:09:89:D2:8A:8C...
    D	12:34:08.653	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:34:08.671	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:34:08.671	Connected to E3:09:89:D2:8A:8C
    D	12:34:08.672	wait(1600ms)
    I	12:34:09.561	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:34:10.273	Discovering services...
    D	12:34:10.273	gatt.discoverServices()
    D	12:34:10.286	[Callback] Services discovered with status: 0
    I	12:34:10.286	Services discovered
    V	12:34:10.319	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:34:10.319	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:34:10.321	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:34:10.322	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    D	12:34:10.560	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	12:34:10.565	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	12:34:10.565	Device bonded
    I	12:34:10.997	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	12:34:14.638	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	12:34:20.943	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:34:20.944	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:34:20.944	Disconnected
    D	12:34:20.990	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	12:34:23.510	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	12:34:23.510	gatt.close()
    D	12:34:23.519	wait(200)
    V	12:34:23.727	Connecting to E3:09:89:D2:8A:8C...
    D	12:34:23.727	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	12:34:23.737	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	12:34:23.737	Connected to E3:09:89:D2:8A:8C
    D	12:34:23.739	wait(1600ms)
    I	12:34:25.304	PHY updated (TX: LE 2M, RX: LE 2M)
    V	12:34:25.340	Discovering services...
    D	12:34:25.340	gatt.discoverServices()
    D	12:34:25.354	[Callback] Services discovered with status: 0
    I	12:34:25.354	Services discovered
    V	12:34:25.390	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	12:34:25.390	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	12:34:25.392	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	12:34:25.394	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    W	12:34:30.291	Connection parameters update failed with status 8 (interval: 45.0ms, latency: 0, timeout: 5000ms)
    E	12:34:30.291	Error 8 (0x8): GATT INSUF AUTHORIZATION
    D	12:34:30.320	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	12:34:30.320	Error 8 (0x8): GATT CONN TIMEOUT
    I	12:34:30.320	Disconnected
    D	12:34:30.320	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_NONE (10)
    I	12:34:30.321	Bond information deleted
    D	12:34:30.321	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    

    SEGGER J-Link V6.94a - Real time terminal output
    J-Link OB-SAM3U128-V2-NordicSemi compiled Mar 17 2020 14:43:00 V1.0, SN=682591817
    Process: JLinkExe
    *** Booting Zephyr OS build v2.4.99-ncs1  **
    [00:00:00.005,187] <dbg> powermgr_device.powermgr_init_device: battery voltage: 2908mV
    [00:00:00.005,584] <inf> bms_device: BMS service start successfull
    
    [00:00:00.014,343] <inf> fs_nvs: 6 Sectors of 4096 bytes
    [00:00:00.014,343] <inf> fs_nvs: alloc wra: 0, ff0
    [00:00:00.014,343] <inf> fs_nvs: data wra: 0, 0
    [00:00:00.014,587] <inf> sdc_hci_driver: SoftDevice Controller build revision:
                                             e5 c7 9c d9 91 00 1d 66  ea fb 6e 7b 98 2f 42 0d |.......f ..n{./B.
                                             f1 60 93 c8                                      |.`..
    [00:00:00.019,226] <inf> bt_hci_core: HW Platform: Nordic Semiconductor (0x0002)
    [00:00:00.019,256] <inf> bt_hci_core: HW Variant: nRF52x (0x0002)
    [00:00:00.019,256] <inf> bt_hci_core: Firmware: Standard Bluetooth controller (0x00) Version 229.40135 Build 486576601
    [00:00:00.019,653] <dbg> bt_smp.bt_smp_init: LE SC enabled
    [00:00:00.019,836] <inf> bt_hci_core: No ID address. App must call settings_load()
    [00:00:00.019,866] <dbg> ble_device.ble_init_pre_settings_device: BLE initalized
    [00:00:00.020,690] <inf> bt_hci_core: Identity: E3:09:89:D2:8A:8C (random)
    [00:00:00.020,721] <inf> bt_hci_core: HCI: version 5.2 (0x0b) revision 0x1190, manufacturer 0x0059
    [00:00:00.020,721] <inf> bt_hci_core: LMP: version 5.2 (0x0b) subver 0x1190
    [00:00:00.026,428] <dbg> bt_smp.bt_smp_pkey_ready:
    [00:00:00.031,433] <dbg> bt_keys.keys_commit:
    [00:00:00.031,555] <dbg> ble_device.ble_init_post_settings_device: for each bond whitelisting is initialized
    [00:00:00.031,585] <dbg> ble_device.bonded_count: the bond counter found 0 bonds
    
    [00:00:00.031,585] <inf> ble_device: 0 semaphores are taken at startup
    
    [00:00:00.033,386] <inf> ble_device: Fast advertising started
    
    messages dropped:   1
    
    [00:02:29.350,341] <inf> devicestate_device: released UUUU
    [00:02:29.350,402] <dbg> ble_device.confirm_bonding_sequence: confirming all pending bonds
    [00:02:29.350,402] <err> bt_smp: Unable to find SMP channel
    [00:02:29.350,433] <inf> ble_device: Available number of semaphores are 8
    
    [00:02:30.730,712] <inf> devicestate_device: released UUUU
    [00:02:30.730,773] <dbg> ble_device.confirm_bonding_sequence: confirming all pending bonds
    [00:02:30.730,773] <err> bt_smp: Unable to find SMP channel
    [00:02:30.730,804] <inf> ble_device: Available number of semaphores are 8
    
    [00:02:40.386,566] <inf> devicestate_device: pressed BBBB
    [00:02:40.388,580] <inf> ble_device: Fast advertising started
    
    [00:02:41.574,951] <inf> devicestate_device: released UUUU
    [00:02:41.575,042] <dbg> ble_device.confirm_bonding_sequence: confirming all pending bonds
    [00:02:41.575,073] <err> bt_smp: Unable to find SMP channel
    [00:02:41.575,073] <inf> ble_device: Available number of semaphores are 8
    
    [00:02:42.495,452] <dbg> bt_keys.bt_keys_find_irk: 76:56:A0:39:CE:4C (random)
    [00:02:42.495,605] <dbg> bt_keys.bt_keys_find_irk: No IRK for 76:56:A0:39:CE:4C (random)
    [00:02:42.496,215] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:02:42.496,215] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:02:42.496,246] <inf> ble_device: Connected
    
    [00:02:42.496,398] <dbg> bt_keys.bt_keys_find_addr: 76:56:A0:39:CE:4C (random)
    [00:02:47.822,174] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x01 len 6
    [00:02:47.822,174] <dbg> bt_smp.smp_pairing_req:
    [00:02:47.822,326] <dbg> bt_keys.bt_keys_get_addr: 76:56:A0:39:CE:4C (random)
    [00:02:47.822,479] <dbg> bt_keys.bt_keys_get_addr: created 0x20006fdc for 76:56:A0:39:CE:4C (random)
    [00:02:47.822,540] <dbg> bt_smp.smp_init: prnd 94e943f6b97ce8cb5b8747b5b95a6c0~
    [00:02:47.957,702] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x0c len 64
    [00:02:47.957,702] <dbg> bt_smp.smp_public_key:
    [00:02:47.957,824] <dbg> bt_smp.smp_f4: u e69d350e480103ccdbfdf4ac1191f4e~
    [00:02:47.957,855] <dbg> bt_smp.smp_f4: v <log_strdup alloc failed>
    [00:02:47.957,885] <dbg> bt_smp.smp_f4: x <log_strdup alloc failed> z 0x0
    [00:02:47.959,106] <dbg> bt_smp.smp_f4: res <log_strdup alloc failed>
    [00:02:48.182,128] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x04 len 16
    [00:02:48.182,128] <dbg> bt_smp.smp_pairing_random:
    [00:02:48.182,159] <dbg> bt_smp.smp_g2: u <log_strdup alloc failed>
    [00:02:48.182,189] <dbg> bt_smp.smp_g2: v <log_strdup alloc failed>
    [00:02:48.182,220] <dbg> bt_smp.smp_g2: x <log_strdup alloc failed>
    [00:02:48.182,250] <dbg> bt_smp.smp_g2: y <log_strdup alloc failed>
    [00:02:48.183,441] <dbg> bt_smp.smp_g2: res <log_strdup alloc failed>
    [00:02:48.183,441] <dbg> bt_smp.smp_g2: passkey 157118
    [00:02:48.183,441] <inf> ble_device: Press pair on your phone then push Button1 on dev board
    
    [00:02:48.183,471] <inf> buzzerdevice_device: current alert 4
    [00:02:48.183,502] <dbg> ble_device.passkey_confirm: incoming conn is not in bonded list, Semaphore is taken
    
    [00:02:48.395,019] <dbg> bt_smp.bt_smp_dhkey_ready: 0x2000d734
    [00:02:50.391,143] <inf> ble_device: Slow advertising started
    
    [00:02:50.480,834] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x0d len 16
    [00:02:50.480,865] <dbg> bt_smp.smp_dhkey_check:
    [00:02:53.137,878] <inf> devicestate_device: pressed BBBB
    [00:02:53.140,136] <inf> ble_device: Fast advertising started
    
    [00:02:54.281,311] <inf> devicestate_device: released UUUU
    [00:02:54.281,372] <dbg> ble_device.confirm_bonding_sequence: confirming all pending bonds
    [00:02:54.281,433] <dbg> bt_smp.smp_f5: w f42195ddd530a30545c097bcb1d2cc0~
    [00:02:54.281,433] <dbg> bt_smp.smp_f5: n1 f8bd4e7d866d23aa8dafdddb74a2072~
    [00:02:54.281,463] <dbg> bt_smp.smp_f5: n2 94e943f6b97ce8cb5b8747b5b95a6c0~
    [00:02:54.282,104] <dbg> bt_smp.smp_f5: t 729e917b804df633eb65844c7cff8e5~
    [00:02:54.283,081] <dbg> bt_smp.smp_f5: mackey <log_strdup alloc failed>
    [00:02:54.284,088] <dbg> bt_smp.smp_f5: ltk <log_strdup alloc failed>
    [00:02:54.284,118] <dbg> bt_smp.smp_f6: w <log_strdup alloc failed>
    [00:02:54.284,118] <dbg> bt_smp.smp_f6: n1 <log_strdup alloc failed>
    [00:02:54.284,179] <dbg> bt_smp.smp_f6: n2 <log_strdup alloc failed>
    [00:02:54.284,179] <dbg> bt_smp.smp_f6: r <log_strdup alloc failed>
    [00:02:54.284,210] <dbg> bt_smp.smp_f6: io_cap <log_strdup alloc failed>
    [00:02:54.284,210] <dbg> bt_smp.smp_f6: a1 <log_strdup alloc failed>
    [00:02:54.284,240] <dbg> bt_smp.smp_f6: a2 <log_strdup alloc failed>
    [00:02:54.285,430] <dbg> bt_smp.smp_f6: res <log_strdup alloc failed>
    [00:02:54.285,461] <dbg> bt_smp.smp_f6: w <log_strdup alloc failed>
    [00:02:54.285,461] <dbg> bt_smp.smp_f6: n1 <log_strdup alloc failed>
    [00:02:54.285,491] <dbg> bt_smp.smp_f6: n2 <log_strdup alloc failed>
    [00:02:54.285,491] <dbg> bt_smp.smp_f6: r <log_strdup alloc failed>
    [00:02:54.285,522] <dbg> bt_smp.smp_f6: io_cap <log_strdup alloc failed>
    [00:02:54.285,522] <dbg> bt_smp.smp_f6: a1 <log_strdup alloc failed>
    [00:02:54.285,552] <dbg> bt_smp.smp_f6: a2 <log_strdup alloc failed>
    [00:02:54.286,743] <dbg> bt_smp.smp_f6: res <log_strdup alloc failed>
    [00:02:54.286,743] <dbg> bt_smp.sc_smp_send_dhkey_check:
    [00:02:54.286,834] <inf> ble_device: Available number of semaphores are 7
    
    [00:02:54.286,834] <err> bt_smp: Unable to find SMP channel
    messages dropped:   1
    
    [00:02:54.396,026] <dbg> bt_keys.bt_keys_clear: 76:56:A0:39:CE:4C (random) (keys 0x0000)
    [00:02:54.396,179] <dbg> bt_keys.bt_keys_clear: Deleting key bt/keys/7656a039ce4c1
    [00:02:54.396,453] <dbg> bt_keys.bt_keys_get_addr: 76:56:A0:39:CE:4C (random)
    [00:02:54.396,606] <dbg> bt_keys.bt_keys_get_addr: created 0x20006fdc for 76:56:A0:39:CE:4C (random)
    [00:02:54.396,759] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:02:54.396,911] <dbg> ble_device.security_changed: Security changed: <log_strdup alloc failed> level 4
    
    [00:02:54.403,350] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x08 len 16
    [00:02:54.403,350] <dbg> bt_smp.smp_ident_info:
    [00:02:54.403,503] <dbg> bt_keys.bt_keys_get_type: type 2 <log_strdup alloc failed>
    [00:02:54.403,625] <dbg> bt_keys.bt_keys_find: type 2 <log_strdup alloc failed>
    [00:02:54.403,808] <dbg> bt_keys.bt_keys_get_addr: <log_strdup alloc failed>
    [00:02:54.410,888] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x09 len 7
    [00:02:54.411,071] <dbg> bt_smp.smp_ident_addr_info: identity A4:50:46:6E:44:D6 (public)
    [00:02:54.411,224] <dbg> bt_keys.bt_keys_get_type: type 2 76:56:A0:39:CE:4C (random)
    [00:02:54.411,346] <dbg> bt_keys.bt_keys_find: type 2 76:56:A0:39:CE:4C (random)
    [00:02:54.413,513] <dbg> bt_smp.smp_pairing_complete: status 0x0
    [00:02:54.490,966] <dbg> bt_keys.bt_keys_store: Stored keys for A4:50:46:6E:44:D6 (public) (<log_strdup alloc failed>)
    [00:02:54.491,119] <inf> ble_device: Pairing completed: <log_strdup alloc failed>, bonded: 1
    
    [00:02:54.491,943] <dbg> ble_device.add_phone_to_whitelist:  Phone is added to whitelist
    
    [00:02:54.494,018] <inf> ble_device: Fast advertising started
    
    [00:02:54.494,110] <inf> buzzerdevice_device: current alert 6
    [00:02:54.496,490] <inf> ble_device: Slow advertising started
    
    [00:03:03.706,726] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:03:03.886,627] <inf> bas: BAS Notifications enabled
    [00:03:04.156,982] <inf> bss_parser: Received unknown packet type 2
    [00:03:04.157,135] <inf> bbs_device: Received read request
    [00:03:04.247,039] <inf> bbs_device: Received read request
    [00:03:04.496,246] <inf> ble_device: Slow advertising started
    
    [00:04:11.205,413] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:04:11.205,657] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:04:11.205,657] <inf> bas: BAS Notifications disabled
    [00:04:11.205,841] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:04:11.206,054] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:04:11.221,496] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:04:11.221,679] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:04:11.221,710] <inf> ble_device: Disconnected (reason 8)
    
    [00:04:11.223,663] <inf> ble_device: Fast advertising started
    
    [00:04:41.225,646] <inf> ble_device: Slow advertising started
    
    [00:05:48.560,729] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:05:48.560,760] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:05:48.560,760] <inf> ble_device: Connected
    
    [00:05:48.560,913] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:05:48.563,171] <inf> bas: BAS Notifications enabled
    [00:05:48.563,262] <dbg> bt_smp.smp_send_security_req:
    [00:05:48.563,415] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:05:48.563,476] <dbg> bt_smp.smp_init: prnd 1798e22fff92690ecece1355d01579e~
    [00:05:48.712,432] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:05:49.387,329] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:05:49.387,512] <dbg> ble_device.security_changed: Security changed: <log_strdup alloc failed> level 4
    
    [00:05:50.868,408] <inf> bss_parser: Received unknown packet type 2
    [00:05:50.875,854] <inf> bbs_device: Received read request
    [00:05:50.898,376] <inf> bbs_device: Received read request
    [00:06:02.932,250] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:02.932,464] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:02.932,464] <inf> bas: BAS Notifications disabled
    [00:06:02.932,647] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:02.932,861] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:02.934,539] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:06:02.934,722] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:06:02.934,753] <inf> ble_device: Disconnected (reason 8)
    
    [00:06:02.936,706] <inf> ble_device: Fast advertising started
    
    [00:06:32.552,337] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:06:32.552,368] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:06:32.552,368] <inf> ble_device: Connected
    
    [00:06:32.552,551] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:32.554,809] <inf> bas: BAS Notifications enabled
    [00:06:32.554,870] <dbg> bt_smp.smp_send_security_req:
    [00:06:32.555,023] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:06:32.555,084] <dbg> bt_smp.smp_init: prnd 6576c11851c8f8eb36e230cf11fdbba~
    [00:06:32.730,590] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:32.938,873] <inf> ble_device: Slow advertising started
    
    [00:06:33.540,588] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001ec0 handle 0 encrypt 0x01 hci status 0x00
    [00:06:33.540,740] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:06:35.096,740] <inf> bss_parser: Received unknown packet type 2
    [00:06:35.111,694] <inf> bbs_device: Received read request
    [00:06:35.206,054] <inf> bbs_device: Received read request
    [00:06:38.671,478] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:38.671,691] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:38.671,722] <inf> bas: BAS Notifications disabled
    [00:06:38.671,875] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:38.672,088] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:38.673,767] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:06:38.673,950] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:06:38.673,980] <inf> ble_device: Disconnected (reason 8)
    
    [00:06:38.675,933] <inf> ble_device: Fast advertising started
    
    [00:06:56.442,596] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:06:56.442,626] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:06:56.442,626] <inf> ble_device: Connected
    
    [00:06:56.442,779] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:56.445,037] <inf> bas: BAS Notifications enabled
    [00:06:56.445,129] <dbg> bt_smp.smp_send_security_req:
    [00:06:56.445,281] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:06:56.445,343] <dbg> bt_smp.smp_init: prnd 83cd1bf3ef6bc792c0c306f413e203c~
    [00:06:56.560,363] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:06:58.585,052] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:06:58.585,205] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:07:03.635,070] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:03.635,284] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:03.635,314] <inf> bas: BAS Notifications disabled
    [00:07:03.635,467] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:03.635,681] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:03.637,359] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:07:03.637,542] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:07:03.637,573] <inf> ble_device: Disconnected (reason 8)
    
    [00:07:03.639,526] <inf> ble_device: Fast advertising started
    
    [00:07:13.993,530] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:07:13.993,560] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:07:13.993,560] <inf> ble_device: Connected
    
    [00:07:13.993,713] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:13.995,971] <inf> bas: BAS Notifications enabled
    [00:07:13.996,063] <dbg> bt_smp.smp_send_security_req:
    [00:07:13.996,215] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:07:13.996,276] <dbg> bt_smp.smp_init: prnd 982eaf8ea3d075d76882c7d6cac5d3a~
    [00:07:17.587,768] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001ec0 handle 0 encrypt 0x01 hci status 0x00
    [00:07:17.587,921] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:07:20.628,540] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:21.187,164] <inf> bss_parser: Received unknown packet type 2
    [00:07:21.322,113] <inf> bbs_device: Received read request
    [00:07:21.412,750] <inf> bbs_device: Received read request
    [00:07:27.802,886] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:27.803,100] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:27.803,100] <inf> bas: BAS Notifications disabled
    [00:07:27.803,283] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:27.803,497] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:27.805,175] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:07:27.805,358] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:07:27.805,358] <inf> ble_device: Disconnected (reason 8)
    
    [00:07:27.807,342] <inf> ble_device: Fast advertising started
    
    [00:07:53.135,955] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:07:53.135,986] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:07:53.135,986] <inf> ble_device: Connected
    
    [00:07:53.136,138] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:53.138,397] <inf> bas: BAS Notifications enabled
    [00:07:53.138,488] <dbg> bt_smp.smp_send_security_req:
    [00:07:53.138,641] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:07:53.138,702] <dbg> bt_smp.smp_init: prnd f0fc17941d8db108819720019a364a5~
    [00:07:53.329,620] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:07:54.094,512] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:07:54.094,665] <dbg> ble_device.security_changed: Security changed: <log_strdup alloc failed> level 4
    
    [00:07:56.302,917] <inf> bss_parser: Received unknown packet type 2
    [00:07:56.310,546] <inf> bbs_device: Received read request
    [00:07:56.389,099] <inf> bbs_device: Received read request
    [00:07:57.809,539] <inf> ble_device: Slow advertising started
    
    [00:08:24.828,826] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:24.829,040] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:24.829,040] <inf> bas: BAS Notifications disabled
    [00:08:24.829,223] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:24.829,437] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:24.831,115] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:08:24.831,298] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:08:24.831,298] <inf> ble_device: Disconnected (reason 8)
    
    [00:08:24.833,282] <inf> ble_device: Fast advertising started
    
    [00:08:35.762,878] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:08:35.762,908] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:08:35.762,939] <inf> ble_device: Connected
    
    [00:08:35.763,092] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:35.765,350] <inf> bas: BAS Notifications enabled
    [00:08:35.765,411] <dbg> bt_smp.smp_send_security_req:
    [00:08:35.765,563] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:08:35.765,625] <dbg> bt_smp.smp_init: prnd be5c4392d9c1f28fd810a8801632e12~
    [00:08:35.912,902] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:36.677,795] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001ec0 handle 0 encrypt 0x01 hci status 0x00
    [00:08:36.677,947] <dbg> ble_device.security_changed: Security changed: <log_strdup alloc failed> level 4
    
    [00:08:39.970,031] <inf> bss_parser: Received unknown packet type 2
    [00:08:39.977,600] <inf> bbs_device: Received read request
    [00:08:40.289,276] <inf> bbs_device: Received read request
    [00:08:42.089,660] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:42.089,904] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:42.089,904] <inf> bas: BAS Notifications disabled
    [00:08:42.090,087] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:42.090,301] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:42.091,979] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:08:42.092,132] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:08:42.092,163] <inf> ble_device: Disconnected (reason 8)
    
    [00:08:42.094,116] <inf> ble_device: Fast advertising started
    
    [00:08:50.327,850] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:08:50.327,880] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:08:50.327,880] <inf> ble_device: Connected
    
    [00:08:50.328,033] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:50.330,291] <inf> bas: BAS Notifications enabled
    [00:08:50.330,383] <dbg> bt_smp.smp_send_security_req:
    [00:08:50.330,535] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:08:50.330,596] <dbg> bt_smp.smp_init: prnd f7f391416aff21123724eeea9f4aea9~
    [00:08:50.402,130] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:52.157,135] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:08:52.157,318] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:08:55.813,812] <inf> bss_parser: Received unknown packet type 2
    [00:08:55.813,964] <inf> bbs_device: Received read request
    [00:08:56.061,492] <inf> bbs_device: Received read request
    [00:08:58.285,644] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:58.285,858] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:58.285,858] <inf> bas: BAS Notifications disabled
    [00:08:58.286,041] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:58.286,254] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:08:58.287,933] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:08:58.288,116] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:08:58.288,146] <inf> ble_device: Disconnected (reason 8)
    
    [00:08:58.290,100] <inf> ble_device: Fast advertising started
    
    [00:09:00.554,870] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:09:00.554,901] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:09:00.554,931] <inf> ble_device: Connected
    
    [00:09:00.555,084] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:00.557,342] <inf> bas: BAS Notifications enabled
    [00:09:00.557,403] <dbg> bt_smp.smp_send_security_req:
    [00:09:00.557,556] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:09:00.557,617] <dbg> bt_smp.smp_init: prnd 4e31f640cf91dc64827075b2210c4a7~
    [00:09:00.977,264] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:03.362,091] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001ec0 handle 0 encrypt 0x01 hci status 0x00
    [00:09:03.362,243] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:09:10.847,076] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:10.847,290] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:10.847,290] <inf> bas: BAS Notifications disabled
    [00:09:10.847,473] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:10.847,686] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:10.849,365] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:09:10.849,548] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:09:10.849,578] <inf> ble_device: Disconnected (reason 8)
    
    [00:09:10.851,531] <inf> ble_device: Fast advertising started
    
    [00:09:18.026,855] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:09:18.026,885] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:09:18.026,916] <inf> ble_device: Connected
    
    [00:09:18.027,069] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:18.029,388] <inf> bas: BAS Notifications enabled
    [00:09:18.029,510] <dbg> bt_smp.smp_send_security_req:
    [00:09:18.029,663] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:09:18.029,724] <dbg> bt_smp.smp_init: prnd 37bed0f69a32e4cd5af4c3fbaccf8a8~
    [00:09:18.481,475] <dbg> bt_smp.bt_smp_recv: Received SMP code 0x05 len 1
    [00:09:18.481,475] <err> bt_smp: reason 0x5
    [00:09:18.481,506] <dbg> bt_smp.smp_pairing_complete: status 0x5
    [00:09:18.481,536] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x00 hci status 0x05
    [00:09:18.481,658] <err> ble_device: Security failed: A4:50:46:6E:44:D6 (public) level 1 err 5
    
    [00:09:18.481,842] <inf> ble_device: Pairing failed conn: <log_strdup alloc failed>, reason 5
    
    [00:09:18.481,842] <inf> buzzerdevice_device: current alert 5
    [00:09:18.571,685] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:22.306,579] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:09:22.306,732] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:09:22.756,561] <inf> bss_parser: Received unknown packet type 2
    [00:09:23.161,285] <inf> bbs_device: Received read request
    [00:09:24.781,768] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:24.781,982] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:24.781,982] <inf> bas: BAS Notifications disabled
    [00:09:24.782,165] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:24.782,379] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:24.784,057] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:09:24.784,240] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:09:24.784,240] <inf> ble_device: Disconnected (reason 8)
    
    [00:09:24.786,224] <inf> ble_device: Fast advertising started
    
    [00:09:45.721,557] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:09:45.721,588] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:09:45.721,588] <inf> ble_device: Connected
    
    [00:09:45.721,740] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:45.723,999] <inf> bas: BAS Notifications enabled
    [00:09:45.724,090] <dbg> bt_smp.smp_send_security_req:
    [00:09:45.724,334] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:09:45.724,395] <dbg> bt_smp.smp_init: prnd f722c66fc70fef46debdb694089a5d4~
    [00:09:46.056,518] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:09:50.511,474] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001ec0 handle 0 encrypt 0x01 hci status 0x00
    [00:09:50.511,627] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:09:54.788,879] <inf> ble_device: Slow advertising started
    
    [00:10:07.979,644] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:07.979,858] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:07.979,888] <inf> bas: BAS Notifications disabled
    [00:10:07.980,072] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:07.980,255] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:07.981,933] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:10:07.982,116] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:10:07.982,147] <inf> ble_device: Disconnected (reason 8)
    
    [00:10:07.984,100] <inf> ble_device: Fast advertising started
    
    [00:10:11.557,861] <dbg> bt_smp.bt_smp_accept: conn 0x20001e00 handle 0
    [00:10:11.557,891] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:10:11.557,922] <inf> ble_device: Connected
    
    [00:10:11.558,074] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:11.560,333] <inf> bas: BAS Notifications enabled
    [00:10:11.560,394] <dbg> bt_smp.smp_send_security_req:
    [00:10:11.560,546] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:10:11.560,607] <dbg> bt_smp.smp_init: prnd 2b607499b1fe4461f0b98e8b4a1e5c9~
    [00:10:11.631,286] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:13.611,053] <dbg> bt_smp.bt_smp_encrypt_change: chan 0x20002a88 conn 0x20001e00 handle 0 encrypt 0x01 hci status 0x00
    [00:10:13.611,206] <dbg> ble_device.security_changed: Security changed: A4:50:46:6E:44:D6 (public) level 4
    
    [00:10:17.840,820] <inf> bss_parser: Received unknown packet type 2
    [00:10:17.885,772] <inf> bbs_device: Received read request
    [00:10:17.976,440] <inf> bbs_device: Received read request
    [00:10:24.546,508] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:24.546,722] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:24.546,722] <inf> bas: BAS Notifications disabled
    [00:10:24.546,905] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:24.547,119] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:24.548,797] <dbg> bt_keys.bt_keys_find_addr: <log_strdup alloc failed>
    [00:10:24.548,980] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:10:24.549,011] <inf> ble_device: Disconnected (reason 8)
    
    [00:10:24.550,964] <inf> ble_device: Fast advertising started
    
    [00:10:26.528,594] <dbg> bt_smp.bt_smp_accept: conn 0x20001ec0 handle 0
    [00:10:26.528,625] <dbg> bt_smp.bt_smp_connected: chan 0x20002a88 cid 0x0006
    [00:10:26.528,625] <inf> ble_device: Connected
    
    [00:10:26.528,778] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:26.531,036] <inf> bas: BAS Notifications enabled
    [00:10:26.531,127] <dbg> bt_smp.smp_send_security_req:
    [00:10:26.531,280] <dbg> bt_keys.bt_keys_get_addr: A4:50:46:6E:44:D6 (public)
    [00:10:26.531,341] <dbg> bt_smp.smp_init: prnd c864780a142f8d6d61fec5b979e7ef6~
    [00:10:27.102,783] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:33.450,622] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:33.450,836] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:33.450,836] <inf> bas: BAS Notifications disabled
    [00:10:33.451,080] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:33.452,758] <dbg> bt_keys.bt_keys_find_addr: A4:50:46:6E:44:D6 (public)
    [00:10:33.452,941] <dbg> bt_smp.bt_smp_disconnected: chan 0x20002a88 cid 0x0006
    [00:10:33.452,972] <inf> ble_device: Disconnected (reason 8)
    
    [00:10:33.454,925] <inf> ble_device: Fast advertising started
    
    [00:11:03.456,909] <inf> ble_device: Slow advertising started
    
    

  • I was afraid that the sniffer had missed packets in the previous test because it was close to the devices, meaning far away from the phone.

    I re-did the same test, but with the sniffer placed in the middle between the cellphone and the devices instead. But there does not seem to be any major difference between the captures

    I'm posting it anyway in case there is something useful in there

    middle.pcapng

    middlefiltered.log

    nRF Connect, 2021-05-07
    fakename (E3:09:89:D2:8A:8C)
    V	15:27:25.164	Connecting to E3:09:89:D2:8A:8C...
    D	15:27:25.164	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	15:27:25.847	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	15:27:25.852	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	15:27:25.853	Connected to E3:09:89:D2:8A:8C
    D	15:27:25.853	wait(1600ms)
    I	15:27:26.380	PHY updated (TX: LE 2M, RX: LE 2M)
    D	15:27:26.654	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	15:27:26.679	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	15:27:26.679	Device bonded
    I	15:27:27.104	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	15:27:27.455	Discovering services...
    D	15:27:27.455	gatt.discoverServices()
    D	15:27:27.816	[Callback] Services discovered with status: 0
    I	15:27:27.816	Services discovered
    V	15:27:27.831	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	15:27:27.832	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	15:27:27.833	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	15:27:27.834	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	15:27:27.910	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	15:27:31.329	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	15:27:42.313	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	15:27:42.313	Error 8 (0x8): GATT CONN TIMEOUT
    I	15:27:42.313	Disconnected
    D	15:27:42.328	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	15:27:44.648	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	15:27:44.649	gatt.close()
    D	15:27:44.654	wait(200)
    V	15:27:44.856	Connecting to E3:09:89:D2:8A:8C...
    D	15:27:44.856	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	15:27:44.866	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	15:27:44.866	Connected to E3:09:89:D2:8A:8C
    D	15:27:44.866	wait(1600ms)
    I	15:27:45.003	PHY updated (TX: LE 2M, RX: LE 2M)
    D	15:27:45.862	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDING (11)
    D	15:27:45.874	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_BONDED (12)
    I	15:27:45.874	Device bonded
    I	15:27:46.313	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    V	15:27:46.468	Discovering services...
    D	15:27:46.468	gatt.discoverServices()
    D	15:27:48.658	[Callback] Services discovered with status: 0
    I	15:27:48.658	Services discovered
    V	15:27:48.672	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	15:27:48.672	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	15:27:48.674	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	15:27:48.675	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	15:27:48.754	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	15:27:50.059	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	15:27:54.695	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	15:27:54.695	Error 8 (0x8): GATT CONN TIMEOUT
    I	15:27:54.695	Disconnected
    D	15:27:54.702	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	15:28:02.370	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	15:28:02.370	gatt.close()
    D	15:28:02.385	wait(200)
    V	15:28:02.587	Connecting to E3:09:89:D2:8A:8C...
    D	15:28:02.587	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	15:28:02.595	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	15:28:02.595	Connected to E3:09:89:D2:8A:8C
    D	15:28:02.596	wait(1600ms)
    I	15:28:03.177	PHY updated (TX: LE 2M, RX: LE 2M)
    V	15:28:04.197	Discovering services...
    D	15:28:04.197	gatt.discoverServices()
    D	15:28:04.210	[Callback] Services discovered with status: 0
    I	15:28:04.210	Services discovered
    V	15:28:04.230	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	15:28:04.230	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	15:28:04.233	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	15:28:04.234	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    I	15:28:07.998	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
    D	15:28:08.628	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	15:28:08.628	Error 8 (0x8): GATT CONN TIMEOUT
    I	15:28:08.628	Disconnected
    D	15:28:08.638	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    D	15:28:12.434	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
    D	15:28:12.434	gatt.close()
    D	15:28:12.439	wait(200)
    V	15:28:12.640	Connecting to E3:09:89:D2:8A:8C...
    D	15:28:12.640	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
    D	15:28:12.650	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
    I	15:28:12.650	Connected to E3:09:89:D2:8A:8C
    D	15:28:12.651	wait(1600ms)
    I	15:28:14.228	PHY updated (TX: LE 2M, RX: LE 2M)
    V	15:28:14.252	Discovering services...
    D	15:28:14.252	gatt.discoverServices()
    D	15:28:14.260	[Callback] Services discovered with status: 0
    I	15:28:14.260	Services discovered
    V	15:28:14.276	Generic Attribute (0x1801)
    - Service Changed [I] (0x2A05)
       Client Characteristic Configuration (0x2902)
    - Client Supported Features [R W] (0x2B29)
    - Database Hash [R] (0x2B2A)
    Generic Access (0x1800)
    - Device Name [R] (0x2A00)
    - Appearance [R] (0x2A01)
    - Peripheral Preferred Connection Parameters [R] (0x2A04)
    Unknown Service (ef048090-ea1a-49c2-8105-d9d9ab38663f)
    - Unknown Characteristic [W] (defd035f-0226-4beb-874a-bfcbb8e67125)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (2049b16a-9387-4f9f-9372-ab207fb78776)
       Characteristic User Description (0x2901)
    Battery Service (0x180F)
    - Battery Level [N R] (0x2A19)
       Client Characteristic Configuration (0x2902)
    Bond Management (0x181E)
    - Bond Management Control Point [W] (0x2AA4)
    - Bond Management Feature [R] (0x2AA5)
    Binary Sensor (0x183B)
    - BSS Control Point [W WNR] (0x2B2B)
       Client Characteristic Configuration (0x2902)
    - BSS Response [I R] (0x2B2C)
       Client Characteristic Configuration (0x2902)
       Characteristic User Description (0x2901)
    Device Information (0x180A)
    - Model Number String [R] (0x2A24)
    - Manufacturer Name String [R] (0x2A29)
    - Firmware Revision String [R] (0x2A26)
    - Hardware Revision String [R] (0x2A27)
    Link Loss (0x1803)
    - Alert Level [R W] (0x2A06)
    Tx Power (0x1804)
    - Tx Power Level [R] (0x2A07)
    Unknown Service (bd63dd8b-5708-4c1f-a1c6-f24e92a6d715)
    - Unknown Characteristic [W] (bd63dd8b-5708-4c1f-a1c6-f24e92a6daaa)
       Characteristic User Description (0x2901)
    - Unknown Characteristic [W] (0db81abf-23fd-48a2-b611-69676dc0261a)
       Characteristic User Description (0x2901)
    D	15:28:14.276	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
    D	15:28:14.278	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
    D	15:28:14.278	gatt.setCharacteristicNotification(00002b2c-0000-1000-8000-00805f9b34fb, true)
    W	15:28:17.433	Connection parameters update failed with status 8 (interval: 45.0ms, latency: 0, timeout: 5000ms)
    E	15:28:17.433	Error 8 (0x8): GATT INSUF AUTHORIZATION
    D	15:28:17.433	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
    E	15:28:17.433	Error 8 (0x8): GATT CONN TIMEOUT
    I	15:28:17.464	Disconnected
    D	15:28:17.464	[Broadcast] Action received: android.bluetooth.device.action.BOND_STATE_CHANGED, bond state changed to: BOND_NONE (10)
    I	15:28:17.464	Bond information deleted
    D	15:28:17.465	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
    

  • I can see from the log, that the peripheral is sending a security request straight after connection. I suspect this is causing problems.

    Can you in your code look for bt_conn_set_security() and comment it out? You will need to re-bond after doing this change.

  • Hi

    Our code on the peripheral does not explicitly call bt_conn_set_security. I believe this request is from Zephyr it self.

    I was a bit suspicious about this myself earlier and went looking for an equivalent too pm_handler_sec_delay_ms on zephyr, but I could not find it. Do you know of a way to tell zephyr to delay this?

    As another data point, we now believe we have been able to replicate this issue with just a single device. So it may not be related to multiple devices.

    A further question, in the logs I noted that there where a lot of attempts from the phone to read from incorrect handles. Is this normal and expected behaviour? I feel like the discovery should have uncovered the correct service to handle mapping, so seeing all of those failures feels odd.

  • It must be coming from bt_conn_set_security(), so can you try to search your project for it?

    Kenneth

Reply Children
Related