nRF Connect DFU fails only on Samsung phones

[hhmho]

I have a BLE peripheral project that is based on NCS 2.5.0 using the typical flags for firmware update:

CONFIG_NCS_SAMPLE_MCUMGR_BT_OTA_DFU=y
CONFIG_NCS_SAMPLE_MCUMGR_BT_OTA_DFU_SPEEDUP=y

Other relevant flags:

CONFIG_BT_DATA_LEN_UPDATE=y
CONFIG_BT_PERIPHERAL_PREF_MIN_INT=12
CONFIG_BT_PERIPHERAL_PREF_MAX_INT=12

Of the mobile devices on hand, DFU with nRF Connect (latest version) fails only with Samsung S21 and S22 (both Android 14). There is a disconnect basically as soon as DFU is started. Have tried setting the number of buffers to both 2 and 4.

DFU does succeed, however, on other Android devices and iPhones without any issues.

The nRF Connect logs show:

V 16:58:00.033 [McuMgr] Uploading firmware...
W 16:58:05.073 [McuMgr] Error: (0x8): GATT CONN TIMEOUT
D 16:58:05.112 [Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D 16:58:05.348 [Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED

Log files are attached for a failure on S21 and a success on a non-Samsung Android tablet.

Do you have any suggestions on things to check? Thank you.

Fullscreen success-Log 2024-04-25 17_20_59.txt Download

nRF Connect, 2024-04-25
Enso 3 (CF:6D:DD:E8:BB:73)
V	17:19:17.162	[McuMgr] Connecting...
D	17:19:17.164	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	17:19:17.195	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	17:19:17.198	[McuMgr] Connected to CF:6D:DD:E8:BB:73
D	17:19:17.199	[McuMgr] wait(300)
V	17:19:17.501	[McuMgr] Discovering services...
D	17:19:17.506	[McuMgr] gatt.discoverServices()
I	17:19:17.514	[McuMgr] Services discovered
V	17:19:17.516	[McuMgr] Primary service found
V	17:19:17.519	[McuMgr] Requesting new MTU...
D	17:19:17.521	[McuMgr] gatt.requestMtu(498)
I	17:19:17.530	[McuMgr] MTU changed to: 498
D	17:19:17.531	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	17:19:17.534	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	17:19:17.535	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	17:19:17.570	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb
V	17:19:17.573	[McuMgr] Waiting for value change...
V	17:19:17.575	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.578	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x000000010000FF06A0, WRITE COMMAND)
I	17:19:17.585	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.616	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-19-00-00-FF-06-BF-68-62-75-66-5F-73-69-7A-65-19-09-AB-69-62-75-66-5F-63-6F-75-6E-74-04-FF
I	17:19:17.618	[McuMgr] Wait for value changed complete
A	17:19:17.624	[McuMgr] Received Header (Version: 0, Op: 1, Flags: 0, Len: 25, Group: 0, Seq: 255, Command: 6) CBOR {"buf_size":2475,"buf_count":4}
I	17:19:17.630	[McuMgr] SMP reassembly supported with buffer size: 2475 bytes and count: 4
A	17:19:17.635	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 2, Group: 0, Seq: 0, Command: 8) CBOR {}
V	17:19:17.636	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.638	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000200000008BFFF, WRITE COMMAND)
I	17:19:17.644	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.675	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 09-00-00-15-00-00-00-08-BF-6A-62-6F-6F-74-6C-6F-61-64-65-72-67-4D-43-55-62-6F-6F-74-FF
A	17:19:17.678	[McuMgr] Received Header (Version: 1, Op: 1, Flags: 0, Len: 21, Group: 0, Seq: 0, Command: 8) CBOR {"bootloader":"MCUboot"}
A	17:19:17.690	[McuMgr] Sending (21 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 13, Group: 0, Seq: 1, Command: 8) CBOR {"query":"mode"}
V	17:19:17.691	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.693	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000D00000108BF657175657279646D6F6465FF, WRITE COMMAND)
I	17:19:17.702	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.724	Connection parameters updated (interval: 8.75ms, latency: 0, timeout: 420ms)
I	17:19:17.733	[McuMgr] Connection parameters updated (interval: 8.75ms, latency: 0, timeout: 420ms)
I	17:19:17.734	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 09-00-00-08-00-00-01-08-BF-64-6D-6F-64-65-03-FF
A	17:19:17.739	[McuMgr] Received Header (Version: 1, Op: 1, Flags: 0, Len: 8, Group: 0, Seq: 1, Command: 8) CBOR {"mode":3}
A	17:19:17.746	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 2, Command: 0) CBOR {}
V	17:19:17.749	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.756	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000200010200BFFF, WRITE COMMAND)
I	17:19:17.762	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.784	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 09-00-00-F4-00-01-02-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-32-64-68-61-73-68-58-20-63-11-D4-07-C7-51-D9-51-EC-F8-A6-86-B1-7E-CF-2B-58-CF-67-8C-94-B3-13-DE-AB-D8-29-91-D4-01-81-18-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-31-64-68-61-73-68-58-20-BC-66-A2-B1-B1-0A-A2-FF-54-2A-96-F5-42-11-67-DD-79-C6-34-02-20-EE-05-6E-70-17-63-22-86-9B-A3-22-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-73-00-FF
A	17:19:17.788	[McuMgr] Received Header (Version: 1, Op: 1, Flags: 0, Len: 244, Group: 1, Seq: 2, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.2","hash":"YxHUB8dR2VHs+KaGsX7PK1jPZ4yUsxPeq9gpkdQBgRg=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.1","hash":"vGaisbEKov9UKpb1QhFn3XnGNAIg7gVucBdjIoaboyI=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	17:19:17.801	[McuMgr] Uploading firmware...
A	17:19:17.813	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 2, Flags: 0, Len: 2, Group: 63, Seq: 3, Command: 0) CBOR {}
V	17:19:17.815	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.816	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0A000002003F0300BFFF, WRITE COMMAND)
I	17:19:17.821	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.926	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 0B-00-00-02-00-3F-03-00-BF-FF
A	17:19:17.930	[McuMgr] Received Header (Version: 1, Op: 3, Flags: 0, Len: 2, Group: 63, Seq: 3, Command: 0) CBOR {}
V	17:19:17.939	[McuMgr] New state: TEST
A	17:19:17.942	[McuMgr] Sending (58 bytes) Header (Version: 1, Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 4, Command: 0) CBOR {"confirm":false,"hash":"vGaisbEKov9UKpb1QhFn3XnGNAIg7gVucBdjIoaboyI="}
V	17:19:17.946	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:17.948	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0A00003200010400BF67636F6E6669726DF464686173685820BC66A2B1B10AA2FF542A96F5421167DD79C6340220EE056E70176322869BA322FF, WRITE COMMAND)
I	17:19:17.955	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:17.981	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 0B-00-00-F4-00-01-04-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-32-64-68-61-73-68-58-20-63-11-D4-07-C7-51-D9-51-EC-F8-A6-86-B1-7E-CF-2B-58-CF-67-8C-94-B3-13-DE-AB-D8-29-91-D4-01-81-18-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-31-64-68-61-73-68-58-20-BC-66-A2-B1-B1-0A-A2-FF-54-2A-96-F5-42-11-67-DD-79-C6-34-02-20-EE-05-6E-70-17-63-22-86-9B-A3-22-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	17:19:17.985	[McuMgr] Received Header (Version: 1, Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 4, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.2","hash":"YxHUB8dR2VHs+KaGsX7PK1jPZ4yUsxPeq9gpkdQBgRg=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.1","hash":"vGaisbEKov9UKpb1QhFn3XnGNAIg7gVucBdjIoaboyI=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	17:19:17.997	[McuMgr] New state: RESET
A	17:19:18.011	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 5, Command: 5) CBOR {}
V	17:19:18.015	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:18.016	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0A00000200000505BFFF, WRITE COMMAND)
I	17:19:18.025	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:18.044	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 0B-00-00-02-00-00-05-05-BF-FF
A	17:19:18.047	[McuMgr] Received Header (Version: 1, Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 5, Command: 5) CBOR {}
D	17:19:18.698	[Server callback] Connection state changed with status: 0 and new state: DISCONNECTED (0)
I	17:19:18.698	[Server] Device disconnected
D	17:19:18.708	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	17:19:18.708	Error 8 (0x8): GATT CONN TIMEOUT
I	17:19:18.708	Disconnected
D	17:19:18.713	[McuMgr] [Callback] Connection state changed with status: 8 and new state: 0 (DISCONNECTED)
W	17:19:18.716	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
I	17:19:18.720	[McuMgr] Disconnected
D	17:19:18.735	[McuMgr] gatt.close()
D	17:19:18.753	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	17:19:28.062	[McuMgr] Connecting...
D	17:19:28.065	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
V	17:19:28.071	[McuMgr] New state: CONFIRM
D	17:19:38.088	[Server callback] Connection state changed with status: 0 and new state: DISCONNECTED (0)
I	17:19:38.088	[Server] Device disconnected
D	17:19:38.106	[McuMgr] [Callback] Connection state changed with status: 133 and new state: 0 (DISCONNECTED)
W	17:19:38.109	[McuMgr] Error: (0x85): GATT ERROR
D	17:19:38.111	[McuMgr] wait(500)
D	17:19:38.614	[McuMgr] gatt.close()
D	17:19:38.629	[McuMgr] wait(200)
V	17:19:38.831	[McuMgr] Retrying...
D	17:19:38.839	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	17:19:39.055	[Server callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	17:19:39.055	[Server] Device with address CF:6D:DD:E8:BB:73 connected
I	17:19:39.060	[Server] MTU changed to 498
D	17:19:39.111	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	17:19:39.116	[McuMgr] Connected to CF:6D:DD:E8:BB:73
D	17:19:39.118	[McuMgr] wait(300)
D	17:19:39.124	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	17:19:39.424	[McuMgr] Discovering services...
D	17:19:39.428	[McuMgr] gatt.discoverServices()
I	17:19:39.575	[McuMgr] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
I	17:19:40.049	[McuMgr] Services discovered
V	17:19:40.056	[McuMgr] Primary service found
V	17:19:40.059	[McuMgr] Requesting new MTU...
D	17:19:40.060	[McuMgr] gatt.requestMtu(498)
I	17:19:40.064	[McuMgr] MTU changed to: 498
D	17:19:40.072	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	17:19:40.075	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	17:19:40.076	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	17:19:40.110	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb
V	17:19:40.112	[McuMgr] Waiting for value change...
V	17:19:40.114	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:40.115	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x000000010000FF06A0, WRITE COMMAND)
I	17:19:40.123	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:40.143	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-19-00-00-FF-06-BF-68-62-75-66-5F-73-69-7A-65-19-09-AB-69-62-75-66-5F-63-6F-75-6E-74-04-FF
I	17:19:40.146	[McuMgr] Wait for value changed complete
I	17:19:40.148	[McuMgr] Connection parameters updated (interval: 47.5ms, latency: 0, timeout: 5000ms)
A	17:19:40.150	[McuMgr] Received Header (Version: 0, Op: 1, Flags: 0, Len: 25, Group: 0, Seq: 255, Command: 6) CBOR {"buf_size":2475,"buf_count":4}
I	17:19:40.158	[McuMgr] SMP reassembly supported with buffer size: 2475 bytes and count: 4
A	17:19:40.163	[McuMgr] Sending (58 bytes) Header (Version: 1, Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"vGaisbEKov9UKpb1QhFn3XnGNAIg7gVucBdjIoaboyI="}
V	17:19:40.165	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	17:19:40.170	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0A00003200010000BF67636F6E6669726DF564686173685820BC66A2B1B10AA2FF542A96F5421167DD79C6340220EE056E70176322869BA322FF, WRITE COMMAND)
I	17:19:40.176	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	17:19:40.289	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 0B-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-31-64-68-61-73-68-58-20-BC-66-A2-B1-B1-0A-A2-FF-54-2A-96-F5-42-11-67-DD-79-C6-34-02-20-EE-05-6E-70-17-63-22-86-9B-A3-22-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-32-64-68-61-73-68-58-20-63-11-D4-07-C7-51-D9-51-EC-F8-A6-86-B1-7E-CF-2B-58-CF-67-8C-94-B3-13-DE-AB-D8-29-91-D4-01-81-18-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-73-00-FF
A	17:19:40.294	[McuMgr] Received Header (Version: 1, Op: 3, Flags: 0, Len: 244, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"0.0.1","hash":"vGaisbEKov9UKpb1QhFn3XnGNAIg7gVucBdjIoaboyI=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"0.0.2","hash":"YxHUB8dR2VHs+KaGsX7PK1jPZ4yUsxPeq9gpkdQBgRg=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	17:19:40.303	[McuMgr] Disconnecting...
D	17:19:40.304	[McuMgr] gatt.disconnect()
D	17:19:40.314	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 0 (DISCONNECTED)
I	17:19:40.315	[McuMgr] Disconnected
D	17:19:40.316	[McuMgr] gatt.close()
D	17:19:40.328	gatt.close()
D	17:19:40.330	wait(200)
V	17:19:40.531	Connecting to CF:6D:DD:E8:BB:73...
D	17:19:40.531	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	17:19:40.556	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	17:19:40.556	Connected to CF:6D:DD:E8:BB:73
V	17:19:40.569	Discovering services...
D	17:19:40.569	gatt.discoverServices()
I	17:19:41.284	Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
D	17:19:41.692	[Callback] Services discovered with status: 0
I	17:19:41.692	Services discovered
V	17:19:41.704	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
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)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Serial Number String [R] (0x2A25)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
- Software Revision String [R] (0x2A28)
Unknown Service (e5030001-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [W WNR] (e5030002-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N] (e5030003-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N] (e5030004-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R W WNR] (e5030005-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e5030006-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e5030007-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e5030008-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e5030009-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e503000a-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000b-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000c-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N] (e503000d-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000e-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e503000f-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [R] (e5030010-4e19-428e-a331-f90d5abba18c)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	17:19:41.704	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	17:19:41.707	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	17:19:41.709	gatt.setCharacteristicNotification(e5030003-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.713	gatt.setCharacteristicNotification(e5030004-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.715	gatt.setCharacteristicNotification(e5030006-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.716	gatt.setCharacteristicNotification(e5030008-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.724	gatt.setCharacteristicNotification(e503000a-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.726	gatt.setCharacteristicNotification(e503000b-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.728	gatt.setCharacteristicNotification(e503000c-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.730	gatt.setCharacteristicNotification(e503000d-4e19-428e-a331-f90d5abba18c, true)
D	17:19:41.733	gatt.setCharacteristicNotification(e503000e-4e19-428e-a331-f90d5abba18c, true)
I	17:19:41.805	Connection parameters updated (interval: 47.5ms, latency: 0, timeout: 5000ms)
I	17:19:44.422	Connection parameters updated (interval: 8.75ms, latency: 0, timeout: 420ms)
I	17:19:45.335	Connection parameters updated (interval: 15.0ms, latency: 0, timeout: 420ms)

Fullscreen fail-Log 2024-04-25 16_58_43.txt Download

nRF Connect, 2024-04-25
Enso 3 (E8:04:E0:A1:93:8F)
V	16:57:54.925	[McuMgr] Connecting...
D	16:57:54.927	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	16:57:54.953	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	16:57:54.956	[McuMgr] Connected to E8:04:E0:A1:93:8F
D	16:57:54.957	[McuMgr] wait(1600)
V	16:57:56.559	[McuMgr] Discovering services...
D	16:57:56.567	[McuMgr] gatt.discoverServices()
I	16:57:56.584	[McuMgr] Services discovered
V	16:57:56.586	[McuMgr] Primary service found
V	16:57:56.589	[McuMgr] Requesting new MTU...
D	16:57:56.592	[McuMgr] gatt.requestMtu(498)
I	16:57:56.601	[McuMgr] MTU changed to: 498
D	16:57:56.603	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	16:57:56.607	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	16:57:56.608	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	16:57:56.652	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb
V	16:57:56.656	[McuMgr] Waiting for value change...
V	16:57:56.659	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	16:57:56.662	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x000000010000FF06A0, WRITE COMMAND)
I	16:57:56.668	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	16:57:56.698	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-19-00-00-FF-06-BF-68-62-75-66-5F-73-69-7A-65-19-09-AB-69-62-75-66-5F-63-6F-75-6E-74-04-FF
I	16:57:56.701	[McuMgr] Wait for value changed complete
A	16:57:56.704	[McuMgr] Received Header (Version: 0, Op: 1, Flags: 0, Len: 25, Group: 0, Seq: 255, Command: 6) CBOR {"buf_size":2475,"buf_count":4}
I	16:57:56.710	[McuMgr] SMP reassembly supported with buffer size: 2475 bytes and count: 4
A	16:57:56.715	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 2, Group: 0, Seq: 0, Command: 8) CBOR {}
V	16:57:56.716	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	16:57:56.718	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000200000008BFFF, WRITE COMMAND)
I	16:57:56.723	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	16:57:56.757	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 09-00-00-15-00-00-00-08-BF-6A-62-6F-6F-74-6C-6F-61-64-65-72-67-4D-43-55-62-6F-6F-74-FF
A	16:57:56.762	[McuMgr] Received Header (Version: 1, Op: 1, Flags: 0, Len: 21, Group: 0, Seq: 0, Command: 8) CBOR {"bootloader":"MCUboot"}
A	16:57:56.771	[McuMgr] Sending (21 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 13, Group: 0, Seq: 1, Command: 8) CBOR {"query":"mode"}
V	16:57:56.773	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	16:57:56.774	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000D00000108BF657175657279646D6F6465FF, WRITE COMMAND)
I	16:57:56.780	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	16:57:56.820	Connection parameters updated (interval: 11.25ms, latency: 0, timeout: 420ms)
I	16:57:56.825	[McuMgr] Connection parameters updated (interval: 11.25ms, latency: 0, timeout: 420ms)
D	16:57:57.530	[McuMgr] [Callback] Connection state changed with status: 8 and new state: 0 (DISCONNECTED)
D	16:57:57.531	[Callback] Connection state changed with status: 8 and new state: DISCONNECTED (0)
E	16:57:57.531	Error 8 (0x8): GATT CONN TIMEOUT
I	16:57:57.531	Disconnected
W	16:57:57.536	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
I	16:57:57.538	[McuMgr] Disconnected
D	16:57:57.564	[McuMgr] gatt.close()
D	16:57:57.573	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
V	16:57:57.583	[McuMgr] Connecting...
D	16:57:57.584	[McuMgr] gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, LE 1M)
D	16:57:58.014	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
D	16:57:58.017	[McuMgr] [Callback] Connection state changed with status: 0 and new state: 2 (CONNECTED)
I	16:57:58.018	[McuMgr] Connected to E8:04:E0:A1:93:8F
D	16:57:58.023	[McuMgr] wait(1600)
V	16:57:59.625	[McuMgr] Discovering services...
D	16:57:59.628	[McuMgr] gatt.discoverServices()
I	16:57:59.656	[McuMgr] Services discovered
V	16:57:59.657	[McuMgr] Primary service found
V	16:57:59.659	[McuMgr] Requesting new MTU...
D	16:57:59.660	[McuMgr] gatt.requestMtu(498)
I	16:57:59.664	[McuMgr] MTU changed to: 498
D	16:57:59.665	[McuMgr] gatt.setCharacteristicNotification(da2e7828-fbce-4e01-ae9e-261174997c48, true)
V	16:57:59.668	[McuMgr] Enabling notifications for da2e7828-fbce-4e01-ae9e-261174997c48
D	16:57:59.668	[McuMgr] gatt.writeDescriptor(00002902-0000-1000-8000-00805f9b34fb, value=0x01-00)
I	16:57:59.831	[McuMgr] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb
V	16:57:59.833	[McuMgr] Waiting for value change...
V	16:57:59.835	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	16:57:59.836	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x000000010000FF06A0, WRITE COMMAND)
I	16:57:59.840	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	16:57:59.923	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-19-00-00-FF-06-BF-68-62-75-66-5F-73-69-7A-65-19-09-AB-69-62-75-66-5F-63-6F-75-6E-74-04-FF
I	16:57:59.924	[McuMgr] Wait for value changed complete
A	16:57:59.928	[McuMgr] Received Header (Version: 0, Op: 1, Flags: 0, Len: 25, Group: 0, Seq: 255, Command: 6) CBOR {"buf_size":2475,"buf_count":4}
I	16:57:59.933	[McuMgr] SMP reassembly supported with buffer size: 2475 bytes and count: 4
A	16:57:59.937	[McuMgr] Sending (10 bytes) Header (Version: 1, Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 0, Command: 0) CBOR {}
V	16:57:59.939	[McuMgr] Writing characteristic da2e7828-fbce-4e01-ae9e-261174997c48 (WRITE COMMAND)
D	16:57:59.940	[McuMgr] gatt.writeCharacteristic(da2e7828-fbce-4e01-ae9e-261174997c48, value=0x0800000200010000BFFF, WRITE COMMAND)
I	16:57:59.943	[McuMgr] Data written to da2e7828-fbce-4e01-ae9e-261174997c48
I	16:58:00.017	[McuMgr] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 09-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-31-2E-31-2E-32-64-68-61-73-68-58-20-0D-77-65-EB-A3-4A-E3-10-78-42-EC-2B-E7-DB-7A-49-1F-0C-53-F7-CF-72-4F-D3-FB-D1-9A-7A-EF-A6-2A-62-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-31-2E-31-2E-31-64-68-61-73-68-58-20-BE-D6-EC-98-B0-7F-C9-5B-D1-67-FD-48-E6-30-9A-1C-7C-1F-5A-15-02-2E-20-64-F3-7C-FA-1E-AB-FE-DF-AC-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-73-00-FF
A	16:58:00.021	[McuMgr] Received Header (Version: 1, Op: 1, Flags: 0, Len: 244, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"slot":0,"version":"1.1.2","hash":"DXdl66NK4xB4Quwr59t6SR8MU/fPck/T+9Gaeu+mKmI=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"slot":1,"version":"1.1.1","hash":"vtbsmLB/yVvRZ/1I5jCaHHwfWhUCLiBk83z6Hqv+36w=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
V	16:58:00.033	[McuMgr] Uploading firmware...
W	16:58:05.073	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
D	16:58:05.112	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	16:58:05.348	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
W	16:58:12.236	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
D	16:58:12.253	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	16:58:12.490	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
W	16:58:19.437	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
D	16:58:19.454	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	16:58:19.695	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
W	16:58:26.614	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
D	16:58:26.660	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
D	16:58:26.862	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
W	16:58:33.769	[McuMgr] Error: (0x8): GATT CONN TIMEOUT
D	16:58:33.794	gatt.close()
D	16:58:33.797	wait(200)
V	16:58:33.999	Connecting to E8:04:E0:A1:93:8F...
D	16:58:33.999	gatt = device.connectGatt(autoConnect = false, TRANSPORT_LE, preferred PHY = LE 1M)
D	16:58:34.012	[Broadcast] Action received: android.bluetooth.device.action.ACL_DISCONNECTED
I	16:58:34.097	Disconnected
D	16:58:34.336	[Callback] Connection state changed with status: 0 and new state: CONNECTED (2)
I	16:58:34.336	Connected to E8:04:E0:A1:93:8F
D	16:58:34.336	wait(1600ms)
D	16:58:34.355	[Broadcast] Action received: android.bluetooth.device.action.ACL_CONNECTED
V	16:58:35.938	Discovering services...
D	16:58:35.938	gatt.discoverServices()
D	16:58:35.949	[Callback] Services discovered with status: 0
I	16:58:35.949	Services discovered
V	16:58:35.964	Generic Attribute (0x1801)
- Service Changed [I] (0x2A05)
   Client Characteristic Configuration (0x2902)
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)
Device Information (0x180A)
- Model Number String [R] (0x2A24)
- Manufacturer Name String [R] (0x2A29)
- Serial Number String [R] (0x2A25)
- Firmware Revision String [R] (0x2A26)
- Hardware Revision String [R] (0x2A27)
- Software Revision String [R] (0x2A28)
Unknown Service (e5030001-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [W WNR] (e5030002-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N] (e5030003-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N] (e5030004-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R W WNR] (e5030005-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e5030006-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e5030007-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e5030008-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e5030009-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [N R] (e503000a-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000b-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000c-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N] (e503000d-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [N R] (e503000e-4e19-428e-a331-f90d5abba18c)
   Client Characteristic Configuration (0x2902)
- Unknown Characteristic [R] (e503000f-4e19-428e-a331-f90d5abba18c)
- Unknown Characteristic [R] (e5030010-4e19-428e-a331-f90d5abba18c)
SMP Service (8d53dc1d-1db7-4cd3-868b-8a527460aa84)
- SMP Characteristic [N WNR] (da2e7828-fbce-4e01-ae9e-261174997c48)
   Client Characteristic Configuration (0x2902)
D	16:58:35.964	gatt.setCharacteristicNotification(00002a05-0000-1000-8000-00805f9b34fb, true)
D	16:58:35.968	gatt.setCharacteristicNotification(00002a19-0000-1000-8000-00805f9b34fb, true)
D	16:58:35.971	gatt.setCharacteristicNotification(e5030003-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.973	gatt.setCharacteristicNotification(e5030004-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.975	gatt.setCharacteristicNotification(e5030006-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.976	gatt.setCharacteristicNotification(e5030008-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.978	gatt.setCharacteristicNotification(e503000a-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.980	gatt.setCharacteristicNotification(e503000b-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.981	gatt.setCharacteristicNotification(e503000c-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.983	gatt.setCharacteristicNotification(e503000d-4e19-428e-a331-f90d5abba18c, true)
D	16:58:35.987	gatt.setCharacteristicNotification(e503000e-4e19-428e-a331-f90d5abba18c, true)
I	16:58:39.629	Connection parameters updated (interval: 15.0ms, latency: 0, timeout: 420ms)

[AHaug]

Hi,

Could you supply a minimal version of the firmware so I can try to reproduce this on our end?

Kind regards,
Andreas

[hhmho]

I'm unable to easily provide FW that demonstrates this error. But I did figure out that disabling Data Length Update (CONFIG_BT_DATA_LEN_UPDATE=n) seems to fix the issue. Is there some reason why this feature might be causing problems?