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

nrf Connect for Desktop looses first connection (BLE_HCI_CONNECTION_TIMEOUT) when second device connects

Our manufacturing supplier provided me a log file from the nrf Connect for Desktop Application that shows repeatedly unexpected disconnects when nrf Connect opens a second BLE connection. They are doing these connects to do a sanity check whether the BLE functionality is working in their preproductions tests.

I could of course tell them that they should ensure to always have only one connection, but my question is: Could this be caused by any hardware or software issues on our devices (nrf52832 with S132v4.0.4 and SDK13) or is this as I would guess an issue that is caused by the PC running the nrf Connect software (nRFConnect 2.6.0 with pc-nrfconnect-ble v2.2.0)

By the way: On my laptop I just tried to connect to 5 of these devices at the same time without any issues.

Filtered log file showing the issue:

Part of a full log file:

Fullscreen
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
2019-09-04T06:22:49.081Z DEBUG 378 -> [00 8a 01 01 a0 00 20 00 3c 00 ] type: VENDOR_SPECIFIC reliable:yes seq#:6 ack#:4 payload_length:a data_integrity:1 header_checksum:6c err_code:0
2019-09-04T06:22:49.083Z DEBUG 375/ 0 <- [] type: ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.083Z DEBUG 376/ 0 <- [01 8a 00 00 00 00 ] type: VENDOR_SPECIFIC reliable:yes seq#:4 ack#:7 payload_length:6 data_integrity:1 header_checksum:96 err_code:0
2019-09-04T06:22:49.083Z DEBUG 379 -> [] type: ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.089Z INFO Scan started
2019-09-04T06:22:49.102Z DEBUG 377/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 dc 00 1f 01 02 01 05 02 0a f6 03 02 39 fe 14 16 39 fe 01 13 1d 00 00 06 bd fc 7f 28 d0 78 4a 77 60 97 05 ] type: VENDOR_SPECIFIC reliable:yes seq#:5 ack#:7 payload_length:36 data_integrity:1 header_checksum:92 err_code:0
2019-09-04T06:22:49.102Z DEBUG 380 -> [] type: ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.104Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2019-09-04T06:22:49.098Z connHandle:65535 rssi:36 peerAddr:[address:D4:31:5D:07:4D:77 type:randomStatic addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leLimitedDiscMode,brEdrNotSupported,leOnlyLimitedDiscMode,leOnlyGeneralDiscMode] txPowerLevel:246 16BitServiceUuidMoreAvailable:FE39 serviceData:57,254,1,19,29,0,0,6,189,252,127,40,208,120,74,119,96,151,5]
2019-09-04T06:22:49.108Z DEBUG 378/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 dd 01 16 01 0c ff 4f 04 00 59 f3 9b 00 6e b1 62 02 08 08 42 50 20 31 38 20 49 ] type: VENDOR_SPECIFIC reliable:yes seq#:6 ack#:7 payload_length:2d data_integrity:1 header_checksum:22 err_code:0
2019-09-04T06:22:49.108Z DEBUG 381 -> [] type: ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.109Z DEBUG GAP_EVT_ADV_REPORT time:2019-09-04T06:22:49.100Z connHandle:65535 rssi:35 peerAddr:[address:D4:31:5D:07:4D:77 type:randomStatic addrIdPeer:0] scanRsp:true gap:[manufacturerSpecificData:79,4,0,89,243,155,0,110,177,98,2 shortLocalName:BP 18 I]
2019-09-04T06:22:49.301Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2019-09-04T06:22:49.295Z connHandle:65535 rssi:39 peerAddr:[address:D4:31:5D:07:4D:77 type:randomStatic addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leLimitedDiscMode,brEdrNotSupported,leOnlyLimitedDiscMode,leOnlyGeneralDiscMode] txPowerLevel:246 16BitServiceUuidMoreAvailable:FE39 serviceData:57,254,1,19,29,0,0,6,189,252,127,40,208,120,74,119,96,151,5]
2019-09-04T06:22:49.304Z DEBUG 379/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 d9 00 1f 01 02 01 05 02 0a f6 03 02 39 fe 14 16 39 fe 01 13 1d 00 00 06 bd fc 7f 28 d0 78 4a 77 60 97 05 ] type: VENDOR_SPECIFIC reliable:yes seq#:7 ack#:7 payload_length:36 data_integrity:1 header_checksum:90 err_code:0
2019-09-04T06:22:49.304Z DEBUG 382 -> [] type: ACK reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.304Z DEBUG 380/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 d9 01 16 01 0c ff 4f 04 00 59 f3 9b 00 6e b1 62 02 08 08 42 50 20 31 38 20 49 ] type: VENDOR_SPECIFIC reliable:yes seq#:0 ack#:7 payload_length:2d data_integrity:1 header_checksum:28 err_code:0
2019-09-04T06:22:49.304Z DEBUG 383 -> [] type: ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.305Z DEBUG GAP_EVT_ADV_REPORT time:2019-09-04T06:22:49.301Z connHandle:65535 rssi:39 peerAddr:[address:D4:31:5D:07:4D:77 type:randomStatic addrIdPeer:0] scanRsp:true gap:[manufacturerSpecificData:79,4,0,89,243,155,0,110,177,98,2 shortLocalName:BP 18 I]
2019-09-04T06:22:49.404Z DEBUG 381/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 dc 00 1f 01 02 01 05 02 0a f6 03 02 39 fe 14 16 39 fe 01 13 1d 00 00 06 bd fc 7f 28 d0 78 4a 77 60 97 05 ] type: VENDOR_SPECIFIC reliable:yes seq#:1 ack#:7 payload_length:36 data_integrity:1 header_checksum:96 err_code:0
2019-09-04T06:22:49.405Z DEBUG 384 -> [] type: ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0
2019-09-04T06:22:49.408Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2019-09-04T06:22:49.400Z connHandle:65535 rssi:36 peerAddr:[address:D4:31:5D:07:4D:77 type:randomStatic addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leLimitedDiscMode,brEdrNotSupported,leOnlyLimitedDiscMode,leOnlyGeneralDiscMode] txPowerLevel:246 16BitServiceUuidMoreAvailable:FE39 serviceData:57,254,1,19,29,0,0,6,189,252,127,40,208,120,74,119,96,151,5]
2019-09-04T06:22:49.411Z DEBUG 382/ 0 <- [02 1d 00 ff ff 02 77 4d 07 5d 31 d4 00 42 50 20 31 38 20 dc 01 16 01 0c ff 4f 04 00 59 f3 9b 00 6e b1 62 02 08 08 42 50 20 31 38 20 49 ] type: VENDOR_SPECIFIC reliable:yes seq#:2 ack#:7 payload_length:2d data_integrity:1 header_checksum:26 err_code:0
XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX