nrf5340: FOTA doesn't work with CONFIG_BT_BUF_ACL_RX_SIZE=512

Hello,

we are using the following equipment:

- nrf5340-DK Board

 -Zephyr SDK 1.9.0 

Our application is intended to transfer a large number of data over BLE.

So, we defined the size of the buffers as followed

CONFIG_BT_BUF_ACL_RX_SIZE=512
CONFIG_BT_L2CAP_TX_MTU=509
CONFIG_BT_BUF_ACL_TX_COUNT=10
CONFIG_BT_BUF_ACL_TX_SIZE=512
...and we also added a child_image
#
# Copyright (c) 2021 Nordic Semiconductor
#
# SPDX-License-Identifier: LicenseRef-Nordic-5-Clause
#

CONFIG_BT_BUF_ACL_TX_SIZE=512
CONFIG_BT_CTLR_DATA_LENGTH_MAX=251
CONFIG_BT_BUF_ACL_RX_SIZE=512

CONFIG_BT_MAX_CONN=2

# Zum Einstellen der Sendeleistung
CONFIG_BT_CTLR_TX_PWR_DYNAMIC_CONTROL=y
So far the application is running correct.
Now we added the FOTA feature for updating our application.
It depends on CONFIG_BT_BUF_ACL_RX_SIZE wheather the
FOTA works or failed.
CONFIG_BT_BUF_ACL_RX_SIZE=512 (in prj.config)
-> FOTA Firmware update failed (using nRF Connect()
CONFIG_BT_BUF_ACL_RX_SIZE=256  (in prj.config)
-> FOTA Firmware update work's correct
In the attachment you can find a simple application with the described effect.
This apllication runs on a nrf5340-DK board.
I added also 2 logs of the nRF Connect during update.
The bad.txt shows the logging of a failed fota firmware update. (CONFIG_BT_BUF_ACL_RX_SIZE=512)
The good.txt shows the logging of a successful fota firmware update (CONFIG_BT_BUF_ACL_RX_SIZE=256).
The Question is: How to get the FOTA run with CONFIG_BT_BUF_ACL_RX_SIZE=512 ?
Best regards,
Georg
nRF Connect, 2022-07-05
MY_BLE_SLOW (F3:AD:40:4F:4C:4C)
V	15:39:32.145	Connecting to F3:AD:40:4F:4C:4C...
D	15:39:32.145	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	15:39:32.735	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	15:39:32.735	Connected to F3:AD:40:4F:4C:4C
V	15:39:32.744	Discovering services...
D	15:39:32.744	gatt.discoverServices()
D	15:39:32.759	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	15:39:33.000	PHY updated (TX: LE 2M, RX: LE 2M)
I	15:39:33.450	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	15:39:33.590	[Callback] Services discovered with status: 0
I	15:39:33.590	Services discovered
V	15:39:33.599	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	15:39:33.599	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	15:39:33.675	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	15:39:37.953	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
V	15:39:41.416	[McuMgr] Connecting...
D	15:39:41.421	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	15:39:41.458	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	15:39:41.461	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	15:39:41.465	[McuMgr] wait(300)
V	15:39:41.770	[McuMgr] Discovering services...
D	15:39:41.776	[McuMgr] gatt.discoverServices()
I	15:39:41.786	[McuMgr] Services discovered
V	15:39:41.789	[McuMgr] Primary service found
V	15:39:41.800	[McuMgr] Requesting new MTU...
D	15:39:41.805	[McuMgr] gatt.requestMtu(498)
I	15:39:41.866	[McuMgr] MTU changed to: 252
D	15:39:41.871	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	15:39:41.875	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	15:39:41.879	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	15:39:42.047	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	15:39:42.052	[McuMgr] Notifications enabled
A	15:39:42.057	[McuMgr] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 0, Command: 0) CBOR {}
V	15:39:42.060	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	15:39:42.071	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	15:39:42.078	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-01-00-00-BF-FF
I	15:39:42.317	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-F4-00-01-00-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-41-C0-87-AD-41-5F-46-BB-D5-F5-BB-EB-8B-CC-03-6F-6C-D7-F2-68-01-42-D9-62-1D-2D-77-7B-91-C1-2B-55-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-BF-64-73-6C-6F-74-01-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-41-C0-87-AD-41-5F-46-BB-D5-F5-BB-EB-8B-CC-03-6F-6C-D7-F2-68-01-42-D9-62-1D-2D-77-7B-91-C1-2B-55-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F4-66-61-63-74-69-76-65-F4-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75
I	15:39:42.322	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 73-00-FF
A	15:39:42.327	[McuMgr] Received Header (Op: 1, Flags: 0, Len: 244, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"QcCHrUFfRrvV9bvri8wDb2zX8mgBQtliHS13e5HBK1U=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.0","hash":"QcCHrUFfRrvV9bvri8wDb2zX8mgBQtliHS13e5HBK1U=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	15:39:42.343	[McuMgr] Uploading firmware...
A	15:40:13.909	[McuMgr] 96164 bytes sent in 29207 ms (3.29 kB/s)
A	15:40:13.932	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 63, Seq: 178, Command: 0) CBOR {}
V	15:40:13.937	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	15:40:13.959	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	15:40:13.970	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-3F-B2-00-BF-FF
I	15:40:14.043	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-3F-B2-00-BF-62-72-63-08-FF
A	15:40:14.050	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 6, Group: 63, Seq: 178, Command: 0) CBOR {"rc":8}
W	15:40:14.056	[McuMgr] Error: NOT_SUPPORTED (8)
V	15:40:14.066	[McuMgr] New state: TEST
A	15:40:14.073	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 179, Command: 0) CBOR {"confirm":false,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	15:40:14.077	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	15:40:14.082	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	15:40:14.093	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-B3-00-BF-67-63-6F-6E-66-69-72-6D-F4-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	15:40:14.357	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-F4-00-01-B3-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-41-C0-87-AD-41-5F-46-BB-D5-F5-BB-EB-8B-CC-03-6F-6C-D7-F2-68-01-42-D9-62-1D-2D-77-7B-91-C1-2B-55-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-BF-64-73-6C-6F-74-01-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F5-69-63-6F-6E-66-69-72-6D-65-64-F4-66-61-63-74-69-76-65-F4-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75
I	15:40:14.364	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 73-00-FF
A	15:40:14.370	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 179, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"QcCHrUFfRrvV9bvri8wDb2zX8mgBQtliHS13e5HBK1U=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.0","hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	15:40:14.377	[McuMgr] New state: RESET
A	15:40:14.391	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 180, Command: 5) CBOR {}
V	15:40:14.398	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	15:40:14.402	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	15:40:14.414	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-00-B4-05-BF-FF
I	15:40:14.495	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-02-00-00-B4-05-BF-FF
A	15:40:14.504	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 180, Command: 5) CBOR {}
D	15:40:15.304	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	15:40:15.304	Error 8 (0x8): GATT CONN TIMEOUT
I	15:40:15.304	Disconnected
D	15:40:15.307	[McuMgr] [Callback] Connection state changed with status: 8 and new state: 0 (DISCONNECTED)
W	15:40:15.327	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
I	15:40:15.335	[McuMgr] Disconnected
D	15:40:15.346	[McuMgr] gatt.close()
D	15:40:15.350	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	15:40:24.519	[McuMgr] Connecting...
D	15:40:24.525	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
V	15:40:24.531	[McuMgr] New state: CONFIRM
D	15:40:25.611	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	15:40:25.619	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	15:40:25.635	[McuMgr] wait(300)
D	15:40:25.641	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	15:40:25.876	[McuMgr] PHY updated (TX: LE 2M, RX: LE 2M)
V	15:40:25.944	[McuMgr] Discovering services...
D	15:40:25.950	[McuMgr] gatt.discoverServices()
I	15:40:26.327	[McuMgr] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	15:40:26.464	[McuMgr] Services discovered
V	15:40:26.469	[McuMgr] Primary service found
V	15:40:26.473	[McuMgr] Requesting new MTU...
D	15:40:26.476	[McuMgr] gatt.requestMtu(498)
I	15:40:26.493	[McuMgr] MTU changed to: 252
D	15:40:26.497	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	15:40:26.500	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	15:40:26.503	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	15:40:26.522	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	15:40:26.525	[McuMgr] Notifications enabled
A	15:40:26.536	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	15:40:26.542	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	15:40:26.545	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	15:40:26.549	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-00-00-BF-67-63-6F-6E-66-69-72-6D-F5-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	15:40:26.553	[McuMgr] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	15:40:26.957	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-F4-00-01-00-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-BF-64-73-6C-6F-74-01-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-41-C0-87-AD-41-5F-46-BB-D5-F5-BB-EB-8B-CC-03-6F-6C-D7-F2-68-01-42-D9-62-1D-2D-77-7B-91-C1-2B-55-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F4-66-61-63-74-69-76-65-F4-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75
I	15:40:26.962	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 73-00-FF
A	15:40:26.967	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.0","hash":"QcCHrUFfRrvV9bvri8wDb2zX8mgBQtliHS13e5HBK1U=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	15:40:26.974	[McuMgr] Disconnecting...
D	15:40:26.980	[McuMgr] gatt.disconnect()
D	15:40:27.002	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 0 (DISCONNECTED)
I	15:40:27.006	[McuMgr] Disconnected
D	15:40:27.012	[McuMgr] gatt.close()
D	15:40:27.022	gatt.close()
D	15:40:27.023	wait(200)
V	15:40:27.224	Connecting to F3:AD:40:4F:4C:4C...
D	15:40:27.224	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	15:40:27.241	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	15:40:27.242	Connected to F3:AD:40:4F:4C:4C
V	15:40:27.251	Discovering services...
D	15:40:27.251	gatt.discoverServices()
I	15:40:27.676	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	15:40:27.821	[Callback] Services discovered with status: 0
I	15:40:27.821	Services discovered
V	15:40:27.828	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	15:40:27.828	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	15:40:27.900	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	15:40:30.781	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
nRF Connect, 2022-07-05
MY_BLE_SLOW (F3:AD:40:4F:4C:4C)
V	10:37:03.819	Connecting to F3:AD:40:4F:4C:4C...
D	10:37:03.820	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	10:37:04.419	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	10:37:04.419	Connected to F3:AD:40:4F:4C:4C
V	10:37:04.430	Discovering services...
D	10:37:04.430	gatt.discoverServices()
D	10:37:04.437	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	10:37:04.683	PHY updated (TX: LE 2M, RX: LE 2M)
I	10:37:05.135	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	10:37:05.273	[Callback] Services discovered with status: 0
I	10:37:05.273	Services discovered
V	10:37:05.283	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	10:37:05.283	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	10:37:05.359	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	10:37:09.633	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
V	10:37:10.702	[McuMgr] Connecting...
D	10:37:10.709	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	10:37:10.748	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	10:37:10.752	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	10:37:10.756	[McuMgr] wait(300)
V	10:37:11.062	[McuMgr] Discovering services...
D	10:37:11.067	[McuMgr] gatt.discoverServices()
I	10:37:11.075	[McuMgr] Services discovered
V	10:37:11.085	[McuMgr] Primary service found
V	10:37:11.089	[McuMgr] Requesting new MTU...
D	10:37:11.093	[McuMgr] gatt.requestMtu(498)
I	10:37:11.166	[McuMgr] MTU changed to: 498
D	10:37:11.170	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	10:37:11.176	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	10:37:11.181	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	10:37:11.346	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	10:37:11.351	[McuMgr] Notifications enabled
A	10:37:11.355	[McuMgr] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 0, Command: 0) CBOR {}
V	10:37:11.358	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:37:11.370	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:37:11.375	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-01-00-00-BF-FF
I	10:37:11.526	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-86-00-01-00-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-FF-27-50-2C-4D-86-78-19-3E-F4-5E-2E-95-28-DF-15-23-0C-1E-00-CC-9B-20-2C-8B-0C-B8-4E-A7-7D-73-DF-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
A	10:37:11.531	[McuMgr] Received Header (Op: 1, Flags: 0, Len: 134, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"/ydQLE2GeBk+9F4ulSjfFSMMHgDMmyAsiwy4Tqd9c98=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
V	10:37:11.544	[McuMgr] Uploading firmware...
A	10:37:38.799	[McuMgr] 95920 bytes sent in 26999 ms (3.55 kB/s)
A	10:37:38.822	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 63, Seq: 207, Command: 0) CBOR {}
V	10:37:38.828	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:37:38.840	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:37:38.846	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-3F-CF-00-BF-FF
I	10:37:38.931	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-3F-CF-00-BF-62-72-63-08-FF
A	10:37:38.939	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 6, Group: 63, Seq: 207, Command: 0) CBOR {"rc":8}
W	10:37:38.943	[McuMgr] Error: NOT_SUPPORTED (8)
V	10:37:38.954	[McuMgr] New state: TEST
A	10:37:38.961	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 208, Command: 0) CBOR {"confirm":false,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	10:37:38.967	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:37:38.972	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:37:38.983	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-D0-00-BF-67-63-6F-6E-66-69-72-6D-F4-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	10:37:39.246	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-F4-00-01-D0-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-FF-27-50-2C-4D-86-78-19-3E-F4-5E-2E-95-28-DF-15-23-0C-1E-00-CC-9B-20-2C-8B-0C-B8-4E-A7-7D-73-DF-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-BF-64-73-6C-6F-74-01-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F5-69-63-6F-6E-66-69-72-6D-65-64-F4-66-61-63-74-69-76-65-F4-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
A	10:37:39.257	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 208, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"/ydQLE2GeBk+9F4ulSjfFSMMHgDMmyAsiwy4Tqd9c98=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.0","hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	10:37:39.274	[McuMgr] New state: RESET
A	10:37:39.283	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 209, Command: 5) CBOR {}
V	10:37:39.288	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:37:39.293	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:37:39.302	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-00-D1-05-BF-FF
I	10:37:39.387	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-02-00-00-D1-05-BF-FF
A	10:37:39.395	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 209, Command: 5) CBOR {}
D	10:37:40.193	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	10:37:40.194	Error 8 (0x8): GATT CONN TIMEOUT
I	10:37:40.194	Disconnected
D	10:37:40.195	[McuMgr] [Callback] Connection state changed with status: 8 and new state: 0 (DISCONNECTED)
W	10:37:40.217	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
I	10:37:40.223	[McuMgr] Disconnected
D	10:37:40.232	[McuMgr] gatt.close()
D	10:37:40.236	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	10:37:49.415	[McuMgr] Connecting...
D	10:37:49.423	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
V	10:37:49.431	[McuMgr] New state: CONFIRM
D	10:37:51.134	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	10:37:51.146	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	10:37:51.155	[McuMgr] wait(300)
D	10:37:51.158	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	10:37:51.397	[McuMgr] PHY updated (TX: LE 2M, RX: LE 2M)
V	10:37:51.461	[McuMgr] Discovering services...
D	10:37:51.471	[McuMgr] gatt.discoverServices()
I	10:37:51.849	[McuMgr] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	10:37:51.986	[McuMgr] Services discovered
V	10:37:51.995	[McuMgr] Primary service found
V	10:37:52.001	[McuMgr] Requesting new MTU...
D	10:37:52.005	[McuMgr] gatt.requestMtu(498)
I	10:37:52.025	[McuMgr] MTU changed to: 498
D	10:37:52.029	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	10:37:52.034	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	10:37:52.038	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	10:37:52.075	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	10:37:52.080	[McuMgr] Notifications enabled
I	10:37:52.097	[McuMgr] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
A	10:37:52.105	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	10:37:52.110	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:37:52.122	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:37:52.132	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-00-00-BF-67-63-6F-6E-66-69-72-6D-F5-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	10:37:52.299	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-01-00-00-BF-62-72-63-03-FF
A	10:37:52.307	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 6, Group: 1, Seq: 0, Command: 0) CBOR {"rc":3}
W	10:37:52.312	[McuMgr] Error: IN_VALUE (3)
V	10:37:52.324	[McuMgr] Disconnecting...
D	10:37:52.329	[McuMgr] gatt.disconnect()
D	10:37:52.340	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 0 (DISCONNECTED)
I	10:37:52.346	[McuMgr] Disconnected
D	10:37:52.355	[McuMgr] gatt.close()
D	10:37:52.366	gatt.close()
D	10:37:52.366	wait(200)
V	10:37:52.568	Connecting to F3:AD:40:4F:4C:4C...
D	10:37:52.568	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	10:37:52.583	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	10:37:52.583	Connected to F3:AD:40:4F:4C:4C
V	10:37:52.595	Discovering services...
D	10:37:52.595	gatt.discoverServices()
I	10:37:53.014	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	10:37:53.160	[Callback] Services discovered with status: 0
I	10:37:53.160	Services discovered
V	10:37:53.171	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	10:37:53.172	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	10:37:53.240	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	10:37:56.300	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
D	10:38:01.883	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	10:38:01.883	Error 8 (0x8): GATT CONN TIMEOUT
I	10:38:01.883	Disconnected
D	10:38:01.919	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	10:44:09.743	gatt.close()
D	10:44:09.743	wait(200)
V	10:44:09.945	Connecting to F3:AD:40:4F:4C:4C...
D	10:44:09.945	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	10:44:10.344	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	10:44:10.344	Connected to F3:AD:40:4F:4C:4C
V	10:44:10.354	Discovering services...
D	10:44:10.354	gatt.discoverServices()
D	10:44:10.362	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	10:44:10.607	PHY updated (TX: LE 2M, RX: LE 2M)
I	10:44:11.058	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	10:44:11.199	[Callback] Services discovered with status: 0
I	10:44:11.199	Services discovered
V	10:44:11.204	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	10:44:11.204	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	10:44:11.292	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
V	10:44:15.463	[McuMgr] Connecting...
D	10:44:15.470	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	10:44:15.492	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	10:44:15.495	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	10:44:15.498	[McuMgr] wait(300)
I	10:44:15.512	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
I	10:44:15.517	[McuMgr] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
V	10:44:15.803	[McuMgr] Discovering services...
D	10:44:15.809	[McuMgr] gatt.discoverServices()
I	10:44:15.817	[McuMgr] Services discovered
V	10:44:15.827	[McuMgr] Primary service found
V	10:44:15.833	[McuMgr] Requesting new MTU...
D	10:44:15.837	[McuMgr] gatt.requestMtu(498)
I	10:44:15.920	[McuMgr] MTU changed to: 498
D	10:44:15.925	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	10:44:15.929	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	10:44:15.934	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	10:44:16.100	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	10:44:16.106	[McuMgr] Notifications enabled
A	10:44:16.111	[McuMgr] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 0, Command: 0) CBOR {}
V	10:44:16.115	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:44:16.127	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:44:16.135	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-01-00-00-BF-FF
I	10:44:16.279	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-86-00-01-00-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-FF-27-50-2C-4D-86-78-19-3E-F4-5E-2E-95-28-DF-15-23-0C-1E-00-CC-9B-20-2C-8B-0C-B8-4E-A7-7D-73-DF-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
A	10:44:16.285	[McuMgr] Received Header (Op: 1, Flags: 0, Len: 134, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"/ydQLE2GeBk+9F4ulSjfFSMMHgDMmyAsiwy4Tqd9c98=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
V	10:44:16.299	[McuMgr] Uploading firmware...
A	10:44:43.418	[McuMgr] 95920 bytes sent in 26865 ms (3.57 kB/s)
A	10:44:43.449	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 63, Seq: 207, Command: 0) CBOR {}
V	10:44:43.454	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:44:43.465	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:44:43.471	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-3F-CF-00-BF-FF
I	10:44:43.550	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-3F-CF-00-BF-62-72-63-08-FF
A	10:44:43.558	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 6, Group: 63, Seq: 207, Command: 0) CBOR {"rc":8}
W	10:44:43.562	[McuMgr] Error: NOT_SUPPORTED (8)
V	10:44:43.574	[McuMgr] New state: TEST
A	10:44:43.583	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 208, Command: 0) CBOR {"confirm":false,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	10:44:43.589	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:44:43.595	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:44:43.608	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-D0-00-BF-67-63-6F-6E-66-69-72-6D-F4-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	10:44:43.866	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-F4-00-01-D0-00-BF-66-69-6D-61-67-65-73-9F-BF-64-73-6C-6F-74-00-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-FF-27-50-2C-4D-86-78-19-3E-F4-5E-2E-95-28-DF-15-23-0C-1E-00-CC-9B-20-2C-8B-0C-B8-4E-A7-7D-73-DF-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F4-69-63-6F-6E-66-69-72-6D-65-64-F5-66-61-63-74-69-76-65-F5-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-BF-64-73-6C-6F-74-01-67-76-65-72-73-69-6F-6E-65-30-2E-30-2E-30-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-68-62-6F-6F-74-61-62-6C-65-F5-67-70-65-6E-64-69-6E-67-F5-69-63-6F-6E-66-69-72-6D-65-64-F4-66-61-63-74-69-76-65-F4-69-70-65-72-6D-61-6E-65-6E-74-F4-FF-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
A	10:44:43.876	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 208, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.0","hash":"/ydQLE2GeBk+9F4ulSjfFSMMHgDMmyAsiwy4Tqd9c98=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.0","hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	10:44:43.893	[McuMgr] New state: RESET
A	10:44:43.904	[McuMgr] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 209, Command: 5) CBOR {}
V	10:44:43.909	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:44:43.915	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:44:43.928	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-00-D1-05-BF-FF
I	10:44:44.001	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-02-00-00-D1-05-BF-FF
A	10:44:44.010	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 209, Command: 5) CBOR {}
D	10:44:44.811	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	10:44:44.812	Error 8 (0x8): GATT CONN TIMEOUT
I	10:44:44.812	Disconnected
D	10:44:44.815	[McuMgr] [Callback] Connection state changed with status: 8 and new state: 0 (DISCONNECTED)
W	10:44:44.837	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
I	10:44:44.845	[McuMgr] Disconnected
D	10:44:44.853	[McuMgr] gatt.close()
D	10:44:44.857	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	10:44:54.031	[McuMgr] Connecting...
D	10:44:54.047	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
V	10:44:54.055	[McuMgr] New state: CONFIRM
D	10:44:55.751	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	10:44:55.775	[McuMgr] Connected to F3:AD:40:4F:4C:4C
D	10:44:55.783	[McuMgr] wait(300)
D	10:44:55.787	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
I	10:44:56.014	[McuMgr] PHY updated (TX: LE 2M, RX: LE 2M)
V	10:44:56.090	[McuMgr] Discovering services...
D	10:44:56.100	[McuMgr] gatt.discoverServices()
I	10:44:56.467	[McuMgr] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	10:44:56.604	[McuMgr] Services discovered
V	10:44:56.610	[McuMgr] Primary service found
V	10:44:56.614	[McuMgr] Requesting new MTU...
D	10:44:56.618	[McuMgr] gatt.requestMtu(498)
I	10:44:56.640	[McuMgr] MTU changed to: 498
D	10:44:56.646	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	10:44:56.653	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	10:44:56.657	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	10:44:56.705	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
I	10:44:56.712	[McuMgr] Notifications enabled
I	10:44:56.718	[McuMgr] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
A	10:44:56.746	[McuMgr] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"vijatvwqf7lLbOzAm0xXNAnpNrNPopNgXuJtKo9vh48="}
V	10:44:56.761	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	10:44:56.765	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48)
I	10:44:56.770	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-00-00-BF-67-63-6F-6E-66-69-72-6D-F5-64-68-61-73-68-58-20-BE-28-DA-B6-FC-2A-7F-B9-4B-6C-EC-C0-9B-4C-57-34-09-E9-36-B3-4F-A2-93-60-5E-E2-6D-2A-8F-6F-87-8F-FF
I	10:44:56.916	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-01-00-00-BF-62-72-63-03-FF
A	10:44:56.927	[McuMgr] Received Header (Op: 3, Flags: 0, Len: 6, Group: 1, Seq: 0, Command: 0) CBOR {"rc":3}
W	10:44:56.933	[McuMgr] Error: IN_VALUE (3)
V	10:44:56.949	[McuMgr] Disconnecting...
D	10:44:56.957	[McuMgr] gatt.disconnect()
D	10:44:56.968	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 0 (DISCONNECTED)
I	10:44:56.976	[McuMgr] Disconnected
D	10:44:56.985	[McuMgr] gatt.close()
D	10:44:56.996	gatt.close()
D	10:44:56.998	wait(200)
V	10:44:57.199	Connecting to F3:AD:40:4F:4C:4C...
D	10:44:57.199	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	10:44:57.212	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	10:44:57.212	Connected to F3:AD:40:4F:4C:4C
V	10:44:57.228	Discovering services...
D	10:44:57.229	gatt.discoverServices()
I	10:44:57.633	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	10:44:57.778	[Callback] Services discovered with status: 0
I	10:44:57.778	Services discovered
V	10:44:57.788	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)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	10:44:57.789	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
I	10:44:57.858	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
I	10:45:00.922	Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 420ms)
Related