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)