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

[Poorp]

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

Fullscreen failedreconnection.log Download

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

Fullscreen dkdidntwork.txt Download

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

Fullscreen deleted bond Log 2021-05-04 14_29_02.txt Download

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

[Kenneth]

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

Kenneth

[Poorp]

I did that before, I've pasted the output of grep below.
We do not call bt_conn_set_security directly. 

However I suspect that something like bt_gatt_connected in gatt.c is calling it, see line 4512 in the function bt_gatt_connected, in the file gatt.c (I'm not saying it is that exact function that is calling it as I'm not sure if that function is for the server or client, but I suspect it or some other function like it)

username@computer ~/[censored]/projects/[censored]/git/[censored project directory]
 % grep -R "bt_conn_set_security"
username@computer ~/[censored]/projects/[censored]/git/[censored project directory]
 % 

[Kenneth]

I have reported it internally, I will keep you posted.

Kenneth

[Kenneth]

They will look into making this configurable, it can be disabled or delayed, similar to the nRF5 SDK. Are you able for test to comment out the bt_conn_set_security() to see if this impact your issue?

Kenneth

[Poorp]

Sure. Which specific instance of it is it you want me to comment out?

The reason I ask is because if it does in fact fix it, it will take us a few hours of testing to make sure the problem is actually gone.