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

DFU OTA read property "find" and "InstanceID" error in dual-transport

I have DFU code base working. It consists of a thin layer of our code, and majority is from Bootloader component from SDK v17.

I started with DFU OTA, and then incorporated dual-transport (UART and OTA) by simply including DFU UART source code.

We have 2 custom devices, one is 52832, and the other one is 52833. The DFU Controller is nRF Connect for Desktop v3.5.0

This same source code runs fine on 52832 platform (either in OTA only, or dual-transport).

However, the OTA only works fine on 52833, but the dual-transport doesn't work.

The weird thing is, it advertises fine (I can see the advertising ID), but then when I click "Connect", it popped up as "<Unknown>".

And then shortly I got the read property error.

Please see attached screenshots below.

I also attached the log (and removed some identifying info) below.

And then when I "forced" it, ignoring the error and press "Start DFU", I got: read property "InstanceID" error.

Log:

2020-09-18T01:10:14.526Z INFO Device setup completed
2020-09-18T01:10:14.527Z INFO Getting information from J-Link debugger...
2020-09-18T01:10:16.788Z INFO Found device type: unknown. J-Link firmware: J-Link OB-SAM3U128-V2-NordicSemi compiled Mar 17 2020 14:43:00.
2020-09-18T01:10:16.788Z INFO Connectivity firmware version: 4.1.2. SoftDevice API version: 5. Baud rate: 1000000.
2020-09-18T01:10:16.789Z INFO Opening adapter connected to COM5
2020-09-18T01:10:17.711Z INFO Successfully opened COM5. Baud rate: 1000000. Flow control: none. Parity: none.
2020-09-18T01:10:17.711Z DEBUG State change: STATE_START -> STATE_RESET
2020-09-18T01:10:17.711Z DEBUG        1 ->  [N/A] type:          RESERVED_5 reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:17.712Z INFO Reset performed on adapter COM5
2020-09-18T01:10:17.743Z DEBUG     1/ 0 <-  [01 7e ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:2 data_integrity:0 err_code:0x0 [SYNC]
2020-09-18T01:10:18.016Z DEBUG State change: STATE_RESET -> STATE_UNINITIALIZED
2020-09-18T01:10:18.016Z DEBUG        2 ->  [01 7e ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:2 data_integrity:0 err_code:0x0 [SYNC]
2020-09-18T01:10:18.046Z DEBUG     2/ 0 <-  [02 7d ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:2 data_integrity:0 err_code:0x0 [SYNC_RESP]
2020-09-18T01:10:18.046Z DEBUG State change: STATE_UNINITIALIZED -> STATE_INITIALIZED
2020-09-18T01:10:18.046Z DEBUG        3 ->  [03 fc 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.298Z DEBUG        4 ->  [03 fc 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.446Z DEBUG     3/ 0 <-  [01 7e ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:2 data_integrity:0 err_code:0x0 [SYNC]
2020-09-18T01:10:18.446Z DEBUG        5 ->  [02 7d ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:2 data_integrity:0 err_code:0x0 [SYNC_RESP]
2020-09-18T01:10:18.549Z DEBUG        6 ->  [03 fc 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.582Z DEBUG     4/ 0 <-  [03 fc 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.582Z DEBUG        7 ->  [04 7b 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG_RESP [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.801Z DEBUG        8 ->  [03 fc 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.833Z DEBUG     5/ 0 <-  [04 7b 11 ] type: LINK_CONTROL_PACKET reliable: no seq#:0 ack#:0 payload_length:3 data_integrity:0 err_code:0x0 [CONFIG_RESP [ sliding-window-size:1 out-of-frame:0 data-integrity-check-type:1 version-number:0 ]]
2020-09-18T01:10:18.834Z DEBUG State change: STATE_INITIALIZED -> STATE_ACTIVE
2020-09-18T01:10:18.839Z INFO Adapter connected to COM5 opened
2020-09-18T01:10:18.842Z DEBUG        9 ->  [00 69 20 00 00 00 01 01 08 9c 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:0 payload_length:b data_integrity:1 header_checksum:82 err_code:0x0
2020-09-18T01:10:18.871Z DEBUG     6/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:18.871Z DEBUG     7/ 0 <-  [01 69 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:1 payload_length:6 data_integrity:1 header_checksum:ca err_code:0x0
2020-09-18T01:10:18.871Z DEBUG       10 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:18.871Z DEBUG       11 ->  [00 69 23 00 00 00 01 01 f7 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:1 payload_length:a data_integrity:1 header_checksum:89 err_code:0x0
2020-09-18T01:10:18.904Z DEBUG     8/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0

[...Lots of data...]

2020-09-18T01:10:19.173Z DEBUG    24/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.173Z DEBUG    25/ 0 <-  [01 6d 00 00 00 00 02 c4 09 7f 76 84 f4 ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:2 payload_length:d data_integrity:1 header_checksum:51 err_code:0x0
2020-09-18T01:10:19.173Z DEBUG       28 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.176Z DEBUG SoftDevice BLE stack enabled.
2020-09-18T01:10:19.582Z DEBUG       29 ->  [00 8a 01 01 a0 00 20 00 3c 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:2 payload_length:a data_integrity:1 header_checksum:80 err_code:0x0
2020-09-18T01:10:19.615Z DEBUG    26/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.615Z DEBUG    27/ 0 <-  [01 8a 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:3 payload_length:6 data_integrity:1 header_checksum:b8 err_code:0x0
2020-09-18T01:10:19.615Z DEBUG       30 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.617Z INFO Scan started
2020-09-18T01:10:19.720Z DEBUG    28/ 0 <-  [02 1d 00 ff ff 00 ab e9 f4 f5 79 8c 00 00 00 00 00 ff 00 ac 00 1f 01 02 01 1a 1b ff 75 00 42 04 01 01 66 8c 79 f5 f4 e9 ab 8e 79 f5 f4 e9 aa 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:3 payload_length:36 data_integrity:1 header_checksum:b4 err_code:0x0
2020-09-18T01:10:19.721Z DEBUG       31 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.724Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:19.721Z connHandle:65535 rssi:84 peerAddr:[address:8C:79:F5:F4:E9:AB type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,1,102,140,121,245,244,233,171,142,121,245,244,233,170,1,0,0,0,0,0,0]
2020-09-18T01:10:19.754Z DEBUG GAP_EVT_ADV_REPORT time:2020-09-18T01:10:19.754Z connHandle:65535 rssi:84 peerAddr:[address:8C:79:F5:F4:E9:AB type:public addrIdPeer:0] scanRsp:true gap:[shortLocalName:[TV] Samsung 7 Series (65)]
2020-09-18T01:10:19.756Z DEBUG    29/ 0 <-  [02 1d 00 ff ff 00 ab e9 f4 f5 79 8c 00 00 00 00 00 ff 00 ac 01 1c 01 1b 08 5b 54 56 5d 20 53 61 6d 73 75 6e 67 20 37 20 53 65 72 69 65 73 20 28 36 35 29 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:3 payload_length:33 data_integrity:1 header_checksum:e3 err_code:0x0
2020-09-18T01:10:19.756Z DEBUG       32 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.786Z DEBUG    30/ 0 <-  [02 1d 00 ff ff 00 97 e9 f4 f5 79 8c 00 00 00 00 00 ff 00 b5 06 1c 01 1b ff 75 00 42 04 01 80 60 8c 79 f5 f4 e9 97 8e 79 f5 f4 e9 96 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:5 ack#:3 payload_length:33 data_integrity:1 header_checksum:e2 err_code:0x0
2020-09-18T01:10:19.786Z DEBUG       33 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:19.787Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:19.787Z connHandle:65535 rssi:75 peerAddr:[address:8C:79:F5:F4:E9:97 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,140,121,245,244,233,151,142,121,245,244,233,150,1,0,0,0,0,0,0]
2020-09-18T01:10:19.937Z DEBUG    31/ 0 <-  [02 1d 00 ff ff 00 72 71 40 a4 6e cc 00 00 00 00 00 ff 00 b6 06 1c 01 1b ff 75 00 42 04 01 80 60 cc 6e a4 40 71 72 ce 6e a4 40 71 71 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:6 ack#:3 payload_length:33 data_integrity:1 header_checksum:e1 err_code:0x0
2020-09-18T01:10:19.937Z DEBUG       34 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0x0

[...Lots of data...]

2020-09-18T01:10:20.123Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:20.123Z connHandle:65535 rssi:80 peerAddr:[address:CC:6E:A4:40:6D:D6 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,204,110,164,64,109,214,206,110,164,64,109,213,1,0,0,0,0,0,0]
2020-09-18T01:10:20.126Z DEBUG    35/ 0 <-  [02 1d 00 ff ff 00 d6 6d 40 a4 6e cc 00 00 00 00 00 ff 00 b0 06 1c 01 1b ff 75 00 42 04 01 80 60 cc 6e a4 40 6d d6 ce 6e a4 40 6d d5 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:3 payload_length:33 data_integrity:1 header_checksum:e5 err_code:0x0
2020-09-18T01:10:20.126Z DEBUG       38 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:20.156Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:20.156Z connHandle:65535 rssi:84 peerAddr:[address:8C:79:F5:F4:E9:AB type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,32,102,25,5,0,0,1,65,0,0,0,0,0,0,0,0,0,0,0,0,0]
2020-09-18T01:10:20.158Z DEBUG    36/ 0 <-  [02 1d 00 ff ff 00 ab e9 f4 f5 79 8c 00 00 00 00 00 ff 00 ac 00 1f 01 02 01 1a 1b ff 75 00 42 04 01 20 66 19 05 00 00 01 41 00 00 00 00 00 00 00 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:3 payload_length:36 data_integrity:1 header_checksum:b4 err_code:0x0
2020-09-18T01:10:20.158Z DEBUG       39 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:20.224Z DEBUG    37/ 0 <-  [02 1d 00 ff ff 00 e6 e0 25 6e 8c 9c 00 00 00 00 00 ff 00 a7 00 1f 01 02 01 1a 1b ff 75 00 42 04 01 20 66 19 05 00 00 01 4b 01 01 00 01 00 00 00 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:3 payload_length:36 data_integrity:1 header_checksum:b3 err_code:0x0
2020-09-18T01:10:20.224Z DEBUG       40 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:20.225Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:20.225Z connHandle:65535 rssi:89 peerAddr:[address:9C:8C:6E:25:E0:E6 type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,32,102,25,5,0,0,1,75,1,1,0,1,0,0,0,0,0,0,0,0,0]
2020-09-18T01:10:20.257Z DEBUG    38/ 0 <-  [02 1d 00 ff ff 02 b8 b3 d6 9b 5a e3 00 00 00 00 00 ff 00 bb 00 13 01 02 01 06 03 02 59 fe 0b 09 4d 41 53 5f 37 32 30 31 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:5 ack#:3 payload_length:2a data_integrity:1 header_checksum:73 err_code:0x0
2020-09-18T01:10:20.257Z DEBUG       41 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0x0

[...Lots of data...]

2020-09-18T01:10:21.195Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:21.195Z connHandle:65535 rssi:82 peerAddr:[address:B8:BC:5B:9E:50:39 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,184,188,91,158,80,57,186,188,91,158,80,56,1,0,0,0,0,0,0]
2020-09-18T01:10:21.227Z DEBUG    58/ 0 <-  [02 1d 00 ff ff 00 d5 fd f4 f5 79 8c 00 00 00 00 00 ff 00 a9 06 1c 01 1b ff 75 00 42 04 01 80 60 8c 79 f5 f4 fd d5 8e 79 f5 f4 fd d4 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:3 payload_length:33 data_integrity:1 header_checksum:e6 err_code:0x0
2020-09-18T01:10:21.227Z DEBUG       61 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:21.228Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:21.228Z connHandle:65535 rssi:87 peerAddr:[address:8C:79:F5:F4:FD:D5 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,140,121,245,244,253,213,142,121,245,244,253,212,1,0,0,0,0,0,0]
2020-09-18T01:10:21.260Z DEBUG    59/ 0 <-  [02 1d 00 ff ff 02 b8 b3 d6 9b 5a e3 00 00 00 00 00 ff 00 b7 00 13 01 02 01 06 03 02 59 fe 0b 09 4d 41 53 5f 37 32 30 31 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:3 payload_length:2a data_integrity:1 header_checksum:76 err_code:0x0
2020-09-18T01:10:21.260Z DEBUG       62 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:21.260Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:21.261Z connHandle:65535 rssi:73 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,brEdrNotSupported,leOnlyLimitedDiscMode,leOnlyGeneralDiscMode] 16BitServiceUuidMoreAvailable:FE59 completeLocalName:MAS_7201]
2020-09-18T01:10:21.292Z DEBUG    60/ 0 <-  [02 1d 00 ff ff 02 b8 b3 d6 9b 5a e3 00 00 00 00 00 ff 00 b8 01 00 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:3 payload_length:17 data_integrity:1 header_checksum:a6 err_code:0x0
2020-09-18T01:10:21.292Z DEBUG       63 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:21.293Z DEBUG GAP_EVT_ADV_REPORT time:2020-09-18T01:10:21.293Z connHandle:65535 rssi:72 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] scanRsp:true
2020-09-18T01:10:21.325Z DEBUG    61/ 0 <-  [02 1d 00 ff ff 04 1d da 13 e9 91 42 00 00 00 00 00 ff 00 a9 06 1f 01 1e ff 06 00 01 09 20 02 1b 31 7d 90 3f 72 53 ff a5 cd 95 e2 2a ad 24 27 a4 8b 48 4c 17 c3 10 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:3 payload_length:36 data_integrity:1 header_checksum:b3 err_code:0x0
2020-09-18T01:10:21.325Z DEBUG       64 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0

[...Lots of data...]

2020-09-18T01:10:22.788Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:22.788Z connHandle:65535 rssi:90 peerAddr:[address:9C:8C:6E:25:E0:E6 type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,1,102,156,140,110,37,224,230,158,140,110,37,224,229,1,0,0,0,0,0,0]
2020-09-18T01:10:22.820Z DEBUG    96/ 0 <-  [02 1d 00 ff ff 00 8d ec f4 f5 79 8c 00 00 00 00 00 ff 00 af 00 1f 01 02 01 1a 1b ff 75 00 42 04 01 20 66 19 05 00 00 01 41 00 00 00 00 00 00 00 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:7 ack#:3 payload_length:36 data_integrity:1 header_checksum:b0 err_code:0x0
2020-09-18T01:10:22.820Z DEBUG       99 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:22.821Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:22.821Z connHandle:65535 rssi:81 peerAddr:[address:8C:79:F5:F4:EC:8D type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,32,102,25,5,0,0,1,65,0,0,0,0,0,0,0,0,0,0,0,0,0]
2020-09-18T01:10:22.853Z DEBUG    97/ 0 <-  [02 1d 00 ff ff 00 97 e9 f4 f5 79 8c 00 00 00 00 00 ff 00 ae 06 1c 01 1b ff 75 00 42 04 01 80 60 8c 79 f5 f4 e9 97 8e 79 f5 f4 e9 96 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:3 payload_length:33 data_integrity:1 header_checksum:e7 err_code:0x0
2020-09-18T01:10:22.853Z DEBUG      100 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:22.854Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:22.854Z connHandle:65535 rssi:82 peerAddr:[address:8C:79:F5:F4:E9:97 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,140,121,245,244,233,151,142,121,245,244,233,150,1,0,0,0,0,0,0]
2020-09-18T01:10:22.886Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:22.887Z connHandle:65535 rssi:82 peerAddr:[address:8C:79:F5:86:6E:70 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,140,121,245,134,110,112,142,121,245,134,110,111,1,0,0,0,0,0,0]
2020-09-18T01:10:22.888Z DEBUG    98/ 0 <-  [02 1d 00 ff ff 00 70 6e 86 f5 79 8c 00 00 00 00 00 ff 00 ae 06 1c 01 1b ff 75 00 42 04 01 80 60 8c 79 f5 86 6e 70 8e 79 f5 86 6e 6f 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:3 payload_length:33 data_integrity:1 header_checksum:e6 err_code:0x0
2020-09-18T01:10:22.889Z DEBUG      101 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:22.919Z DEBUG    99/ 0 <-  [02 1d 00 ff ff 00 39 50 9e 5b bc b8 00 00 00 00 00 ff 00 a8 06 1c 01 1b ff 75 00 42 04 01 80 60 b8 bc 5b 9e 50 39 ba bc 5b 9e 50 38 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:3 payload_length:33 data_integrity:1 header_checksum:e5 err_code:0x0
2020-09-18T01:10:22.920Z DEBUG      102 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:22.922Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:22.920Z connHandle:65535 rssi:88 peerAddr:[address:B8:BC:5B:9E:50:39 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,184,188,91,158,80,57,186,188,91,158,80,56,1,0,0,0,0,0,0]
2020-09-18T01:10:23.121Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:23.120Z connHandle:65535 rssi:70 peerAddr:[address:CC:6E:A4:40:6D:D6 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,204,110,164,64,109,214,206,110,164,64,109,213,1,0,0,0,0,0,0]
2020-09-18T01:10:23.122Z DEBUG   100/ 0 <-  [02 1d 00 ff ff 00 d6 6d 40 a4 6e cc 00 00 00 00 00 ff 00 ba 06 1c 01 1b ff 75 00 42 04 01 80 60 cc 6e a4 40 6d d6 ce 6e a4 40 6d d5 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:3 payload_length:33 data_integrity:1 header_checksum:e4 err_code:0x0
2020-09-18T01:10:23.122Z DEBUG      103 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.153Z DEBUG GAP_EVT_ADV_REPORT/ADV_NONCONN_IND time:2020-09-18T01:10:23.153Z connHandle:65535 rssi:82 peerAddr:[address:8C:79:F5:F4:E9:97 type:public addrIdPeer:0] scanRsp:false advType:advNonconnInd gap:[manufacturerSpecificData:117,0,66,4,1,128,96,140,121,245,244,233,151,142,121,245,244,233,150,1,0,0,0,0,0,0]
2020-09-18T01:10:23.154Z DEBUG   101/ 0 <-  [02 1d 00 ff ff 00 97 e9 f4 f5 79 8c 00 00 00 00 00 ff 00 ae 06 1c 01 1b ff 75 00 42 04 01 80 60 8c 79 f5 f4 e9 97 8e 79 f5 f4 e9 96 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:3 payload_length:33 data_integrity:1 header_checksum:e3 err_code:0x0
2020-09-18T01:10:23.155Z DEBUG      104 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.222Z DEBUG   102/ 0 <-  [02 1d 00 ff ff 00 53 b0 f4 f5 79 8c 00 00 00 00 00 ff 00 ad 00 1f 01 02 01 1a 1b ff 75 00 42 04 01 01 66 8c 79 f5 f4 b0 53 8e 79 f5 f4 b0 52 01 00 00 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:5 ack#:3 payload_length:36 data_integrity:1 header_checksum:b2 err_code:0x0
2020-09-18T01:10:23.223Z DEBUG      105 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.223Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:23.223Z connHandle:65535 rssi:83 peerAddr:[address:8C:79:F5:F4:B0:53 type:public addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,leOnlyGeneralDiscMode,leBrEdrController,leBrEdrHost] manufacturerSpecificData:117,0,66,4,1,1,102,140,121,245,244,176,83,142,121,245,244,176,82,1,0,0,0,0,0,0]
2020-09-18T01:10:23.237Z INFO Connecting to device
2020-09-18T01:10:23.246Z DEBUG      106 ->  [00 8c 01 02 b8 b3 d6 9b 5a e3 01 01 a0 00 50 00 14 00 01 06 00 06 00 00 00 90 01 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:6 payload_length:1c data_integrity:1 header_checksum:3e err_code:0x0
2020-09-18T01:10:23.271Z DEBUG   103/ 0 <-  [02 1d 00 ff ff 02 b8 b3 d6 9b 5a e3 00 00 00 00 00 ff 00 bb 00 13 01 02 01 06 03 02 59 fe 0b 09 4d 41 53 5f 37 32 30 31 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:6 ack#:3 payload_length:2a data_integrity:1 header_checksum:72 err_code:0x0
2020-09-18T01:10:23.271Z DEBUG      107 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.271Z DEBUG   104/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.272Z DEBUG GAP_EVT_ADV_REPORT/ADV_IND time:2020-09-18T01:10:23.272Z connHandle:65535 rssi:69 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] scanRsp:false advType:advInd gap:[adTypeFlags:[leGeneralDiscMode,brEdrNotSupported,leOnlyLimitedDiscMode,leOnlyGeneralDiscMode] 16BitServiceUuidMoreAvailable:FE59 completeLocalName:MAS_7201]
2020-09-18T01:10:23.304Z DEBUG   105/ 0 <-  [01 8c 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:7 ack#:4 payload_length:6 data_integrity:1 header_checksum:ab err_code:0x0
2020-09-18T01:10:23.304Z DEBUG      108 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.336Z DEBUG   106/ 0 <-  [02 1d 00 ff ff 02 b8 b3 d6 9b 5a e3 00 00 00 00 00 ff 00 bc 01 00 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:4 payload_length:17 data_integrity:1 header_checksum:a1 err_code:0x0
2020-09-18T01:10:23.336Z DEBUG      109 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.337Z DEBUG GAP_EVT_ADV_REPORT time:2020-09-18T01:10:23.337Z connHandle:65535 rssi:68 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] scanRsp:true
2020-09-18T01:10:23.369Z DEBUG GAP_EVT_CONNECTED time:2020-09-18T01:10:23.369Z connHandle:0 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] role:central connParams:[minConnInterval:7_5 maxConnInterval:7_5 slaveLatency:0 connSupTimeout:4000]
2020-09-18T01:10:23.372Z INFO Connected to device E3:5A:9B:D6:B3:B8
2020-09-18T01:10:23.384Z DEBUG   107/ 0 <-  [02 10 00 00 00 02 b8 b3 d6 9b 5a e3 02 06 00 06 00 00 00 90 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:4 payload_length:15 data_integrity:1 header_checksum:c0 err_code:0x0
2020-09-18T01:10:23.384Z DEBUG      110 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.384Z DEBUG      111 ->  [00 94 00 00 01 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:2 payload_length:7 data_integrity:1 header_checksum:ae err_code:0x0
2020-09-18T01:10:23.417Z DEBUG   108/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.417Z DEBUG   109/ 0 <-  [01 94 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:5 payload_length:6 data_integrity:1 header_checksum:a8 err_code:0x0
2020-09-18T01:10:23.417Z DEBUG      112 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.450Z DEBUG   110/ 0 <-  [02 30 00 00 00 00 00 00 00 03 00 00 18 01 01 00 09 00 01 18 01 0a 00 0a 00 59 fe 01 0b 00 ff ff ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:5 payload_length:20 data_integrity:1 header_checksum:5 err_code:0x0
2020-09-18T01:10:23.450Z DEBUG      113 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.451Z DEBUG GATTC_EVT_PRIM_SRVC_DISC_RSP time:2020-09-18T01:10:23.451Z connHandle:0 gattStatus:0 gattStatusName:success errorHandle:0 count:3 services:[[uuid:[uuid:6144 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:1 endHandle:9]],[uuid:[uuid:6145 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:10 endHandle:10]],[uuid:[uuid:65113 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:11 endHandle:65535]]]
2020-09-18T01:10:23.481Z DEBUG      114 ->  [00 96 00 00 01 01 00 09 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:5 ack#:4 payload_length:9 data_integrity:1 header_checksum:7d err_code:0x0
2020-09-18T01:10:23.504Z DEBUG   111/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:23.504Z DEBUG   112/ 0 <-  [01 96 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:4 ack#:6 payload_length:6 data_integrity:1 header_checksum:9e err_code:0x0
2020-09-18T01:10:23.504Z DEBUG      115 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:5 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:27.734Z DEBUG   113/ 0 <-  [02 11 00 00 00 08 ] type:     VENDOR_SPECIFIC reliable:yes seq#:5 ack#:6 payload_length:6 data_integrity:1 header_checksum:9d err_code:0x0
2020-09-18T01:10:27.734Z DEBUG      116 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:6 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:27.734Z DEBUG GAP_EVT_DISCONNECTED time:2020-09-18T01:10:27.735Z connHandle:0 reason:8 reasonName:connectionTimeout
2020-09-18T01:10:27.739Z INFO Disconnected from device E3:5A:9B:xxx, reason: BLE_HCI_CONNECTION_TIMEOUT
2020-09-18T01:10:33.478Z INFO Disconnected from device E3:5A:9B:xxx
2020-09-18T01:10:33.479Z INFO Performing DFU with file: H:\Projects\OTA_WIP_833_Latest_Dbg_pkg.zip
2020-09-18T01:10:33.479Z DEBUG Loading zip file: H:\Projects\OTA_WIP_833_Latest_Dbg_pkg.zip
2020-09-18T01:10:33.553Z DEBUG Found application files: OTA_WIP_833_Latest_Dbg.dat, OTA_WIP_833_Latest_Dbg.bin
2020-09-18T01:10:33.553Z DEBUG Creating DFU transport.
2020-09-18T01:10:33.553Z DEBUG Initializing DFU transport with targetAddress: E3:5A:9B:xxx, targetAddressType: BLE_GAP_ADDR_TYPE_RANDOM_STATIC, prnValue: 0, mtuSize: 247.
2020-09-18T01:10:33.553Z DEBUG Connecting to address: E3:5A:9B:D6:B3:B8, type: BLE_GAP_ADDR_TYPE_RANDOM_STATIC.
2020-09-18T01:10:33.576Z DEBUG      117 ->  [00 8c 01 02 b8 b3 d6 9b 5a e3 01 01 a0 00 50 00 14 00 01 06 00 06 00 00 00 90 01 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:6 ack#:6 payload_length:1c data_integrity:1 header_checksum:3b err_code:0x0
2020-09-18T01:10:33.593Z DEBUG   114/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.593Z DEBUG   115/ 0 <-  [01 8c 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:6 ack#:7 payload_length:6 data_integrity:1 header_checksum:94 err_code:0x0
2020-09-18T01:10:33.593Z DEBUG      118 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:7 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.625Z DEBUG   116/ 0 <-  [02 10 00 00 00 02 b8 b3 d6 9b 5a e3 02 06 00 06 00 00 00 90 01 ] type:     VENDOR_SPECIFIC reliable:yes seq#:7 ack#:7 payload_length:15 data_integrity:1 header_checksum:a2 err_code:0x0
2020-09-18T01:10:33.626Z DEBUG      119 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.627Z DEBUG GAP_EVT_CONNECTED time:2020-09-18T01:10:33.626Z connHandle:0 peerAddr:[address:E3:5A:9B:D6:B3:B8 type:randomStatic addrIdPeer:0] role:central connParams:[minConnInterval:7_5 maxConnInterval:7_5 slaveLatency:0 connSupTimeout:4000]
2020-09-18T01:10:33.640Z DEBUG      120 ->  [00 94 00 00 01 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:7 ack#:0 payload_length:7 data_integrity:1 header_checksum:bb err_code:0x0
2020-09-18T01:10:33.666Z DEBUG   117/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:0 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.667Z DEBUG   118/ 0 <-  [01 94 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:0 payload_length:6 data_integrity:1 header_checksum:d2 err_code:0x0
2020-09-18T01:10:33.667Z DEBUG      121 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.699Z DEBUG   119/ 0 <-  [02 30 00 00 00 00 00 00 00 03 00 00 18 01 01 00 09 00 01 18 01 0a 00 0a 00 59 fe 01 0b 00 ff ff ] type:     VENDOR_SPECIFIC reliable:yes seq#:1 ack#:0 payload_length:20 data_integrity:1 header_checksum:2f err_code:0x0
2020-09-18T01:10:33.699Z DEBUG      122 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:2 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.700Z DEBUG GATTC_EVT_PRIM_SRVC_DISC_RSP time:2020-09-18T01:10:33.700Z connHandle:0 gattStatus:0 gattStatusName:success errorHandle:0 count:3 services:[[uuid:[uuid:6144 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:1 endHandle:9]],[uuid:[uuid:6145 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:10 endHandle:10]],[uuid:[uuid:65113 type:1 typeString:bleUuidTypeBle],handleRange:[startHandle:11 endHandle:65535]]]
2020-09-18T01:10:33.701Z DEBUG      123 ->  [00 96 00 00 01 01 00 09 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:0 ack#:2 payload_length:9 data_integrity:1 header_checksum:92 err_code:0x0
2020-09-18T01:10:33.733Z DEBUG   120/ 0 <-  [N/A] type:                 ACK reliable: no seq#:0 ack#:1 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:33.733Z DEBUG   121/ 0 <-  [01 96 00 00 00 00 ] type:     VENDOR_SPECIFIC reliable:yes seq#:2 ack#:1 payload_length:6 data_integrity:1 header_checksum:c8 err_code:0x0
2020-09-18T01:10:33.733Z DEBUG      124 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:3 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:38.031Z DEBUG   122/ 0 <-  [02 11 00 00 00 08 ] type:     VENDOR_SPECIFIC reliable:yes seq#:3 ack#:1 payload_length:6 data_integrity:1 header_checksum:c7 err_code:0x0
2020-09-18T01:10:38.031Z DEBUG      125 ->  [N/A] type:                 ACK reliable: no seq#:0 ack#:4 payload_length:0 data_integrity:0 err_code:0x0
2020-09-18T01:10:38.031Z DEBUG GAP_EVT_DISCONNECTED time:2020-09-18T01:10:38.031Z connHandle:0 reason:8 reasonName:connectionTimeout
2020-09-18T01:10:38.031Z DEBUG Did not find service changed. Error: Error: Device disconnected
2020-09-18T01:10:38.032Z DEBUG findCharacteristic: Did not find characteristic ID. Error Error: Cannot read property 'instanceId' of undefined
2020-09-18T01:10:38.032Z DEBUG Destroying DFU transport.
2020-09-18T01:10:38.032Z ERROR DFU failed with error: Cannot read property 'instanceId' of undefined.

Parents
  • Hi Harry,

     Please provide the nrf_log output from the bootloader when this issue occurs.

    -Amanda H.

  • Hi Amanda,

    Sorry for the delayed response.

    Please find below is the log output from the bootloader. I found that it kept rebooting. This segment you see blow is the full cycle, and it keeps repeating every second (or slightly less).

    00> <debug> app: Setting up vector table: 0x00064000
    00> 
    00> <debug> app: ***** BootApp Initialized *****
    00> 
    00> <debug> app: In nrf_bootloader_init
    00> 
    00> <debug> nrf_dfu_settings: Calling nrf_dfu_settings_init()...
    00> 
    00> <debug> nrf_dfu_flash: Initializing nrf_fstorage_nvmc backend.
    00> 
    00> <debug> nrf_dfu_settings: Using settings page.
    00> 
    00> <debug> nrf_dfu_settings: Copying forbidden parts from backup page.
    00> 
    00> <debug> nrf_dfu_settings: Destination settings are identical to source, write not needed. Skipping.
    00> 
    00> <info> nrf_dfu_settings: Backing up settings page to address 0x76000.
    00> 
    00> <debug> nrf_dfu_settings: Destination settings are identical to source, write not needed. Skipping.
    00> 
    00> <debug> app: Enter nrf_bootloader_fw_activate
    00> 
    00> <info> app: No firmware to activate.
    00> 
    00> <info> app: Boot validation failed. No valid app to boot.
    00> 
    00> <debug> app: DFU mode because app is not valid.
    00> 
    00> <info> nrf_bootloader_wdt: WDT is not enabled
    00> 
    00> <debug> app: in weak nrf_dfu_init_user
    00> 
    00> <debug> app: timer_stop (0x2000300C)
    00> 
    00> <debug> app: timer_activate (0x2000300C)
    00> 
    00> <info> app: Entering DFU mode.
    00> 
    00> <debug> app: Initializing transports (found: 2)
    00> 
    00> <debug> nrf_dfu_ble: Initializing BLE DFU transport
    00> 
    00> <debug> nrf_dfu_ble: Enabling SoftDevice.
    00> 
    00> <debug> nrf_dfu_ble: Configuring BLE stack.
    00> 
    00> <debug> nrf_dfu_ble: Enabling the BLE stack.
    00> 
    00> <debug> nrf_dfu_ble: No advertising name found
    00> 
    00> <debug> nrf_dfu_ble: Using default advertising name
    00> 
    00> <debug> nrf_dfu_ble: Advertising...
    00> 
    00> <debug> nrf_dfu_ble: BLE DFU transport initialized.
    00> 
    00> <debug> nrf_dfu_serial_uart: serial_dfu_transport_init()
    00> 
    00> <debug> nrf_dfu_serial_uart: serial_dfu_transport_init() completed
    00> 
    00> <debug> app: Error 12: ..\..\bootloader\serial_dfu\nrf_dfu_serial_uart.c:150
    00> 
    

    The error:

    00> <debug> app: Error 12: ..\..\bootloader\serial_dfu\nrf_dfu_serial_uart.c:150

    I assume the error indicates that it happened at line 150 in nrf_dfu_serial_uart.c. Please see the code snippet below:

Reply
  • Hi Amanda,

    Sorry for the delayed response.

    Please find below is the log output from the bootloader. I found that it kept rebooting. This segment you see blow is the full cycle, and it keeps repeating every second (or slightly less).

    00> <debug> app: Setting up vector table: 0x00064000
    00> 
    00> <debug> app: ***** BootApp Initialized *****
    00> 
    00> <debug> app: In nrf_bootloader_init
    00> 
    00> <debug> nrf_dfu_settings: Calling nrf_dfu_settings_init()...
    00> 
    00> <debug> nrf_dfu_flash: Initializing nrf_fstorage_nvmc backend.
    00> 
    00> <debug> nrf_dfu_settings: Using settings page.
    00> 
    00> <debug> nrf_dfu_settings: Copying forbidden parts from backup page.
    00> 
    00> <debug> nrf_dfu_settings: Destination settings are identical to source, write not needed. Skipping.
    00> 
    00> <info> nrf_dfu_settings: Backing up settings page to address 0x76000.
    00> 
    00> <debug> nrf_dfu_settings: Destination settings are identical to source, write not needed. Skipping.
    00> 
    00> <debug> app: Enter nrf_bootloader_fw_activate
    00> 
    00> <info> app: No firmware to activate.
    00> 
    00> <info> app: Boot validation failed. No valid app to boot.
    00> 
    00> <debug> app: DFU mode because app is not valid.
    00> 
    00> <info> nrf_bootloader_wdt: WDT is not enabled
    00> 
    00> <debug> app: in weak nrf_dfu_init_user
    00> 
    00> <debug> app: timer_stop (0x2000300C)
    00> 
    00> <debug> app: timer_activate (0x2000300C)
    00> 
    00> <info> app: Entering DFU mode.
    00> 
    00> <debug> app: Initializing transports (found: 2)
    00> 
    00> <debug> nrf_dfu_ble: Initializing BLE DFU transport
    00> 
    00> <debug> nrf_dfu_ble: Enabling SoftDevice.
    00> 
    00> <debug> nrf_dfu_ble: Configuring BLE stack.
    00> 
    00> <debug> nrf_dfu_ble: Enabling the BLE stack.
    00> 
    00> <debug> nrf_dfu_ble: No advertising name found
    00> 
    00> <debug> nrf_dfu_ble: Using default advertising name
    00> 
    00> <debug> nrf_dfu_ble: Advertising...
    00> 
    00> <debug> nrf_dfu_ble: BLE DFU transport initialized.
    00> 
    00> <debug> nrf_dfu_serial_uart: serial_dfu_transport_init()
    00> 
    00> <debug> nrf_dfu_serial_uart: serial_dfu_transport_init() completed
    00> 
    00> <debug> app: Error 12: ..\..\bootloader\serial_dfu\nrf_dfu_serial_uart.c:150
    00> 
    

    The error:

    00> <debug> app: Error 12: ..\..\bootloader\serial_dfu\nrf_dfu_serial_uart.c:150

    I assume the error indicates that it happened at line 150 in nrf_dfu_serial_uart.c. Please see the code snippet below:

Children
Related