Showing the error state when running dfu to nRF5340

Hi,

Our product is based on nRF5340 and will run DFU over BLE.

Now I am testing the DFU function via the "Firmware Upgrade" in device manager APP.

In the current architecture, there are two kinds of dfu image should be sent to device:

app_update.bin(app core only) and dfu_application.zip(app_core and net_core).

When updating the dfu_application.zip,  the device can receive the whole image and

do the updating successfully.

The log below shows the image has been swapped to the primary partition.

But the "device manager" still shows an error "Invalid value(3)".

*** Booting Zephyr OS build aec156f2fe71  ***
I: Starting bootloader
I: Swap type: none
I: Swap type: test
I: Image upgrade secondary slot -> primary slot
I: Erasing the primary slot
I: Copying the secondary slot to the primary slot: 0x2be5c bytes
I: Turned on network core
I: Turned off network core
I: Bootloader chainload address offset: 0xc000
*** Booting Zephyr OS build aec156f2fe71  ***
[00:00:00.005,004] <inf> mcumgr_zephyr_grp: Registering Zephyr basic mgmt group

The device manager shows the error:

If I just updated the app_update.bin, all the process is good.

Our SDK version v2.1.0.

Please help us to check this issue.

Thanks.

Parents
  • Hi,

    Make sure you have enabled multi image DFU in your prj.conf:

    CONFIG_DFU_MULTI_IMAGE=y
    CONFIG_UPDATEABLE_IMAGE_NUMBER=2

    And that you enable the necessary mcuboot configs in your mcuboot.conf:

    # Increase main stack size
    CONFIG_MAIN_STACK_SIZE=10240
    
    # Configure MCUboot features
    CONFIG_NRF53_MULTI_IMAGE_UPDATE=y
    CONFIG_BOOT_UPGRADE_ONLY=y
    CONFIG_BOOT_MAX_IMG_SECTORS=256
    CONFIG_MCUBOOT_DOWNGRADE_PREVENTION=y
    
    # Allow for storing two images in MCUboot partitions
    CONFIG_UPDATEABLE_IMAGE_NUMBER=2
    
    # Allow for storing two images in MCUboot partitions
    CONFIG_UPDATEABLE_IMAGE_NUMBER=2
    
    # Store new images inside external flash
    CONFIG_PM_EXTERNAL_FLASH_MCUBOOT_SECONDARY=y
    
    # Enable flash simulator
    CONFIG_PCD_APP=y
    CONFIG_FLASH_SIMULATOR=y
    CONFIG_FLASH_SIMULATOR_DOUBLE_WRITES=y
    CONFIG_FLASH_SIMULATOR_STATS=n
    
    # Configure QSPI for external flash
    CONFIG_FLASH=y
    CONFIG_FPROTECT=y
    CONFIG_NORDIC_QSPI_NOR=y
    CONFIG_NORDIC_QSPI_NOR_FLASH_LAYOUT_PAGE_SIZE=4096
    CONFIG_NORDIC_QSPI_NOR_STACK_WRITE_BUFFER_SIZE=16

    For more information you can check out this Simultaneous DFU for app and net core of nRF5340 example by a colleague of mine, where they are doing exactly what you are trying to do.

    Best regards,

    Marte

  • Hi,

    As I mentioned in my post, I can upgrade our product of app_core and net_core simultaneously.

    So the configuration of bootloader and zephyr shouldn't have any problem.

    I tried the example ( Simultaneous DFU for app and net...) and got the same result.

    ==> nRF connect (Android): PASS

            nRF connect Device Manager(Android) : Upgrading finished. App still show error.

    I am just wondering why the upgrading is successful but the "Device Manager" app still shows error.

    It means the app can't get the right result of device upgrading.

    thanks,

    Jacob

Reply Children
  • Hi Jacob,

    Thank you for clarifying and for verifying that this does not happen with the nRF Connect app. I have reported this to the team responsible for the app.

    Best regards,

    Marte

  • Hi Jacob,

    The team got back to me already. They are asking if you can install the nRF Logger app. With this installed, retry DFU until you get the state showing error as in your pictures. The logs will be saved to nRF Logger, so then open nRF Logger and select Device Manager:

    Find the last session and share the logs:

    In addition to this, a thing you can try to do is to go into the additional settings for DFU in the Device Manager and deselect "Erase application settings":

    It should work despite this, but it might be the reason for the issue.

    Best regards,

    Marte

  • Hi Marte,

    I tried the "deselect Erase application settings" but it's not help on the issue.

    I attached the log file from nrf-Logger.

    Thanks.

    Device Manager, 2022-10-28
    ISD_IAQ (Device Manager)
    I	16:26:55.832	[e] Connected to C1:28:62:08:A0:D8
    I	16:26:56.771	[e] PHY updated (TX: LE 2M, RX: LE 2M)
    I	16:26:57.194	[e] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	16:26:57.326	[e] Services discovered
    I	16:26:57.412	[e] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	16:26:57.457	[e] MTU changed to: 498
    I	16:26:57.696	[e] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
    I	16:26:57.722	[e] Notifications enabled
    I	16:26:57.739	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-01-00-00-FF-06-A0
    I	16:26:57.884	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-FF-06-BF-62-72-63-08-FF
    I	16:26:57.917	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 255, Command: 6) CBOR {"rc":8}
    I	16:26:57.933	[e] PHY read (TX: LE 2M, RX: LE 2M)
    I	16:26:57.949	[e] Sending (19 bytes) Header (Op: 2, Flags: 0, Len: 11, Group: 0, Seq: 0, Command: 0) CBOR {"d":"Hello!"}
    I	16:26:57.957	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-0B-00-00-00-00-BF-61-64-66-48-65-6C-6C-6F-21-FF
    I	16:26:57.963	[e] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 0, Seq: 1, Command: 6) CBOR {}
    I	16:26:57.976	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-00-01-06-BF-FF
    I	16:26:58.122	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-0B-00-00-00-00-BF-61-72-66-48-65-6C-6C-6F-21-FF
    I	16:26:58.138	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-01-06-BF-62-72-63-08-FF
    I	16:26:58.153	[e] Received Header (Op: 3, Flags: 0, Len: 11, Group: 0, Seq: 0, Command: 0) CBOR {"r":"Hello!"}
    I	16:26:58.163	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 1, Command: 6) CBOR {"rc":8}
    V	16:27:39.566	[j] Starting DFU, mode: TEST_AND_CONFIRM
    I	16:27:39.762	[e] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 2, Command: 0) CBOR {}
    I	16:27:39.853	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-01-02-00-BF-FF
    I	16:27:39.897	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-8D-00-01-02-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-1B-A5-79-58-83-51-35-26-AB-76-A8-BB-EE-8D-99-3C-18-42-06-B8-7D-CE-87-5A-41-93-E9-DE-F2-91-19-EF-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-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
    I	16:27:39.919	[e] Received Header (Op: 1, Flags: 0, Len: 141, Group: 1, Seq: 2, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    V	16:27:39.947	[k] Validation response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    V	16:27:39.974	[j] Moving from state VALIDATE to state UPLOAD
    I	16:27:40.003	[e] Connection parameters updated (interval: 15.0ms, latency: 0, timeout: 20000ms)
    I	16:27:40.011	Uploading firmware...
    I	16:27:51.216	[ImageUploader] Upload completed. 179800 bytes sent in 11201 ms with avg speed: 16.050705 kBytes/s
    I	16:27:51.232	Image (179800 bytes) sent in 11151 ms (avg speed: 16.124115 kB/s)
    V	16:27:51.371	[c] Erase storage response: {}
    V	16:27:51.393	[j] Moving from state UPLOAD to state TEST
    I	16:27:51.406	[e] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 133, Command: 0) CBOR {"confirm":false,"hash":"32LSyceZtObA3xxu2LWeAn/TYbbCI41X87DSWdbt+FM="}
    I	16:27:51.451	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-85-00-BF-67-63-6F-6E-66-69-72-6D-F4-64-68-61-73-68-58-20-DF-62-D2-C9-C7-99-B4-E6-C0-DF-1C-6E-D8-B5-9E-02-7F-D3-61-B6-C2-23-8D-57-F3-B0-D2-59-D6-ED-F8-53-FF
    I	16:27:51.491	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-01-02-00-01-85-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-1B-A5-79-58-83-51-35-26-AB-76-A8-BB-EE-8D-99-3C-18-42-06-B8-7D-CE-87-5A-41-93-E9-DE-F2-91-19-EF-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-65-69-6D-61-67-65-01-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-DF-62-D2-C9-C7-99-B4-E6-C0-DF-1C-6E-D8-B5-9E-02-7F-D3-61-B6-C2-23-8D-57-F3-B0-D2-59-D6-ED-F8-53-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
    I	16:27:51.515	[e] Received Header (Op: 3, Flags: 0, Len: 258, Group: 1, Seq: 133, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"32LSyceZtObA3xxu2LWeAn/TYbbCI41X87DSWdbt+FM=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    V	16:27:51.527	[i] Test response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"32LSyceZtObA3xxu2LWeAn/TYbbCI41X87DSWdbt+FM=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    V	16:27:51.531	[j] Moving from state TEST to state RESET
    I	16:27:51.550	[e] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 134, Command: 5) CBOR {}
    I	16:27:51.559	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-00-86-05-BF-FF
    I	16:27:51.586	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-02-00-00-86-05-BF-FF
    I	16:27:51.612	[e] Received Header (Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 134, Command: 5) CBOR {}
    V	16:27:51.638	[g] Reset request success. Waiting for disconnect...
    W	16:28:11.856	[e] Error: (0x8): GATT CONN TIMEOUT
    I	16:28:11.892	[e] Disconnected
    I	16:28:11.928	[g] Device disconnected
    V	16:28:11.947	[g] Waiting remaining 4685 ms for the swap operation to complete
    V	16:28:16.656	[j] Moving from state RESET to state CONFIRM
    I	16:28:16.828	[e] Connected to C1:28:62:08:A0:D8
    I	16:28:17.693	[e] PHY updated (TX: LE 2M, RX: LE 2M)
    I	16:28:18.110	[e] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	16:28:18.342	[e] Services discovered
    I	16:28:18.436	[e] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	16:28:18.561	[e] MTU changed to: 498
    I	16:28:18.788	[e] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
    I	16:28:18.815	[e] Notifications enabled
    I	16:28:18.845	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-01-00-00-FF-06-A0
    I	16:28:19.081	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-FF-06-BF-62-72-63-08-FF
    I	16:28:19.099	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 255, Command: 6) CBOR {"rc":8}
    I	16:28:19.151	[e] PHY read (TX: LE 2M, RX: LE 2M)
    I	16:28:19.183	[e] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"32LSyceZtObA3xxu2LWeAn/TYbbCI41X87DSWdbt+FM="}
    I	16:28:19.194	[e] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 0, Seq: 1, Command: 6) CBOR {}
    I	16:28:19.217	[e] 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-DF-62-D2-C9-C7-99-B4-E6-C0-DF-1C-6E-D8-B5-9E-02-7F-D3-61-B6-C2-23-8D-57-F3-B0-D2-59-D6-ED-F8-53-FF
    I	16:28:19.236	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-00-01-06-BF-FF
    I	16:28:19.371	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-01-00-00-BF-62-72-63-03-FF
    I	16:28:19.394	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-01-06-BF-62-72-63-08-FF
    I	16:28:19.418	[e] Received Header (Op: 3, Flags: 0, Len: 6, Group: 1, Seq: 0, Command: 0) CBOR {"rc":3}
    I	16:28:19.442	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 1, Command: 6) CBOR {"rc":8}
    E	16:28:19.463	Upgrade failed
    Mcu Mgr Error: IN_VALUE (3)
    	at g2.e$b.c(Unknown Source:24)
    	at h2.f.j(Unknown Source:10)
    	at h2.f.a(Unknown Source:0)
    	at h2.d.run(Unknown Source:4)
    	at android.os.Handler.handleCallback(Handler.java:873)
    	at android.os.Handler.dispatchMessage(Handler.java:99)
    	at android.os.Looper.loop(Looper.java:210)
    	at android.os.HandlerThread.run(HandlerThread.java:65)
    
    V	16:28:46.982	[j] Starting DFU, mode: TEST_AND_CONFIRM
    I	16:28:47.187	[e] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 1, Seq: 2, Command: 0) CBOR {}
    I	16:28:47.195	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-01-02-00-BF-FF
    I	16:28:47.306	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-8D-00-01-02-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-1B-A5-79-58-83-51-35-26-AB-76-A8-BB-EE-8D-99-3C-18-42-06-B8-7D-CE-87-5A-41-93-E9-DE-F2-91-19-EF-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-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
    I	16:28:47.314	[e] Received Header (Op: 1, Flags: 0, Len: 141, Group: 1, Seq: 2, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    V	16:28:47.327	[k] Validation response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    V	16:28:47.334	[j] Moving from state VALIDATE to state UPLOAD
    I	16:28:47.347	[e] Sending (492 bytes) Header (Op: 2, Flags: 0, Len: 484, Group: 1, Seq: 3, Command: 1) CBOR {"data":"PbjzlgAAAAAAAgAAyI8FAAAAAAAAAAAAAAAAAAAAAAD///////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////////8=","len":365336,"sha":"StDS","off":0}
    I	16:28:47.351	Uploading firmware...
    I	16:29:09.347	[ImageUploader] Upload completed. 365336 bytes sent in 21997 ms with avg speed: 16.60769 kBytes/s
    I	16:29:09.354	Image (365336 bytes) sent in 21899 ms (avg speed: 16.682772 kB/s)
    I	16:29:20.046	[ImageUploader] Upload completed. 171036 bytes sent in 10678 ms with avg speed: 16.016106 kBytes/s
    I	16:29:20.055	Image (171036 bytes) sent in 10569 ms (avg speed: 16.182798 kB/s)
    V	16:29:20.079	[j] Moving from state UPLOAD to state TEST
    I	16:29:20.176	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-01-77-00-01-7E-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-1B-A5-79-58-83-51-35-26-AB-76-A8-BB-EE-8D-99-3C-18-42-06-B8-7D-CE-87-5A-41-93-E9-DE-F2-91-19-EF-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-65-69-6D-61-67-65-00-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-59-0F-02-3A-0B-17-97-5A-EC-32-80-02-70-CF-89-8D-2C-31-9A-10-E3-C8-ED-84-2F-AB-29-CD-D6-5F-BB-F7-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-BF-65-69-6D-61-67-65-01-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-D1-F8-04-21-26-AF-8C-6B-B6-76-5E-E7-E7-BF-55-08-1B-E2-86-51-FC-35-56-61-9E-85-A9-F0-E4-69-3D-EA-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
    I	16:29:20.199	[e] Received Header (Op: 3, Flags: 0, Len: 375, Group: 1, Seq: 126, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":0,"slot":1,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    V	16:29:20.224	[i] Test response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":0,"slot":1,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo=","bootable":true,"pending":false,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    I	16:29:20.245	[e] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 127, Command: 0) CBOR {"confirm":false,"hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo="}
    I	16:29:20.270	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-7F-00-BF-67-63-6F-6E-66-69-72-6D-F4-64-68-61-73-68-58-20-D1-F8-04-21-26-AF-8C-6B-B6-76-5E-E7-E7-BF-55-08-1B-E2-86-51-FC-35-56-61-9E-85-A9-F0-E4-69-3D-EA-FF
    I	16:29:20.408	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-01-77-00-01-7F-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-1B-A5-79-58-83-51-35-26-AB-76-A8-BB-EE-8D-99-3C-18-42-06-B8-7D-CE-87-5A-41-93-E9-DE-F2-91-19-EF-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-65-69-6D-61-67-65-00-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-59-0F-02-3A-0B-17-97-5A-EC-32-80-02-70-CF-89-8D-2C-31-9A-10-E3-C8-ED-84-2F-AB-29-CD-D6-5F-BB-F7-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-BF-65-69-6D-61-67-65-01-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-D1-F8-04-21-26-AF-8C-6B-B6-76-5E-E7-E7-BF-55-08-1B-E2-86-51-FC-35-56-61-9E-85-A9-F0-E4-69-3D-EA-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
    I	16:29:20.431	[e] Received Header (Op: 3, Flags: 0, Len: 375, Group: 1, Seq: 127, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":0,"slot":1,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    V	16:29:20.453	[i] Test response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"G6V5WINRNSardqi77o2ZPBhCBrh9zodaQZPp3vKRGe8=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false},{"image":0,"slot":1,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false},{"image":1,"slot":1,"version":"0.0.0","hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo=","bootable":true,"pending":true,"confirmed":false,"active":false,"permanent":false}],"splitStatus":0}
    V	16:29:20.469	[j] Moving from state TEST to state RESET
    I	16:29:20.486	[e] Sending (10 bytes) Header (Op: 2, Flags: 0, Len: 2, Group: 0, Seq: 128, Command: 5) CBOR {}
    I	16:29:20.495	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-02-00-00-80-05-BF-FF
    I	16:29:20.533	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-02-00-00-80-05-BF-FF
    I	16:29:20.551	[e] Received Header (Op: 3, Flags: 0, Len: 2, Group: 0, Seq: 128, Command: 5) CBOR {}
    V	16:29:20.570	[g] Reset request success. Waiting for disconnect...
    W	16:29:40.822	[e] Error: (0x8): GATT CONN TIMEOUT
    I	16:29:40.851	[e] Disconnected
    I	16:29:40.878	[g] Device disconnected
    V	16:29:40.895	[g] Waiting remaining 4665 ms for the swap operation to complete
    V	16:29:45.597	[j] Moving from state RESET to state CONFIRM
    I	16:29:49.881	[e] Connected to C1:28:62:08:A0:D8
    I	16:29:50.823	[e] PHY updated (TX: LE 2M, RX: LE 2M)
    I	16:29:51.319	[e] Connection parameters updated (interval: 7.5ms, latency: 0, timeout: 5000ms)
    I	16:29:51.472	[e] Services discovered
    I	16:29:51.530	[e] Connection parameters updated (interval: 45.0ms, latency: 0, timeout: 5000ms)
    I	16:29:51.569	[e] MTU changed to: 498
    I	16:29:51.800	[e] Data written to descr. 00002902-0000-1000-8000-00805f9b34fb, value: (0x) 01-00
    I	16:29:51.830	[e] Notifications enabled
    I	16:29:51.855	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-01-00-00-FF-06-A0
    I	16:29:52.034	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-FF-06-BF-62-72-63-08-FF
    I	16:29:52.064	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 255, Command: 6) CBOR {"rc":8}
    I	16:29:52.096	[e] PHY read (TX: LE 2M, RX: LE 2M)
    I	16:29:52.113	[e] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 0, Command: 0) CBOR {"confirm":true,"hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c="}
    I	16:29:52.119	[e] Sending (10 bytes) Header (Op: 0, Flags: 0, Len: 2, Group: 0, Seq: 1, Command: 6) CBOR {}
    I	16:29:52.182	[e] 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-59-0F-02-3A-0B-17-97-5A-EC-32-80-02-70-CF-89-8D-2C-31-9A-10-E3-C8-ED-84-2F-AB-29-CD-D6-5F-BB-F7-FF
    I	16:29:52.221	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 00-00-00-02-00-00-01-06-BF-FF
    I	16:29:52.357	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-8D-00-01-00-00-BF-66-69-6D-61-67-65-73-9F-BF-65-69-6D-61-67-65-00-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-59-0F-02-3A-0B-17-97-5A-EC-32-80-02-70-CF-89-8D-2C-31-9A-10-E3-C8-ED-84-2F-AB-29-CD-D6-5F-BB-F7-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-FF-6B-73-70-6C-69-74-53-74-61-74-75-73-00-FF
    I	16:29:52.383	[e] Received Header (Op: 3, Flags: 0, Len: 141, Group: 1, Seq: 0, Command: 0) CBOR {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    I	16:29:52.409	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 01-00-00-06-00-00-01-06-BF-62-72-63-08-FF
    V	16:29:52.436	[a] Confirm response: {"images":[{"image":0,"slot":0,"version":"0.0.0","hash":"WQ8COgsXl1rsMoACcM+JjSwxmhDjyO2EL6spzdZfu/c=","bootable":true,"pending":false,"confirmed":true,"active":true,"permanent":false}],"splitStatus":0}
    I	16:29:52.468	[e] Received Header (Op: 1, Flags: 0, Len: 6, Group: 0, Seq: 1, Command: 6) CBOR {"rc":8}
    I	16:29:52.497	[e] Sending (58 bytes) Header (Op: 2, Flags: 0, Len: 50, Group: 1, Seq: 2, Command: 0) CBOR {"confirm":true,"hash":"0fgEISavjGu2dl7n579VCBvihlH8NVZhnoWp8ORpPeo="}
    I	16:29:52.522	[e] Data written to da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 02-00-00-32-00-01-02-00-BF-67-63-6F-6E-66-69-72-6D-F5-64-68-61-73-68-58-20-D1-F8-04-21-26-AF-8C-6B-B6-76-5E-E7-E7-BF-55-08-1B-E2-86-51-FC-35-56-61-9E-85-A9-F0-E4-69-3D-EA-FF
    I	16:29:52.658	[e] Notification received from da2e7828-fbce-4e01-ae9e-261174997c48, value: (0x) 03-00-00-06-00-01-02-00-BF-62-72-63-03-FF
    I	16:29:52.680	[e] Received Header (Op: 3, Flags: 0, Len: 6, Group: 1, Seq: 2, Command: 0) CBOR {"rc":3}
    E	16:29:52.704	Upgrade failed
    Mcu Mgr Error: IN_VALUE (3)
    	at g2.e$b.c(Unknown Source:24)
    	at h2.f.j(Unknown Source:10)
    	at h2.f.a(Unknown Source:0)
    	at h2.d.run(Unknown Source:4)
    	at android.os.Handler.handleCallback(Handler.java:873)
    	at android.os.Handler.dispatchMessage(Handler.java:99)
    	at android.os.Looper.loop(Looper.java:210)
    	at android.os.HandlerThread.run(HandlerThread.java:65)
    
    

    Best regards,

    Jacob

  • Hi Jacob,

    The issue is with selecting "Test & Confirm". For multicore uploads you must use "Confirm Only" instead. This is because the network core does not have a way to swap images, so it can only overwrite the existing one. "Test" assumes swapping, verifying and confirming, but also allows restoring the original, which is not possible on the network core. 

    "Confirm Only" mode is also faster.

    Best regards,

    Marte

Related