• State Verified Answer
  • Replies 2 replies
  • Subscribers 73 subscribers
  • Views 1423 views
  • Users 0 members are here
Attachments (1) Download All
Nordic Case Info
  • Case ID: 212012
Options
This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts

App not starting after DFU

digitalnyx

I am attempting to add DFU capability to an nRF52 based product but have run into an issue. I was able to successfully build the boot loader and flash it to the device. I was unable to get anything working after flashing the boot loader, app, and SD to the device so I backed up a step. I can see the DFU service running from my phone so I packaged the app and attempted to upload it. Everything appears to work correctly but the device just boots right back into the DFU mode after flashing. I have attached an RTT log of the process. I have it set so that the DFU code will log when in main as will the app; however, the app main never seems to be reached.

I did have to change the boot loader start to 0x70000 to fit the RTT code but everything seems to go fine from there and the app position is the same at 0x1F000 so I would expect it to find it. If I disable logging and move the boot loader back to 0x78000 I observe the same behavior.

Any ideas?

SDK: nRF5_SDK_12.2.0_f012efa

SD: s132_nrf52_3.0.0_softdevice.hex

Fullscreen dfu_log_1.log Download 
# SEGGER J-Link RTT Viewer V6.12a Terminal Log File
# Compiled: 16:45:33 on Dec  2 2016
# Logging started @ 07 Aug 2018 14:28:56
 0> :INFO:Inside DFU main
 0> :INFO:In nrf_bootloader_init
 0> :INFO:In real nrf_dfu_init
 0> :INFO:running nrf_dfu_settings_init
 0> :INFO:!!!!!!!!!!!!!!! Resetting bootloader settings !!!!!!!!!!!
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Enter nrf_dfu_continue
 0> :INFO:Single: Invalid bank
 0> :INFO:Application sent bootloader request
 0> :INFO:In nrf_dfu_transports_init
 0> :INFO:num transports: 1
 0> :INFO:vector table: 0x00070000
 0> :INFO:After nrf_dfu_transports_init
 0> :INFO:------- nrf_dfu_flash_init-------
 0> :INFO:Waiting for events
 0> :INFO:Received select object
 0> :INFO:Valid Command: NRF_DFU_OBJECT_OP_SELECT
 0> :INFO:Sending Object Info: [0x60, 0x06, 0x01 max: 0:x00000100 0:x00000000, CRC:0x00000000]
 0> :INFO:Set receipt notif
 0> :INFO:Sending Response: [0x2, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create command
 0> :INFO:Valid Command Create
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Before OP write command
 0> :INFO:Received calculate CRC
 0> :INFO:Valid Command CRC
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00000087, CRC:0x61d30010]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute command
 0> :INFO:Valid command execute
 0> :INFO:
 0> 12 84 01 0A 3E 08 01 12 3A 08 05 10 34 1A 02 8C  ....>...:...4...
 0> 01 20 00 28 00 30 00 38 C0 ED 02 42 24 08 03 12  . .(.0.8...B$...
 0> 20 B9 E9 78 0A 75 B7 23 F5 2B 72 A9 5B 40 03 89   ..x.u.#.+r.[@..
 0> A8 B0 ED D9 BC 45 1B 79 EA E0 2F 88 69 1E 70 B2  .....E.y../.i.p.
 0> 47 48 00 10 00 1A 40 D4 6F 34 8B 77 C4 68 E1 28  [email protected].(
 0> 42 BB AB EF 38 17 52 6D 28 B3 6E F3 84 81 3D F9  B...8.Rm(.n...=.
 0> :INFO:
 0> 47 48 00 10 00 1A 40 D4 6F 34 8B 77 C4 68 E1 28  [email protected].(
 0> 42 BB AB EF 38 17 52 6D 28 B3 6E F3 84 81 3D F9  B...8.Rm(.n...=.
 0> :INFO:
 0> :INFO:p_Init command:
 0> :INFO:Image verified
 0> :INFO:Enter nrf_dfu_find_cache
 0> :INFO:Bank content
 0> :INFO:Bank type: 0
 0> :INFO:Bank 0 code: 0x00: Size: 0
 0> :INFO:Bank 1 code: 0x00: Size: 0
 0> :INFO:No previous, using bank 0
 0> :INFO:Write address set to 0x0001f000
 0> :INFO:DFU prevalidate SUCCESSFUL!
 0> :INFO:Prevalidate OK.
 0> :INFO:Saving init command...
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Setting DFU flag to initialized
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received select object
 0> :INFO:Valid Data Read info
 0> :INFO:Sending Object Info: [0x60, 0x06, 0x01 max: 0:x00001000 0:x00000000, CRC:0x00000000]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x0001f000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00000000, CRC: 0x00000000
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x0001f000
 0> :INFO:Storing 256 B at: 0x0001f100
 0> :INFO:Storing 256 B at: 0x0001f200
 0> :INFO:Storing 256 B at: 0x0001f300
 0> :INFO:Storing 256 B at: 0x0001f400
 0> :INFO:Storing 256 B at: 0x0001f500
 0> :INFO:Storing 256 B at: 0x0001f600
 0> :INFO:Storing 256 B at: 0x0001f700
 0> :INFO:Storing 256 B at: 0x0001f800
 0> :INFO:Storing 256 B at: 0x0001f900
 0> :INFO:Storing 256 B at: 0x0001fa00
 0> :INFO:Storing 256 B at: 0x0001fb00
 0> :INFO:Storing 256 B at: 0x0001fc00
 0> :INFO:Storing 256 B at: 0x0001fd00
 0> :INFO:Storing 256 B at: 0x0001fe00
 0> :INFO:Storing 256 B at: 0x0001ff00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00001000, CRC:0xdad53476]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00020000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00001000, CRC: 0xdad53476
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00020000
 0> :INFO:Storing 256 B at: 0x00020100
 0> :INFO:Storing 256 B at: 0x00020200
 0> :INFO:Storing 256 B at: 0x00020300
 0> :INFO:Storing 256 B at: 0x00020400
 0> :INFO:Storing 256 B at: 0x00020500
 0> :INFO:Storing 256 B at: 0x00020600
 0> :INFO:Storing 256 B at: 0x00020700
 0> :INFO:Storing 256 B at: 0x00020800
 0> :INFO:Storing 256 B at: 0x00020900
 0> :INFO:Storing 256 B at: 0x00020a00
 0> :INFO:Storing 256 B at: 0x00020b00
 0> :INFO:Storing 256 B at: 0x00020c00
 0> :INFO:Storing 256 B at: 0x00020d00
 0> :INFO:Storing 256 B at: 0x00020e00
 0> :INFO:Storing 256 B at: 0x00020f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00002000, CRC:0x323ec6b6]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00021000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00002000, CRC: 0x323ec6b6
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00021000
 0> :INFO:Storing 256 B at: 0x00021100
 0> :INFO:Storing 256 B at: 0x00021200
 0> :INFO:Storing 256 B at: 0x00021300
 0> :INFO:Storing 256 B at: 0x00021400
 0> :INFO:Storing 256 B at: 0x00021500
 0> :INFO:Storing 256 B at: 0x00021600
 0> :INFO:Storing 256 B at: 0x00021700
 0> :INFO:Storing 256 B at: 0x00021800
 0> :INFO:Storing 256 B at: 0x00021900
 0> :INFO:Storing 256 B at: 0x00021a00
 0> :INFO:Storing 256 B at: 0x00021b00
 0> :INFO:Storing 256 B at: 0x00021c00
 0> :INFO:Storing 256 B at: 0x00021d00
 0> :INFO:Storing 256 B at: 0x00021e00
 0> :INFO:Storing 256 B at: 0x00021f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00003000, CRC:0x098c69ea]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00022000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00003000, CRC: 0x098c69ea
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00022000
 0> :INFO:Storing 256 B at: 0x00022100
 0> :INFO:Storing 256 B at: 0x00022200
 0> :INFO:Storing 256 B at: 0x00022300
 0> :INFO:Storing 256 B at: 0x00022400
 0> :INFO:Storing 256 B at: 0x00022500
 0> :INFO:Storing 256 B at: 0x00022600
 0> :INFO:Storing 256 B at: 0x00022700
 0> :INFO:Storing 256 B at: 0x00022800
 0> :INFO:Storing 256 B at: 0x00022900
 0> :INFO:Storing 256 B at: 0x00022a00
 0> :INFO:Storing 256 B at: 0x00022b00
 0> :INFO:Storing 256 B at: 0x00022c00
 0> :INFO:Storing 256 B at: 0x00022d00
 0> :INFO:Storing 256 B at: 0x00022e00
 0> :INFO:Storing 256 B at: 0x00022f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00004000, CRC:0xfa008333]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00023000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00004000, CRC: 0xfa008333
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00023000
 0> :INFO:Storing 256 B at: 0x00023100
 0> :INFO:Storing 256 B at: 0x00023200
 0> :INFO:Storing 256 B at: 0x00023300
 0> :INFO:Storing 256 B at: 0x00023400
 0> :INFO:Storing 256 B at: 0x00023500
 0> :INFO:Storing 256 B at: 0x00023600
 0> :INFO:Storing 256 B at: 0x00023700
 0> :INFO:Storing 256 B at: 0x00023800
 0> :INFO:Storing 256 B at: 0x00023900
 0> :INFO:Storing 256 B at: 0x00023a00
 0> :INFO:Storing 256 B at: 0x00023b00
 0> :INFO:Storing 256 B at: 0x00023c00
 0> :INFO:Storing 256 B at: 0x00023d00
 0> :INFO:Storing 256 B at: 0x00023e00
 0> :INFO:Storing 256 B at: 0x00023f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00005000, CRC:0xafe30913]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00024000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00005000, CRC: 0xafe30913
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00024000
 0> :INFO:Storing 256 B at: 0x00024100
 0> :INFO:Storing 256 B at: 0x00024200
 0> :INFO:Storing 256 B at: 0x00024300
 0> :INFO:Storing 256 B at: 0x00024400
 0> :INFO:Storing 256 B at: 0x00024500
 0> :INFO:Storing 256 B at: 0x00024600
 0> :INFO:Storing 256 B at: 0x00024700
 0> :INFO:Storing 256 B at: 0x00024800
 0> :INFO:Storing 256 B at: 0x00024900
 0> :INFO:Storing 256 B at: 0x00024a00
 0> :INFO:Storing 256 B at: 0x00024b00
 0> :INFO:Storing 256 B at: 0x00024c00
 0> :INFO:Storing 256 B at: 0x00024d00
 0> :INFO:Storing 256 B at: 0x00024e00
 0> :INFO:Storing 256 B at: 0x00024f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00006000, CRC:0x9a1d05be]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00025000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00006000, CRC: 0x9a1d05be
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00025000
 0> :INFO:Storing 256 B at: 0x00025100
 0> :INFO:Storing 256 B at: 0x00025200
 0> :INFO:Storing 256 B at: 0x00025300
 0> :INFO:Storing 256 B at: 0x00025400
 0> :INFO:Storing 256 B at: 0x00025500
 0> :INFO:Storing 256 B at: 0x00025600
 0> :INFO:Storing 256 B at: 0x00025700
 0> :INFO:Storing 256 B at: 0x00025800
 0> :INFO:Storing 256 B at: 0x00025900
 0> :INFO:Storing 256 B at: 0x00025a00
 0> :INFO:Storing 256 B at: 0x00025b00
 0> :INFO:Storing 256 B at: 0x00025c00
 0> :INFO:Storing 256 B at: 0x00025d00
 0> :INFO:Storing 256 B at: 0x00025e00
 0> :INFO:Storing 256 B at: 0x00025f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00007000, CRC:0x03e0cec7]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00026000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00007000, CRC: 0x03e0cec7
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00026000
 0> :INFO:Storing 256 B at: 0x00026100
 0> :INFO:Storing 256 B at: 0x00026200
 0> :INFO:Storing 256 B at: 0x00026300
 0> :INFO:Storing 256 B at: 0x00026400
 0> :INFO:Storing 256 B at: 0x00026500
 0> :INFO:Storing 256 B at: 0x00026600
 0> :INFO:Storing 256 B at: 0x00026700
 0> :INFO:Storing 256 B at: 0x00026800
 0> :INFO:Storing 256 B at: 0x00026900
 0> :INFO:Storing 256 B at: 0x00026a00
 0> :INFO:Storing 256 B at: 0x00026b00
 0> :INFO:Storing 256 B at: 0x00026c00
 0> :INFO:Storing 256 B at: 0x00026d00
 0> :INFO:Storing 256 B at: 0x00026e00
 0> :INFO:Storing 256 B at: 0x00026f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00008000, CRC:0x8ab9e18a]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00027000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00008000, CRC: 0x8ab9e18a
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00027000
 0> :INFO:Storing 256 B at: 0x00027100
 0> :INFO:Storing 256 B at: 0x00027200
 0> :INFO:Storing 256 B at: 0x00027300
 0> :INFO:Storing 256 B at: 0x00027400
 0> :INFO:Storing 256 B at: 0x00027500
 0> :INFO:Storing 256 B at: 0x00027600
 0> :INFO:Storing 256 B at: 0x00027700
 0> :INFO:Storing 256 B at: 0x00027800
 0> :INFO:Storing 256 B at: 0x00027900
 0> :INFO:Storing 256 B at: 0x00027a00
 0> :INFO:Storing 256 B at: 0x00027b00
 0> :INFO:Storing 256 B at: 0x00027c00
 0> :INFO:Storing 256 B at: 0x00027d00
 0> :INFO:Storing 256 B at: 0x00027e00
 0> :INFO:Storing 256 B at: 0x00027f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x00009000, CRC:0x588e4213]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00028000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x00009000, CRC: 0x588e4213
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00028000
 0> :INFO:Storing 256 B at: 0x00028100
 0> :INFO:Storing 256 B at: 0x00028200
 0> :INFO:Storing 256 B at: 0x00028300
 0> :INFO:Storing 256 B at: 0x00028400
 0> :INFO:Storing 256 B at: 0x00028500
 0> :INFO:Storing 256 B at: 0x00028600
 0> :INFO:Storing 256 B at: 0x00028700
 0> :INFO:Storing 256 B at: 0x00028800
 0> :INFO:Storing 256 B at: 0x00028900
 0> :INFO:Storing 256 B at: 0x00028a00
 0> :INFO:Storing 256 B at: 0x00028b00
 0> :INFO:Storing 256 B at: 0x00028c00
 0> :INFO:Storing 256 B at: 0x00028d00
 0> :INFO:Storing 256 B at: 0x00028e00
 0> :INFO:Storing 256 B at: 0x00028f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x0000a000, CRC:0xb88f29f4]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x00029000, num: 1
 0> :INFO:Creating object with size: 4096. Offset: 0x0000a000, CRC: 0xb88f29f4
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x00029000
 0> :INFO:Storing 256 B at: 0x00029100
 0> :INFO:Storing 256 B at: 0x00029200
 0> :INFO:Storing 256 B at: 0x00029300
 0> :INFO:Storing 256 B at: 0x00029400
 0> :INFO:Storing 256 B at: 0x00029500
 0> :INFO:Storing 256 B at: 0x00029600
 0> :INFO:Storing 256 B at: 0x00029700
 0> :INFO:Storing 256 B at: 0x00029800
 0> :INFO:Storing 256 B at: 0x00029900
 0> :INFO:Storing 256 B at: 0x00029a00
 0> :INFO:Storing 256 B at: 0x00029b00
 0> :INFO:Storing 256 B at: 0x00029c00
 0> :INFO:Storing 256 B at: 0x00029d00
 0> :INFO:Storing 256 B at: 0x00029e00
 0> :INFO:Storing 256 B at: 0x00029f00
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x0000b000, CRC:0xd1235a8a]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Received create object
 0> :INFO:Before OP create
 0> :INFO:Valid Data Create
 0> :INFO:Erasing: 0x0002a000, num: 1
 0> :INFO:Creating object with size: 1728. Offset: 0x0000b000, CRC: 0xd1235a8a
 0> :INFO:Sending Response: [0x1, 0x1]
 0> :INFO:Storing 256 B at: 0x0002a000
 0> :INFO:Storing 256 B at: 0x0002a100
 0> :INFO:Storing 256 B at: 0x0002a200
 0> :INFO:Storing 256 B at: 0x0002a300
 0> :INFO:Storing 256 B at: 0x0002a400
 0> :INFO:Storing 256 B at: 0x0002a500
 0> :INFO:Storing 192 B at: 0x0002a600
 0> :INFO:Received calculate CRC
 0> :INFO:Before OP crc
 0> :INFO:Sending CRC: [0x60, 0x03, 0x01, 0:x0000b6c0, CRC:0xc171306a]
 0> :INFO:Received execute object
 0> :INFO:Before OP execute
 0> :INFO:Valid Data Execute
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Waiting for 0 pending flash operations before doing postvalidate.
 0> :INFO:Doing postvalidate
 0> :INFO:Current bank is bank 0
 0> :INFO:Successfully run the postvalidation check!
 0> :INFO:Erasing old settings at: 0x0007f000
 0> :INFO:Waiting for other flash operation to finish.
 0> :INFO:Waiting for other flash operation to finish.
 0> :INFO:Erasing: 0x0007f000, num: 1
 0> :INFO:Writing 0x00000057 words
 0> :INFO:Writing settings...
 0> :INFO:Sending Response: [0x4, 0x1]
 0> :INFO:Resetting device. 
 0> :INFO:In nrf_dfu_transports_close
 0> :INFO:num transports: 1
 0> :INFO:Waiting for buffers to be cleared before disconnect
 0> :INFO:Inside DFU main
 0> :INFO:In nrf_bootloader_init
 0> :INFO:In real nrf_dfu_init
 0> :INFO:running nrf_dfu_settings_init
 0> :INFO:Enter nrf_dfu_continue
 0> :INFO:Valid App
 0> :INFO:Application sent bootloader request
 0> :INFO:In nrf_dfu_transports_init
 0> :INFO:num transports: 1
 0> :INFO:vector table: 0x00070000
 0> :INFO:After nrf_dfu_transports_init
 0> :INFO:------- nrf_dfu_flash_init-------
 0> :INFO:Waiting for events

# Logging stopped @ 07 Aug 2018 14:32:48

Parents
  • +1

    Hi,

    Assuming you have not modified the bootloader, the log string "Application sent bootloader request" is only printed if nrf_dfu_enter_check() returns true, which can happen for two reasons:

    • the GPIO pin used to force bootloader entry is asserted, or
    • the enter_buttonless_dfu flag in bootloader settings is set to 1.

    Which pin is configured as BOOTLOADER_BUTTON, and what is the state of that pin?

  • 0 in reply to Einar Thorsrud

    Einar,

    Thanks for the clue. In the SDK I have, DFU check was:

    __WEAK bool nrf_dfu_enter_check(void)
{
    return true;
    
    /*
    if (nrf_gpio_pin_read(BOOTLOADER_BUTTON) == 0)
    {
        return true;
    }

    if (s_dfu_settings.enter_buttonless_dfu == 1)
    {
        s_dfu_settings.enter_buttonless_dfu = 0;
        APP_ERROR_CHECK(nrf_dfu_settings_write(NULL));
        return true;
    }
    return false;
    */
}

    Overriding it fixed the issue.

    Thanks!

Reply Children
No Data
Related
Terms of service