modem delta update fails when switching from v1.8.0 to 1.9.1

Hello,

when switching from 1.8.0 to v1.9.1 release unfortunately modem delta update fails. I have also tried with v2.0.2 but without success. I am trying to update the modem fw from mfw_nrf9160_1.3.2 to mfw_nrf9160_update_from_1.3.2_to_1.3.2-FOTA-TEST.bin.

The delta update hangs right after this call

[00:00:05.285,827] <inf> dfu_target_modem_delta: Deleting firmware image, this can take several minutes

Further investigation shows that the code hangs in the while loop of that function

static int delete_banked_modem_delta_fw(void)
{
	int err;
	int offset;
	int timeout = CONFIG_DFU_TARGET_MODEM_TIMEOUT;

	LOG_INF("Deleting firmware image, this can take several minutes");
	err = nrf_modem_delta_dfu_erase();
	if (err != 0) {
		LOG_ERR("Failed to delete backup, error %d", err);
		return -EFAULT;
	}

	while (true) {
		err = nrf_modem_delta_dfu_offset(&offset);
		if (err != 0) {
			if (timeout < 0) {
				callback(DFU_TARGET_EVT_TIMEOUT);
				timeout = CONFIG_DFU_TARGET_MODEM_TIMEOUT;
			}
			if (err != NRF_MODEM_DELTA_DFU_ERASE_PENDING &&
			    err != NRF_MODEM_DELTA_DFU_INVALID_DATA) {
				LOG_ERR("Error during erase, error %d", err);
			}
			k_sleep(K_SECONDS(SLEEP_TIME));
			timeout -= SLEEP_TIME;
		} else {
			callback(DFU_TARGET_EVT_ERASE_DONE);
			LOG_INF("Modem FW delete complete");
			break;
		}
	}

	return 0;
}

Parents Reply Children
  • I have debugged the issue to the point that I am thinking that sending/receive data via lwm2m during a modem delta update causes a large delay of the whole update. I can trigger the behavior in a way that if I do not observe any object that I am using in my (test-)application (and so no data is sent/receive) the modem delta update works (only registration update is sent meanwhile). Once I am observing all resources, the update process is stuck in the loop right after that log line

    [00:00:04.211,212] <inf> dfu_target_modem_delta: Deleting firmware image, this can take several minutes

    and loops over the function

    nrf_modem_delta_dfu_offset

    basically for ever. Whereas if there is basically no data traffic, a modem delta update takes just 2-3 minutes, with traffic I was waiting for 30 minutes without any progress. Do you see any reason for that behavior? Is constant data traffic during a modem delta update not allowed?

  • Hi chmielewskiandreas,

    chmielewskiandreas said:
    I am observing all resources, the update process is stuck in the loop right after that log line

    I am trying to understand this issue and did some experiments with nRF9160: LwM2M Client on Coiote Device Management platform. The FOTA test is using mfw_nrf9160_update_from_1.3.2_to_1.3.2-FOTA-TEST.bin and mfw_nrf9160_update_from_1.3.2-FOTA-TEST_to_1.3.2.bin to switch MFW between 1.3.2 and 1.3.2-FOTA-TEST. The test is using an LTE-M network. It works well by far except I try to enable all observation. I am even not able to enable all resources, because this will drive huge MCU resources and cause many message errors, and the Coiote itself seems to limit the observation requests you can apply. If I enable only /3 Device and /5 Firmware updates that I think will help me to understand the device during FOTA. Everything worked as expected. 

    2022-09-05T14:02:12.284Z DEBUG Application data folder: C:\Users\chs1\AppData\Roaming\nrfconnect\pc-nrfconnect-linkmonitor
    2022-09-05T14:02:12.350Z INFO Using nrf-device-lib-js version: 0.4.11
    2022-09-05T14:02:12.350Z INFO Using nrf-device-lib version: 0.11.8
    2022-09-05T14:02:12.350Z INFO Using nrfjprog DLL version: 10.15.4
    2022-09-05T14:02:12.351Z INFO Using JLink version: JLink_V7.58b
    2022-09-05T14:02:12.371Z DEBUG App pc-nrfconnect-linkmonitor v2.0.1 official
    2022-09-05T14:02:12.371Z DEBUG App path: C:\Users\chs1\.nrfconnect-apps\node_modules\pc-nrfconnect-linkmonitor
    2022-09-05T14:02:12.371Z DEBUG nRFConnect 3.11.1, required by the app is (^3.8.0)
    2022-09-05T14:02:12.371Z DEBUG nRFConnect path: C:\Users\chs1\AppData\Local\Programs\nrfconnect\resources\app.asar
    2022-09-05T14:02:12.372Z DEBUG HomeDir: C:\Users\chs1
    2022-09-05T14:02:12.372Z DEBUG TmpDir: C:\Users\chs1\AppData\Local\Temp
    2022-09-05T14:02:14.765Z INFO Modem port is opened
    2022-09-05T14:02:16.116Z DEBUG modem << *** Booting Zephyr OS build v3.0.99-ncs1-1  ***
    2022-09-05T14:02:16.118Z DEBUG modem << I: Starting bootloader
    2022-09-05T14:02:16.124Z DEBUG modem << I: Primary image: magic=unset, swap_type=0x1, copy_done=0x3, image_ok=0x3
    2022-09-05T14:02:16.140Z DEBUG modem << I: Secondary image: magic=unset, swap_type=0x1, copy_done=0x3, image_ok=0x3
    2022-09-05T14:02:16.142Z DEBUG modem << I: Boot source: none
    2022-09-05T14:02:16.144Z DEBUG modem << I: Swap type: none
    2022-09-05T14:02:16.238Z DEBUG modem << I: Bootloader chainload address offset: 0x10000
    2022-09-05T14:02:16.241Z DEBUG modem << I: Jumping to the first image slot
    2022-09-05T14:02:16.461Z DEBUG modem << *** Booting Zephyr OS build v3.0.99-ncs1-1  ***
    2022-09-05T14:02:16.464Z DEBUG modem << Flash regionsDomainPermissions
    2022-09-05T14:02:16.468Z DEBUG modem << 00 03 0x00000 0x20000 Securerwxl
    2022-09-05T14:02:16.471Z DEBUG modem << 04 31 0x20000 0x100000 Non-Securerwxl
    2022-09-05T14:02:16.477Z DEBUG modem << Non-secure callable region 0 placed in flash region 3 with size 32.
    2022-09-05T14:02:16.529Z DEBUG modem << SRAM regionDomainPermissions
    2022-09-05T14:02:16.532Z DEBUG modem << 00 03 0x00000 0x08000 Securerwxl
    2022-09-05T14:02:16.535Z DEBUG modem << 04 31 0x08000 0x40000 Non-Securerwxl
    2022-09-05T14:02:16.538Z DEBUG modem << PeripheralDomainStatus
    2022-09-05T14:02:16.541Z DEBUG modem << 00 NRF_P0               Non-SecureOK
    2022-09-05T14:02:16.545Z DEBUG modem << 01 NRF_CLOCK            Non-SecureOK
    2022-09-05T14:02:16.549Z DEBUG modem << 02 NRF_RTC0             Non-SecureOK
    2022-09-05T14:02:16.552Z DEBUG modem << 03 NRF_RTC1             Non-SecureOK
    2022-09-05T14:02:16.555Z DEBUG modem << 04 NRF_NVMC             Non-SecureOK
    2022-09-05T14:02:16.558Z DEBUG modem << 05 NRF_UARTE1           Non-SecureOK
    2022-09-05T14:02:16.562Z DEBUG modem << 06 NRF_UARTE2           SecureSKIP
    2022-09-05T14:02:16.569Z DEBUG modem << 07 NRF_TWIM2            Non-SecureOK
    2022-09-05T14:02:16.571Z DEBUG modem << 08 NRF_SPIM3            Non-SecureOK
    2022-09-05T14:02:16.572Z DEBUG modem << 09 NRF_TIMER0           Non-SecureOK
    2022-09-05T14:02:16.575Z DEBUG modem << 10 NRF_TIMER1           Non-SecureOK
    2022-09-05T14:02:16.582Z DEBUG modem << 11 NRF_TIMER2           Non-SecureOK
    2022-09-05T14:02:16.584Z DEBUG modem << 12 NRF_SAADC            Non-SecureOK
    2022-09-05T14:02:16.586Z DEBUG modem << 13 NRF_PWM0             Non-SecureOK
    2022-09-05T14:02:16.589Z DEBUG modem << 14 NRF_PWM1             Non-SecureOK
    2022-09-05T14:02:16.593Z DEBUG modem << 15 NRF_PWM2             Non-SecureOK
    2022-09-05T14:02:16.600Z DEBUG modem << 16 NRF_PWM3             Non-SecureOK
    2022-09-05T14:02:16.601Z DEBUG modem << 17 NRF_WDT              Non-SecureOK
    2022-09-05T14:02:16.603Z DEBUG modem << 18 NRF_IPC              Non-SecureOK
    2022-09-05T14:02:16.607Z DEBUG modem << 19 NRF_VMC              Non-SecureOK
    2022-09-05T14:02:16.610Z DEBUG modem << 20 NRF_FPU              Non-SecureOK
    2022-09-05T14:02:16.616Z DEBUG modem << 21 NRF_EGU0             Non-SecureOK
    2022-09-05T14:02:16.618Z DEBUG modem << 22 NRF_EGU1             Non-SecureOK
    2022-09-05T14:02:16.621Z DEBUG modem << 23 NRF_EGU2             Non-SecureOK
    2022-09-05T14:02:16.623Z DEBUG modem << 24 NRF_EGU3             Non-SecureOK
    2022-09-05T14:02:16.627Z DEBUG modem << 25 NRF_EGU4             Non-SecureOK
    2022-09-05T14:02:16.632Z DEBUG modem << 26 NRF_EGU5             Non-SecureOK
    2022-09-05T14:02:16.634Z DEBUG modem << 27 NRF_DPPIC            Non-SecureOK
    2022-09-05T14:02:16.637Z DEBUG modem << 28 NRF_REGULATORS       Non-SecureOK
    2022-09-05T14:02:16.641Z DEBUG modem << 29 NRF_PDM              Non-SecureOK
    2022-09-05T14:02:16.644Z DEBUG modem << 30 NRF_I2S              Non-SecureOK
    2022-09-05T14:02:16.648Z DEBUG modem << 31 NRF_GPIOTE1          Non-SecureOK
    2022-09-05T14:02:16.651Z DEBUG modem << SPM: NS image at 0x20200
    2022-09-05T14:02:16.653Z DEBUG modem << SPM: NS MSP at 0x200212e0
    2022-09-05T14:02:16.655Z DEBUG modem << SPM: NS reset vector at 0x2f401
    2022-09-05T14:02:16.659Z DEBUG modem << SPM: prepare to jump to Non-Secure image.
    2022-09-05T14:02:16.968Z DEBUG modem << *** Booting Zephyr OS build v3.0.99-ncs1-1  ***
    2022-09-05T14:02:16.973Z DEBUG modem << [m
    2022-09-05T14:02:16.979Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.301,147] [0m<inf> app_lwm2m_client: Run LWM2M client[0m
    2022-09-05T14:02:18.225Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:00.549,774] [0m<inf> app_lwm2m_client: Initializing modem.[0m
    2022-09-05T14:02:18.235Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.564,025] [0m<inf> app_lwm2m_client: endpoint: urn:imei:351358815320657[0m
    2022-09-05T14:02:18.246Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.568,664] [0m<inf> lwm2m_neighbour_cell: Registering ncell notification handler[0m
    2022-09-05T14:02:18.256Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,000] [0m<inf> lwm2m_firmware: Update Counter: current 0, update 0[0m
    2022-09-05T14:02:18.266Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,030] [0m<inf> lwm2m_firmware: Image is not confirmed OK[0m
    2022-09-05T14:02:18.273Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,122] [0m<inf> lwm2m_firmware: Marked image as OK[0m
    2022-09-05T14:02:18.283Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,305] [0m<inf> lwm2m_firmware: Update Counter updated[0m
    2022-09-05T14:02:18.292Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,335] [0m<inf> lwm2m_firmware: Firmware updated successfully[0m
    2022-09-05T14:02:18.301Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,366] [0m<inf> app_lwm2m_client: Connecting to LTE network.[0m
    2022-09-05T14:02:18.311Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:00.569,396] [0m<inf> app_lwm2m_client: This may take several minutes.[0m
    2022-09-05T14:02:20.310Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:02.634,918] [0m<inf> app_lwm2m_client: Connected to LTE network[0m
    2022-09-05T14:02:20.320Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:02.639,892] [0m<inf> lwm2m_connmon: Updating modem data on connmon[0m
    2022-09-05T14:02:20.331Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:02.640,930] [0m<inf> net_lwm2m_rd_client: Start LWM2M Client: urn:imei:351358815320657[0m
    2022-09-05T14:02:20.346Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:03.301,269] [0m<inf> net_lwm2m_rd_client: RD Client started with endpoint 'urn:imei:351358815320657' with client lifetime 30[0m
    2022-09-05T14:02:20.358Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:03.487,213] [0m<inf> lwm2m_security: Need to write credentials, requesting LTE and GNSS offline...[0m
    2022-09-05T14:02:24.595Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:06.918,426] [0m<inf> lwm2m_security: Requesting LTE and GNSS online[0m
    2022-09-05T14:02:26.317Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:08.642,028] [0m<inf> lwm2m_security: Modem connection restored[0m
    2022-09-05T14:02:26.326Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.010,345] [0m<inf> net_lwm2m_engine: Connected, sock id 0[0m
    2022-09-05T14:02:26.336Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.114,196] [0m<dbg> app_lwm2m_client: rd_client_event: Registration complete[0m
    2022-09-05T14:02:26.346Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.114,349] [0m<inf> app_lwm2m_client: Obtained date-time from modem[0m
    2022-09-05T14:02:26.358Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.117,248] [0m<dbg> gnss_module: gnss_event_handler: A-GPS data request not supported.[0m
    2022-09-05T14:02:26.367Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.117,279] [0m<dbg> gnss_module: start_gnss: Started GNSS scan[0m
    2022-09-05T14:02:26.378Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:09.117,309] [0m<inf> net_lwm2m_rd_client: Registration Done (EP='urn:imei:351358815320657')[0m
    2022-09-05T14:02:51.186Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:33.511,688] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:02:51.197Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:33.511,718] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:02:51.205Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:33.511,749] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:03:11.093Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:00:53.419,830] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:03:11.104Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:53.419,860] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:03:11.112Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:00:53.419,891] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:03:33.018Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:15.346,099] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:03:33.032Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:15.346,130] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:03:33.037Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:15.346,160] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:03:45.088Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:27.416,412] [0m<inf> app_lwm2m_gas_res_sensor: Gas resistance: 9126.000000 Ω[0m
    2022-09-05T14:03:45.098Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:27.578,735] [0m<inf> app_lwm2m_temp_sensor: Temperature: 20.502863 °C[0m
    2022-09-05T14:03:45.107Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:27.747,741] [0m<inf> app_lwm2m_humid_sensor: Humidity: 52.074466 %[0m
    2022-09-05T14:03:45.118Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.071,929] [0m<inf> app_lwm2m_accel: Acceleration x-direction: -18.-726589[0m
    2022-09-05T14:03:45.128Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.072,845] [0m<inf> app_lwm2m_accel: Acceleration y-direction: -18.-722173[0m
    2022-09-05T14:03:45.140Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.073,699] [0m<inf> app_lwm2m_accel: Acceleration z-direction: -18.-717749[0m
    2022-09-05T14:03:45.148Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.218,780] [0m<inf> app_lwm2m_press_sensor: Pressure: 98.686731 kPa[0m
    2022-09-05T14:03:45.158Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.376,617] [0m<inf> app_lwm2m_light_sensor: Light value: 0x7944F3FF[0m
    2022-09-05T14:03:45.171Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:28.377,380] [0m<inf> app_lwm2m_light_sensor: Colour value: 0x1502D136[0m
    2022-09-05T14:03:47.491Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:29.821,594] [0m<inf> lwm2m_firmware: Image type 2[0m
    2022-09-05T14:03:47.504Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:29.821,868] [0m<inf> dfu_target_modem_delta: Modem firmware version: 4ccd5f94-3209-4a7b-9062-6b7dc75db31a[0m
    2022-09-05T14:03:47.514Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:29.824,371] [0m<inf> lwm2m_firmware: Modem firmware download started.[0m
    2022-09-05T14:03:47.524Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:29.827,026] [0m<inf> lwm2m_firmware: Skipping bytes 0-452, already written.[0m
    2022-09-05T14:03:47.532Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:29.841,186] [0m<inf> lwm2m_firmware: Downloaded 3%[0m
    2022-09-05T14:03:47.540Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:30.023,956] [0m<inf> lwm2m_firmware: Downloaded 7%[0m
    2022-09-05T14:03:47.548Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:30.174,072] [0m<inf> lwm2m_firmware: Downloaded 11%[0m
    2022-09-05T14:03:47.557Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:30.334,228] [0m<inf> lwm2m_firmware: Downloaded 14%[0m
    2022-09-05T14:03:47.564Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:30.502,227] [0m<inf> lwm2m_firmware: Downloaded 18%[0m
    2022-09-05T14:03:47.573Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:30.653,228] [0m<inf> lwm2m_firmware: Downloaded 22%[0m
    2022-09-05T14:03:48.882Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:31.213,256] [0m<inf> lwm2m_firmware: Downloaded 25%[0m
    2022-09-05T14:03:48.891Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:31.373,260] [0m<inf> lwm2m_firmware: Downloaded 29%[0m
    2022-09-05T14:03:48.899Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:31.574,279] [0m<inf> lwm2m_firmware: Downloaded 33%[0m
    2022-09-05T14:03:48.908Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:31.693,298] [0m<inf> lwm2m_firmware: Downloaded 36%[0m
    2022-09-05T14:03:48.915Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:31.854,309] [0m<inf> lwm2m_firmware: Downloaded 40%[0m
    2022-09-05T14:03:48.925Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.014,312] [0m<inf> lwm2m_firmware: Downloaded 44%[0m
    2022-09-05T14:03:48.931Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.174,316] [0m<inf> lwm2m_firmware: Downloaded 47%[0m
    2022-09-05T14:03:50.004Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:32.334,320] [0m<inf> lwm2m_firmware: Downloaded 51%[0m
    2022-09-05T14:03:50.013Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.493,347] [0m<inf> lwm2m_firmware: Downloaded 55%[0m
    2022-09-05T14:03:50.020Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.681,335] [0m<inf> lwm2m_firmware: Downloaded 59%[0m
    2022-09-05T14:03:50.028Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.831,359] [0m<inf> lwm2m_firmware: Downloaded 62%[0m
    2022-09-05T14:03:50.036Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:32.984,375] [0m<inf> lwm2m_firmware: Downloaded 66%[0m
    2022-09-05T14:03:50.044Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:33.142,364] [0m<inf> lwm2m_firmware: Downloaded 70%[0m
    2022-09-05T14:03:50.052Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:33.302,368] [0m<inf> lwm2m_firmware: Downloaded 73%[0m
    2022-09-05T14:03:51.128Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:33.454,284] [0m<inf> lwm2m_firmware: Downloaded 77%[0m
    2022-09-05T14:03:51.137Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:33.631,408] [0m<inf> lwm2m_firmware: Downloaded 81%[0m
    2022-09-05T14:03:51.146Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:34.262,420] [0m<inf> lwm2m_firmware: Downloaded 84%[0m
    2022-09-05T14:03:52.443Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:34.771,453] [0m<inf> lwm2m_firmware: Downloaded 88%[0m
    2022-09-05T14:03:52.449Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:34.913,482] [0m<inf> lwm2m_firmware: Downloaded 92%[0m
    2022-09-05T14:03:52.457Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:35.391,937] [0m<inf> lwm2m_firmware: Downloaded 95%[0m
    2022-09-05T14:03:52.466Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:35.501,007] [0m<inf> lwm2m_firmware: Downloaded 99%[0m
    2022-09-05T14:03:53.531Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:35.857,086] [0m<inf> dfu_target_modem_delta: Scheduling modem firmware upgrade at next boot[0m
    2022-09-05T14:03:53.540Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:35.857,147] [0m<inf> lwm2m_firmware: Firmware downloaded, 13864 bytes in total[0m
    2022-09-05T14:03:53.550Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:36.372,924] [0m<inf> app_lwm2m_light_sensor: Light value: 0x4FC8FFB0[0m
    2022-09-05T14:03:53.562Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:36.373,687] [0m<inf> app_lwm2m_light_sensor: Colour value: 0xF1FF0CEB[0m
    2022-09-05T14:03:54.701Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:37.029,266] [0m<inf> app_lwm2m_press_sensor: Pressure: 98.905623 kPa[0m
    2022-09-05T14:03:54.710Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.498,931] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:03:54.720Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.498,931] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:03:54.731Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.498,962] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:03:54.739Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.969,299] [0m<inf> app_lwm2m_accel: Acceleration x-direction: -19.-141539[0m
    2022-09-05T14:03:54.749Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.970,214] [0m<inf> app_lwm2m_accel: Acceleration y-direction: -19.-137893[0m
    2022-09-05T14:03:54.763Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:37.971,069] [0m<inf> app_lwm2m_accel: Acceleration z-direction: -19.-134240[0m
    2022-09-05T14:04:17.504Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:01:59.834,655] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:04:17.515Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:59.834,686] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:04:17.523Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:01:59.834,716] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:04:39.563Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:02:21.895,935] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:04:39.574Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:21.895,965] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:04:39.582Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:21.895,996] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    2022-09-05T14:04:54.050Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:02:36.380,981] [0m<inf> app_lwm2m_light_sensor: Light value: 0x3A20FFFF[0m
    2022-09-05T14:04:54.060Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:36.381,744] [0m<inf> app_lwm2m_light_sensor: Colour value: 0x76FFFFFF[0m
    2022-09-05T14:04:54.070Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:37.381,347] [0m<inf> app_lwm2m_press_sensor: Pressure: 97.016725 kPa[0m
    2022-09-05T14:04:55.751Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:02:38.084,808] [1;31m<err> net_lwm2m_engine: Failed to send packet, err 11[0m
    2022-09-05T14:04:55.761Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:38.085,388] [0m<inf> app_lwm2m_accel: Acceleration x-direction: -18.-668603[0m
    2022-09-05T14:04:55.772Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:38.086,303] [0m<inf> app_lwm2m_accel: Acceleration y-direction: -18.-664092[0m
    2022-09-05T14:04:55.782Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:38.087,188] [0m<inf> app_lwm2m_accel: Acceleration z-direction: -18.-659573[0m
    2022-09-05T14:05:01.166Z DEBUG modem << [1;32muart:~$ [m[8D[J[1;32muart:~$ [m[8D[J[00:02:43.500,152] [0m<inf> net_lwm2m_rd_client: Update callback (code:2.4)[0m
    2022-09-05T14:05:01.177Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:43.500,183] [0m<dbg> app_lwm2m_client: rd_client_event: Registration update complete[0m
    2022-09-05T14:05:01.185Z DEBUG modem << [1;32muart:~$ [m[8D[J[00:02:43.500,213] [0m<inf> net_lwm2m_rd_client: Update Done[0m
    

    Let me know if I understand your issue correctly.

    Best regards,

    Charlie

Related