I have my Thingy:91 working now but I can only see "terminal" data in nRF Connect for Cloud. I was expecting to see graphs of the data and a map when I have a GPS fix. The "Cellular Link Monitor" says I should update my firmware but I am on the latest version. What's going on?
When I flash either of those files, te file memory layout looks like this
and the Thingy:91 stops working.
Every working version of the software I have used has a memory layout like this:
When I flash either of those hex files you sent, the modem stops responding to commands. Have you actually tested that firmware yourself on a Thingy:91?
The memory layout looks correct. I have not tested the NB-IoT version as my SIM card does not support it, but it has been confirmed by other developers as well as our customers.
Have you updated the firmware on the nRF52840 on the Thingy:91, as described in the getting started steps here.
If not, you can do this using the nRF Programmer application, just remember to switch SW2 on the board to the nRF52 side.
Hi, thanks for the log! That was very useful. I see you're getting this error code
asset_tracker: cloud_connect failed: -95
which is EOPNOTSUPP 95 /* Operation not supported on transport endpoint */
This is either some issue with your certificates or an error code from the modem, which doesn't translate and just uses EOPNOTSUPP as a catch-all.
I think getting a modem trace will be very useful, see this tutorial for how to do it.
You could also try updating the certificates again, perhaps that is the issue.
Best regards,
Heidi
Hi
I didn't have time to look at this again until today. When I query the certificates, I get the screenshot below. Does this look wrong to you? If not, what should it look like.
Hi, this looks fine and it tells us that the nRF Cloud certificates have not been erased, so the problem isn't your certificates. Again, a modem trace will help us find the root cause.
I have tried to follow the tutorial to get a modem trace but it seems to be written for the nRF9160 development kit and Step 2 in particular doesn't seem to make sense for the Thingy:91. The result was that I got no trace. Also, the tutorial doesn't explain how you would collect a modem trace when running the Thingy:91 demo application. It only covers running the demo AT client as far as I understand it.
Hi!
You're right, step 2 is different for the Thingy:91, you should flash the Connectivity Bridge to the nRF52840.
The tutorial uses the AT Client sample as an example but you can get a trace from the Asset Tracker sample as well.
Flash the AT Client sample first and send AT%XMODEMTRACE=1,2 and AT+CFUN=0 to save.
Then add the CONFIG_BSD_LIBRARY_TRACE_ENABLED=y configuration to the application you want to take a trace with and flash it to the device.
Best regards,
Heidi
Hi!
You're right, step 2 is different for the Thingy:91, you should flash the Connectivity Bridge to the nRF52840.
The tutorial uses the AT Client sample as an example but you can get a trace from the Asset Tracker sample as well.
Flash the AT Client sample first and send AT%XMODEMTRACE=1,2 and AT+CFUN=0 to save.
Then add the CONFIG_BSD_LIBRARY_TRACE_ENABLED=y configuration to the application you want to take a trace with and flash it to the device.
Best regards,
Heidi
Hi
Is it possible to send me a pre-compiled version of the Connectivity Bridge for the Thingy:91?
Looking at the instructions, it seems I would have to install a huge toolchain just to compile it.It sounds simple - "send us a modem trace", but achieving this has already taken hours of my time. I am only trying to run the demo asset tracker application.
Steve
I completely understand, here you go. Make sure to set SW2 to the nRF52 position when flashing.
I also attached a newly built copy of the asset_tracker sample from the master branch of NCS with support for NB-IoT (not legacy) and the trace config enabled in case you wanted to try getting a modem trace again.
I understand the process might be hard, but it's difficult for me to understand what the issue might be without it.
thingy91_connectivity_bridge.hex
thingy91_asset_tracker_nbiot_2704.hex
Best regards,
Heidi
Thanks.
I have flashed the connectivity bridge to the nRF52 and your asset_tracker sample to the nRF91. I also made sure that the November 2019 versions of the modem firmware and the UART bridge were installed.
This does not seem to connect to anything and the asset_tracker application doesn't find the Vodafone network that I had connected to previously. I got some sort of modem trace but I suspect it won't be much help because the size stopped growing fairly quickly. This is attached in case it's useful.
The tutorial on getting the modem trace that you linked to previously has mysteriously disappeared ("Unfortunately, the page you've requested no longer exists.") so I couldn't check if I followed all the steps properly.
Steve
Hi, I updated the modem trace link. It seems they moved the blog post to another page on DevZone.
Your trace was unfortunately empty.
From the screenshot in LTE Link Monitor, I see you're getting registration status 5 from +CEREG, i.e Registered, roaming. So, the device is connecting to a network.
Do you have a log file with the full debug output from the app?
Yep. Attached.
2020-04-24T14:26:14.762Z INFO Application data folder: C:\Users\steph\AppData\Roaming\nrfconnect\pc-nrfconnect-linkmonitor
2020-04-24T14:26:14.953Z DEBUG App pc-nrfconnect-linkmonitor v1.1.1 official
2020-04-24T14:26:14.954Z DEBUG App path: C:\Users\steph\.nrfconnect-apps\node_modules\pc-nrfconnect-linkmonitor
2020-04-24T14:26:14.954Z DEBUG nRFConnect 3.3.0 is supported by the app (^3.2.0)
2020-04-24T14:26:14.954Z DEBUG nRFConnect path: C:\Users\steph\AppData\Local\Programs\nrfconnect\resources\app.asar
2020-04-24T14:26:14.954Z DEBUG HomeDir: C:\Users\steph
2020-04-24T14:26:14.955Z DEBUG TmpDir: C:\Users\steph\AppData\Local\Temp
2020-04-24T14:26:20.279Z INFO Modem port is opened
2020-04-24T14:26:39.975Z INFO Modem port is opened
2020-04-24T14:26:39.985Z DEBUG modem << Non-secure callable region 0 placed in flash region 2 with size 32.\x0D\x0A\x0D\x0A
2020-04-24T14:26:39.998Z DEBUG modem << SRAM region\x09\x09Domain\x09\x09Permissions\x0D\x0A
2020-04-24T14:26:40.008Z DEBUG modem << 00 07 0x00000 0x10000 \x09Secure\x09\x09rwxl\x0D\x0A
2020-04-24T14:26:40.012Z DEBUG modem << 08 31 0x10000 0x40000 \x09Non-Secure\x09rwxl\x0D\x0A\x0D\x0A
2020-04-24T14:26:40.016Z DEBUG modem << Peripheral\x09\x09Domain\x09\x09Status\x0D\x0A
2020-04-24T14:26:40.020Z DEBUG modem << 00 NRF_P0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.024Z DEBUG modem << 01 NRF_CLOCK Non-Secure\x09OK\x0D
2020-04-24T14:26:40.111Z DEBUG modem << 02 NRF_RTC0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.115Z DEBUG modem << 03 NRF_RTC1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.122Z DEBUG modem << 04 NRF_NVMC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.128Z DEBUG modem << 05 NRF_UARTE1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.132Z DEBUG modem << 06 NRF_UARTE2 Secure\x09\x09SKIP\x0D\x0A
2020-04-24T14:26:40.137Z DEBUG modem << 07 NRF_TWIM2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.143Z DEBUG modem << 08 NRF_SPIM3 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.147Z DEBUG modem << 09 NRF_TIMER0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.153Z DEBUG modem << 10 NRF_TIMER1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.156Z DEBUG modem << 11 NRF_TIMER2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.160Z DEBUG modem << 12 NRF_SAADC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.163Z DEBUG modem << 13 NRF_PWM0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.167Z DEBUG modem << 14 NRF_PWM1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.173Z DEBUG modem << 15 NRF_PWM2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.184Z DEBUG modem << 16 NRF_PWM3 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.187Z DEBUG modem << 17 NRF_WDT Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.190Z DEBUG modem << 18 NRF_IPC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.193Z DEBUG modem << 19 NRF_VMC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.196Z DEBUG modem << 20 NRF_FPU Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.200Z DEBUG modem << 21 NRF_EGU1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.203Z DEBUG modem << 22 NRF_EGU2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.207Z DEBUG modem << 23 NRF_DPPIC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.210Z DEBUG modem << 24 NRF_GPIOTE1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:26:40.216Z DEBUG modem << 25 NRF_REGULATORS Non-Secure\x09OK\x0D\x0A\x0D\x0A
2020-04-24T14:26:40.222Z DEBUG modem << SPM: NS image at 0x18200\x0D\x0A
2020-04-24T14:26:40.226Z DEBUG modem << SPM: NS MSP at 0x2002eee0\x0D\x0A
2020-04-24T14:26:40.229Z DEBUG modem << SPM: NS reset vector at 0x203bd\x0D\x0A
2020-04-24T14:26:40.232Z DEBUG modem << SPM: prepare to jump to Non-Secure image.\x0D\x0A
2020-04-24T14:26:40.235Z DEBUG modem << *** Booting Zephyr OS build v2.1.99[00:00:00.203,521] \x1B[0m<inf> BH1749: BH1749 initialized\x1B[0m\x0D\x0A
2020-04-24T14:26:40.238Z DEBUG modem << -ncs1-1145-g13dc96f83bab ***\x0D\x0A
2020-04-24T14:26:40.241Z DEBUG modem << [00:00:00.218,048] \x1B[0m<inf> at_host: UART check failed: 12. Dropping buffer and retrying.\x1B[0m\x0D\x0A
2020-04-24T14:26:40.243Z DEBUG modem << [00:00:00.259,399] \x1B[0m<inf> asset_tracker: Asset tracker started\x1B[0m\x0D\x0A
2020-04-24T14:26:40.246Z DEBUG modem << [00:00:00.272,735] \x1B[0m<dbg> nrf_cloud_transport.nct_client_id_get: client_id = nrf-352656100827982\x1B[0m\x0D\x0A
2020-04-24T14:26:40.249Z DEBUG modem << [00:00:00.281,951] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_base_topic: $aws/things/nrf-352656100827982/shadow\x1B[0m\x0D\x0A
2020-04-24T14:26:40.252Z DEBUG modem << [00:00:00.293,609] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: accepted_topic: nrf-352656100827982/shadow/get/accepted\x1B[0m\x0D\x0A
2020-04-24T14:26:40.255Z DEBUG modem << [00:00:00.305,114] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: rejected_topic: $aws/things/nrf-352656100827982/shadow/get/rejected\x1B[0m\x0D\x0A
2020-04-24T14:26:40.258Z DEBUG modem << [00:00:00.317,687] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: update_delta_topic: $aws/things/nrf-352656100827982/shadow/update/delta\x1B[0m\x0D\x0A
2020-04-24T14:26:40.261Z DEBUG modem << [00:00:00.330,596] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: update_topic: $aws/things/nrf-352656100827982/shadow/update\x1B[0m\x0D\x0A
2020-04-24T14:26:40.264Z DEBUG modem << [00:00:00.342,437] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_get_topic: $aws/things/nrf-352656100827982/shadow/get\x1B[0m\x0D\x0A
2020-04-24T14:26:40.268Z DEBUG modem << [00:00:00.354,583] \x1B[0m<inf> asset_tracker: Connecting to LTE network. \x1B[0m\x0D\x0A
2020-04-24T14:26:40.274Z DEBUG modem << [00:00:00.361,358] \x1B[0m<inf> asset_tracker: This may take several minutes.\x1B[0m\x0D\x0A
2020-04-24T14:26:40.277Z DEBUG modem << [00:00:00.376,800] \x1B[0m<dbg> lte_lc.w_lte_lc_connect: Network mode: AT%XSYSTEMMODE=1,0,1,0\x1B[0m\x0D\x0A
2020-04-24T14:27:23.362Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"\x0D\x0A
2020-04-24T14:27:23.503Z DEBUG modem << [00:00:46.143,981] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 2\x1B[0m\x0D\x0A
2020-04-24T14:27:23.575Z DEBUG modem >> AT+COPS=?\x0D\x0A
2020-04-24T14:28:23.574Z ERROR Network search failed: Error: 'AT+COPS=?
' timed out
2020-04-24T14:29:42.190Z DEBUG modem << +COPS: \x0D\x0A
2020-04-24T14:29:42.200Z DEBUG modem << OK\x0D\x0A
2020-04-24T14:34:21.810Z INFO Modem port is opened
2020-04-24T14:34:21.814Z DEBUG modem << Non-secure callable region 0 placed in flash region 2 with size 32.\x0D\x0A\x0D\x0A
2020-04-24T14:34:21.817Z DEBUG modem << SRAM region\x09\x09Domain\x09\x09Permissions\x0D\x0A
2020-04-24T14:34:21.821Z DEBUG modem << 00 07 0x00000 0x10000 \x09Secure\x09\x09rwxl\x0D\x0A
2020-04-24T14:34:21.824Z DEBUG modem << 08 31 0x10000 0x40000 \x09Non-Secure\x09rwxl\x0D\x0A\x0D
2020-04-24T14:34:21.852Z DEBUG modem << Peripheral\x09\x09Domain\x09\x09Status\x0D\x0A
2020-04-24T14:34:21.856Z DEBUG modem << 00 NRF_P0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.860Z DEBUG modem << 01 NRF_CLOCK Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.863Z DEBUG modem << 02 NRF_RTC0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.866Z DEBUG modem << 03 NRF_RTC1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.869Z DEBUG modem << 04 NRF_NVMC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.873Z DEBUG modem << 05 NRF_UARTE1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.876Z DEBUG modem << 06 NRF_UARTE2 Secure\x09\x09SKIP\x0D\x0A
2020-04-24T14:34:21.879Z DEBUG modem << 07 NRF_TWIM2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.882Z DEBUG modem << 08 NRF_SPIM3 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.885Z DEBUG modem << 09 NRF_TIMER0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.889Z DEBUG modem << 10 NRF_TIMER1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.894Z DEBUG modem << 11 NRF_TIMER2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.897Z DEBUG modem << 12 NRF_SAADC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.905Z DEBUG modem << 13 NRF_PWM0 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.908Z DEBUG modem << 14 NRF_PWM1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.910Z DEBUG modem << 15 NRF_PWM2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.913Z DEBUG modem << 16 NRF_PWM3 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.916Z DEBUG modem << 17 NRF_WDT Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.919Z DEBUG modem << 18 NRF_IPC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.923Z DEBUG modem << 19 NRF_VMC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.926Z DEBUG modem << 20 NRF_FPU Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.932Z DEBUG modem << 21 NRF_EGU1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.941Z DEBUG modem << 22 NRF_EGU2 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.945Z DEBUG modem << 23 NRF_DPPIC Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.948Z DEBUG modem << 24 NRF_GPIOTE1 Non-Secure\x09OK\x0D\x0A
2020-04-24T14:34:21.952Z DEBUG modem << 25 NRF_REGULATORS Non-Secure\x09OK\x0D\x0A\x0D\x0A
2020-04-24T14:34:21.956Z DEBUG modem << SPM: NS image at 0x18200\x0D\x0A
2020-04-24T14:34:21.959Z DEBUG modem << SPM: NS MSP at 0x2002eee0\x0D\x0A
2020-04-24T14:34:21.961Z DEBUG modem << SPM: NS reset vector at 0x203bd\x0D\x0A
2020-04-24T14:34:21.964Z DEBUG modem << SPM: prepare to jump to Non-Secure image.\x0D\x0A
2020-04-24T14:34:21.966Z DEBUG modem << *** Booting Zephyr OS build v2.1.99[00:00:00.203,460] \x1B[0m<inf> BH1749: BH1749 initialized\x1B[0m\x0D\x0A
2020-04-24T14:34:21.972Z DEBUG modem << -ncs1-1145-g13dc96f83bab ***\x0D
2020-04-24T14:34:22.005Z DEBUG modem << [00:00:00.217,987] \x1B[0m<inf> at_host: UART check failed: 12. Dropping buffer and retrying.\x1B[0m\x0D\x0A
2020-04-24T14:34:22.007Z DEBUG modem << [00:00:00.259,338] \x1B[0m<inf> asset_tracker: Asset tracker started\x1B[0m\x0D\x0A
2020-04-24T14:34:22.009Z DEBUG modem << [00:00:00.272,674] \x1B[0m<dbg> nrf_cloud_transport.nct_client_id_get: client_id = nrf-352656100827982\x1B[0m\x0D\x0A
2020-04-24T14:34:22.014Z DEBUG modem << [00:00:00.281,890] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_base_topic: $aws/things/nrf-352656100827982/shadow\x1B[0m\x0D\x0A
2020-04-24T14:34:22.017Z DEBUG modem << [00:00:00.293,548] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: accepted_topic: nrf-352656100827982/shadow/get/accepted\x1B[0m\x0D\x0A
2020-04-24T14:34:22.020Z DEBUG modem << [00:00:00.305,084] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: rejected_topic: $aws/things/nrf-352656100827982/shadow/get/rejected\x1B[0m\x0D\x0A
2020-04-24T14:34:22.024Z DEBUG modem << [00:00:00.317,657] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: update_delta_topic: $aws/things/nrf-352656100827982/shadow/update/delta\x1B[0m\x0D\x0A
2020-04-24T14:34:22.027Z DEBUG modem << [00:00:00.330,566] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: update_topic: $aws/things/nrf-352656100827982/shadow/update\x1B[0m\x0D\x0A
2020-04-24T14:34:22.029Z DEBUG modem << [00:00:00.342,437] \x1B[0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_get_topic: $aws/things/nrf-352656100827982/shadow/get\x1B[0m\x0D\x0A
2020-04-24T14:34:22.034Z DEBUG modem << [00:00:00.354,553] \x1B[0m<inf> asset_tracker: Connecting to LTE network. \x1B[0m\x0D\x0A
2020-04-24T14:34:22.038Z DEBUG modem << [00:00:00.361,328] \x1B[0m<inf> asset_tracker: This may take several minutes.\x1B[0m\x0D\x0A
2020-04-24T14:34:22.042Z DEBUG modem << [00:00:00.376,770] \x1B[0m<dbg> lte_lc.w_lte_lc_connect: Network mode: AT%XSYSTEMMODE=1,0,1,0\x1B[0m\x0D\x0A
2020-04-24T14:35:04.321Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"\x0D\x0A
2020-04-24T14:35:04.389Z DEBUG modem << [00:00:46.045,471] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 2\x1B[0m\x0D\x0A
2020-04-24T14:44:18.682Z DEBUG modem << [00:10:00.424,591] \x1B[0m<inf> lte_lc: Network connection attempt timed out\x1B[0m\x0D\x0A
2020-04-24T14:44:18.691Z DEBUG modem << +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"\x0D\x0A
2020-04-24T14:44:18.727Z DEBUG modem << [00:10:00.442,169] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 0\x1B[0m\x0D\x0A
2020-04-24T14:44:18.730Z DEBUG modem << [00:10:00.450,469] \x1B[0m<inf> lte_lc: Using fallback network mode\x1B[0m\x0D\x0A
2020-04-24T14:44:18.735Z DEBUG modem << [00:10:00.456,604] \x1B[0m<dbg> lte_lc.w_lte_lc_connect: Network mode: AT%XSYSTEMMODE=0,1,1,0\x1B[0m\x0D\x0A
2020-04-24T14:44:19.254Z DEBUG modem << +CEREG: 0,"33F6","001F3615",9,0,0,"11100000","11100000"\x0D\x0A
2020-04-24T14:44:19.322Z DEBUG modem << [00:10:01.002,349] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 0\x1B[0m\x0D\x0A
2020-04-24T14:44:19.663Z DEBUG modem << +CEREG: 2,"33F6","001F3615",9,0,0,"11100000","11100000"\x0D\x0A
2020-04-24T14:44:19.728Z DEBUG modem << [00:10:01.412,078] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 2\x1B[0m\x0D\x0A
2020-04-24T14:44:25.375Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:44:25.411Z DEBUG modem << [00:10:07.123,382] \x1B[0m<dbg> lte_lc.parse_nw_reg_status: Network registration status: 5\x1B[0m\x0D\x0A
2020-04-24T14:44:25.414Z DEBUG modem << [00:10:07.131,713] \x1B[0m<inf> asset_tracker: Connected to LTE network\x1B[0m\x0D\x0A
2020-04-24T14:44:25.652Z DEBUG modem << [00:10:07.392,333] \x1B[0m<dbg> nrf_cloud_transport.nct_connect: IPv4 Address 0x165fca22\x1B[0m\x0D\x0A
2020-04-24T14:44:25.693Z DEBUG modem << [00:10:07.400,360] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_connect: mqtt_connect requesting persistent session\x1B[0m\x0D\x0A
2020-04-24T14:44:34.598Z DEBUG modem << [00:10:16.338,928] \x1B[0m<inf> aws_jobs: Subscribe: $aws/things/nrf-352656100827982/jobs/notify-next\x1B[0m\x0D\x0A
2020-04-24T14:44:34.646Z DEBUG modem << [00:10:16.348,907] \x1B[0m<inf> aws_jobs: Subscribe: $aws/things/nrf-352656100827982/jobs/$next/get/#\x1B[0m\x0D\x0A
2020-04-24T14:44:34.659Z DEBUG modem << [00:10:16.358,673] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_CONNACK\x1B[0m\x0D\x0A
2020-04-24T14:44:34.664Z DEBUG modem << [00:10:16.366,821] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 2\x1B[0m\x0D\x0A
2020-04-24T14:44:34.671Z DEBUG modem << [00:10:16.374,511] \x1B[0m<dbg> nrf_cloud.event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTED\x1B[0m\x0D\x0A
2020-04-24T14:44:34.674Z DEBUG modem << [00:10:16.382,659] \x1B[0m<inf> asset_tracker: CLOUD_EVT_CONNECTED\x1B[0m\x0D\x0A
2020-04-24T14:44:34.677Z DEBUG modem << [00:10:16.388,732] \x1B[0m<inf> asset_tracker: Persistent Sessions = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:34.680Z DEBUG modem << [00:10:16.395,141] \x1B[0m<dbg> nrf_cloud_transport.nct_cc_connect: nct_cc_connect\x1B[0m\x0D\x0A
2020-04-24T14:44:34.687Z DEBUG modem << [00:10:16.403,442] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 3\x1B[0m\x0D\x0A
2020-04-24T14:44:35.121Z DEBUG modem << [00:10:16.864,837] \x1B[0m<inf> aws_fota: subscribed to notify-next topic\x1B[0m\x0D\x0A
2020-04-24T14:44:35.171Z DEBUG modem << [00:10:16.871,643] \x1B[0m<inf> aws_jobs: Publish topic: $aws/things/nrf-352656100827982/jobs/$next/get\x1B[0m\x0D
2020-04-24T14:44:35.181Z DEBUG modem << [00:10:16.880,889] \x1B[0m<inf> aws_jobs: Publish payload {"clientToken": ""}\x1B[0m\x0D\x0A
2020-04-24T14:44:35.399Z DEBUG modem << [00:10:17.139,068] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 2114 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:35.484Z DEBUG modem << [00:10:17.224,853] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 1234 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:35.493Z DEBUG modem << [00:10:17.234,832] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 4\x1B[0m\x0D\x0A
2020-04-24T14:44:35.518Z DEBUG modem << [00:10:17.242,523] \x1B[0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 5678 opcode = 0 len = 0\x1B[0m\x0D
2020-04-24T14:44:35.541Z DEBUG modem << [00:10:17.252,960] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 5\x1B[0m\x0D\x0A
2020-04-24T14:44:35.861Z DEBUG modem << [00:10:17.601,806] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 29096 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:35.898Z DEBUG modem << [00:10:17.612,182] \x1B[0m<dbg> aws_fota.on_publish_evt: Received topic: $aws/things/nrf-352656100827982/jobs/$next/get/accepted\x1B[0m\x0D\x0A
2020-04-24T14:44:35.902Z DEBUG modem << [00:10:17.623,596] \x1B[0m<inf> aws_fota: Checking for an available job\x1B[0m\x0D\x0A
2020-04-24T14:44:35.906Z DEBUG modem << [00:10:17.630,157] \x1B[0m<dbg> aws_fota.get_job_execution: Job doc: {"clientToken":"","timestamp":1587739476}\x1B[0m\x0D\x0A
2020-04-24T14:44:35.910Z DEBUG modem << [00:10:17.640,289] \x1B[0m<dbg> aws_fota.get_job_execution: Got only one field\x1B[0m\x0D\x0A
2020-04-24T14:44:35.936Z DEBUG modem << [00:10:17.647,399] \x1B[0m<inf> aws_fota: No queued jobs for this device\x1B[0m\x0D\x0A
2020-04-24T14:44:36.108Z DEBUG modem << [00:10:17.849,029] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 5678 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:36.160Z DEBUG modem << [00:10:17.859,039] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 5\x1B[0m\x0D\x0A
2020-04-24T14:44:36.405Z DEBUG modem << [00:10:18.145,202] \x1B[0m<dbg> aws_fota.on_publish_evt: Received topic: nrf-352656100827982/shadow/get/accepted\x1B[0m\x0D\x0A
2020-04-24T14:44:36.464Z DEBUG modem << [00:10:18.155,273] \x1B[0m<dbg> aws_fota.on_publish_evt: received an unhandled MQTT publish event on topic: nrf-352656100827982/shadow/get/accepted\x1B[0m\x0D\x0A
2020-04-24T14:44:36.477Z DEBUG modem << [00:10:18.168,365] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 15012 len = 283\x1B[0m\x0D\x0A
2020-04-24T14:44:36.487Z DEBUG modem << [00:10:18.180,206] \x1B[0m<dbg> nrf_cloud_transport.nct_dc_endpoint_set: nct_dc_endpoint_set\x1B[0m\x0D\x0A
2020-04-24T14:44:36.490Z DEBUG modem << [00:10:18.188,659] \x1B[0m<dbg> nrf_cloud_transport.nct_dc_endpoint_get: nct_dc_endpoint_get\x1B[0m\x0D\x0A
2020-04-24T14:44:36.493Z DEBUG modem << [00:10:18.197,845] \x1B[0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 7890 opcode = 1 len = 329\x1B[0m\x0D\x0A
2020-04-24T14:44:36.520Z DEBUG modem << [00:10:18.209,472] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 7\x1B[0m\x0D\x0A
2020-04-24T14:44:36.529Z DEBUG modem << [00:10:18.217,163] \x1B[0m<dbg> nrf_cloud.event_handler: NRF_CLOUD_EVT_USER_ASSOCIATED\x1B[0m\x0D\x0A
2020-04-24T14:44:36.532Z DEBUG modem << [00:10:18.224,945] \x1B[0m<inf> asset_tracker: CLOUD_EVT_PAIR_DONE\x1B[0m\x0D\x0A
2020-04-24T14:44:37.376Z DEBUG modem << [00:10:19.116,912] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 7890 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:37.423Z DEBUG modem << [00:10:19.126,922] \x1B[0m<dbg> nrf_cloud_transport.nct_dc_connect: nct_dc_connect\x1B[0m\x0D\x0A
2020-04-24T14:44:37.446Z DEBUG modem << [00:10:19.135,284] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 8\x1B[0m\x0D\x0A
2020-04-24T14:44:37.853Z DEBUG modem << [00:10:19.592,956] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 8765 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:37.910Z DEBUG modem << [00:10:19.602,905] \x1B[0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 9\x1B[0m\x0D\x0A
2020-04-24T14:44:37.945Z DEBUG modem << [00:10:19.610,595] \x1B[0m<dbg> nrf_cloud.event_handler: NRF_CLOUD_EVT_READY\x1B[0m\x0D\x0A
2020-04-24T14:44:37.948Z DEBUG modem << [00:10:19.617,523] \x1B[0m<inf> asset_tracker: CLOUD_EVT_READY\x1B[0m\x0D\x0A
2020-04-24T14:44:37.951Z DEBUG modem << [00:10:19.626,129] \x1B[0m<dbg> nrf9160_gps.init: GPS socket created, fd: 1232491587\x1B[0m\x0D\x0A
2020-04-24T14:44:37.954Z DEBUG modem << [00:10:19.633,758] \x1B[0m<inf> gps_control: GPS initialized\x1B[0m\x0D\x0A
2020-04-24T14:44:37.981Z DEBUG modem << [00:10:19.678,497] \x1B[0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 1 opcode = 1 len = 627\x1B[0m\x0D\x0A
2020-04-24T14:44:37.988Z DEBUG modem << [00:10:19.690,551] \x1B[0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 2 opcode = 1 len = 58\x1B[0m\x0D\x0A
2020-04-24T14:44:38.768Z DEBUG modem << [00:10:20.507,965] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 1 result = 0\x1B[0m\x0D\x0A
2020-04-24T14:44:38.825Z DEBUG modem << [00:10:20.566,894] \x1B[0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 2 result = 0\x1B[0m\x0D
2020-04-24T14:45:09.907Z DEBUG modem << %CESQ: 43,2,24,3\x0D\x0A
2020-04-24T14:46:24.943Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:46:32.373Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:46:57.967Z DEBUG modem << %CESQ: 43,2,19,2\x0D\x0A
2020-04-24T14:47:05.105Z DEBUG modem << %CESQ: 43,2,24,3\x0D\x0A
2020-04-24T14:51:27.018Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:51:34.449Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:52:58.380Z DEBUG modem << %CESQ: 43,2,19,2\x0D
2020-04-24T14:53:08.086Z DEBUG modem >> AT+COPS=?\x0D\x0A
2020-04-24T14:54:07.501Z DEBUG modem << %CESQ: 43,2,24,3\x0D\x0A
2020-04-24T14:54:40.779Z DEBUG modem << %CESQ: 43,2,17,2\x0D\x0A
2020-04-24T14:55:03.819Z DEBUG modem << %CESQ: 43,2,23,3\x0D\x0A
2020-04-24T14:56:33.418Z DEBUG modem << %CESQ: 43,2,17,2\x0D\x0A
2020-04-24T14:56:35.978Z DEBUG modem << %CESQ: 43,2,22,3\x0D\x0A
2020-04-24T14:57:39.977Z DEBUG modem << %CESQ: 43,2,17,2\x0D\x0A
2020-04-24T14:57:42.537Z DEBUG modem << %CESQ: 43,2,22,3\x0D\x0A
2020-04-24T14:57:56.207Z DEBUG modem << [00:23:37.983,032] \x1B[1;31m<err> at_host: Error while processing AT command: -8\x1B[0m\x0D\x0A
2020-04-24T14:57:56.269Z DEBUG modem << ERROR\x0D\x0A
2020-04-24T14:57:56.279Z ERROR Network search failed: Error: AT+COPS=?
failed
2020-04-24T14:59:28.293Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:59:35.722Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T14:59:59.012Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:00:01.322Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:00:04.132Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:00:06.442Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:00:09.251Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:00:57.641Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:03:28.929Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:03:31.239Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:06:58.846Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:07:01.156Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:09:27.324Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:09:29.634Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:11:55.803Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:11:58.112Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:12:00.922Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:12:03.228Z DEBUG modem << %CESQ: 43,2,17,2\x0D\x0A
2020-04-24T15:12:03.312Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:12:06.042Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:12:13.473Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:12:30.846Z DEBUG modem << %CESQ: 43,2,22,3\x0D\x0A
2020-04-24T15:16:57.879Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:17:00.189Z DEBUG modem << +CEREG: 5,"33F6","001F3615",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:18:30.038Z DEBUG modem << +CEREG: 5,"33EF","0002071F",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:18:35.351Z DEBUG modem << %CESQ: 36,1,15,2\x0D\x0A
2020-04-24T15:18:35.429Z DEBUG modem << +CEREG: 5,"33EF","00020715",9,,,"11100000","00101000"\x0D\x0A
2020-04-24T15:18:58.517Z INFO Modem port is closed