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 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 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 asset_tracker: Asset tracker started\x1B[0m\x0D\x0A 2020-04-24T14:26:40.246Z DEBUG modem << [00:00:00.272,735] \x1B[0m 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 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 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 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 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 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 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 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 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 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 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 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 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 asset_tracker: Asset tracker started\x1B[0m\x0D\x0A 2020-04-24T14:34:22.009Z DEBUG modem << [00:00:00.272,674] \x1B[0m 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 asset_tracker: CLOUD_EVT_CONNECTED\x1B[0m\x0D\x0A 2020-04-24T14:44:34.677Z DEBUG modem << [00:10:16.388,732] \x1B[0m asset_tracker: Persistent Sessions = 0\x1B[0m\x0D\x0A 2020-04-24T14:44:34.680Z DEBUG modem << [00:10:16.395,141] \x1B[0m 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 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 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 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 aws_jobs: Publish payload {"clientToken": ""}\x1B[0m\x0D\x0A 2020-04-24T14:44:35.399Z DEBUG modem << [00:10:17.139,068] \x1B[0m 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 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 asset_tracker: CLOUD_EVT_READY\x1B[0m\x0D\x0A 2020-04-24T14:44:37.951Z DEBUG modem << [00:10:19.626,129] \x1B[0m 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 gps_control: GPS initialized\x1B[0m\x0D\x0A 2020-04-24T14:44:37.981Z DEBUG modem << [00:10:19.678,497] \x1B[0m 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 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 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 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 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