Unable to connect to Cloud using Asset Tracker on nRF9160 DK

[AlbertSerica]

Hello, I am currently learning to use nRF9160 DK in Guangzhou, China. 

It is weird that my China Mobile cellphone SIM card can be used on this DK to connect to Cloud. However, iBasics SIM and China Telecom NBIOT SIM cannot connect to Cloud. 

While using iBasics, it's LED3 that keeps blinking. While using China Telecom, LED3 blinks first, then LED4 blinks, LED1 and LED4 blinks at last.

The following is from nRF Connect during the entire session for China Telecom

+CSCON: 1

 

 

[00:00:08.419,586]

[0m<inf> asset_tracker: RRC mode: Connected

[0m

 

 

+CEREG: 1,"765E","075D6450",9,,,"11100000","00111000"

 

 

[00:00:10.095,031]

[0m<inf> asset_tracker: Connected to LTE network.

[0m

 

 

[00:00:10.101,623]

[0m<inf> asset_tracker: Connecting to cloud, attempt 1 of 8

[0m

 

 

[00:00:10.109,039]

[0m<inf> asset_tracker: Cloud connection request sent.

[0m

 

 

[00:00:10.115,966]

[0m<inf> asset_tracker: Connection response timeout is set to 30 seconds.

[0m

 

 

[00:00:10.124,664]

[0m<inf> asset_tracker: Network registration status: Connected - home network

[0m

 

 

[00:00:10.133,544]

[0m<inf> asset_tracker: PSM parameter update: TAU: 86400, Active time: -1

[0m

 

[00:00:10.142,242]

[0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING

[0m

 

 

[00:00:10.150,695]

[0m<inf> asset_tracker: CLOUD_EVT_CONNECTING

[0m

 

 

[00:00:20.343,505]

[0m<dbg> nrf_cloud_transport.nct_connect: IPv4 address: 54.166.31.114

[0m

 

 

[00:00:20.351,715]

[0m<dbg> nrf_cloud_transport.nct_mqtt_connect: MQTT clean session flag: 0

[0m

 

 

[00:00:25.044,555]

[1;33m<wrn> date_time: sntp_query, error: -116

[0m

 

 

[00:00:32.817,443]

[1;33m<wrn> date_time: sntp_query, error: -116

[0m

 

 

[00:00:38.944,549]

[1;33m<wrn> date_time: sntp_query, error: -116

[0m

 

[00:00:44.977,661]

[1;33m<wrn> date_time: sntp_query, error: -116

[0m

 

 

[00:00:51.057,739]

[1;33m<wrn> date_time: sntp_query, error: -116

[0m

 

 

[00:00:51.064,270]

[1;33m<wrn> date_time: Not getting time from any NTP server

[0m

 

 

[00:00:51.072,357]

[0m<inf> asset_tracker: DATE_TIME_OBTAINED_MODEM

[0m

 

 

+CSCON: 0

 

 

[00:01:16.166,137]

[0m<inf> asset_tracker: RRC mode: Idle

[0m

 

 

+CSCON: 1

 

 

[00:01:21.380,767]

[0m<inf> asset_tracker: RRC mode: Connected

[0m

 

 

+CSCON: 0

 

 

[00:01:43.162,567]

[0m<inf> asset_tracker: RRC mode: Idle

[0m

 

 

+CSCON: 1

 

 

[00:02:13.541,534]

[0m<inf> asset_tracker: RRC mode: Connected

[0m

 

 

+CSCON: 0

 

 

[00:02:35.173,370]

[0m<inf> asset_tracker: RRC mode: Idle

[0m

 

 

[00:03:00.723,693]

[0m<dbg> nrf_cloud_transport.nct_mqtt_connect: mqtt_connect failed -22

[0m

 

 

[00:03:00.732,025]

[0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING

[0m

 

 

[00:03:00.740,509]

[0m<inf> asset_tracker: CLOUD_EVT_CONNECTING

[0m

 

 

[00:03:00.746,582]

[1;31m<err> asset_tracker: Failed to connect to cloud, error -7

[0m

 

 

[00:03:00.754,333]

[1;31m<err> asset_tracker: Ensure device has a valid private key

[0m

 

 

[00:03:00.762,145]

[1;31m<err> asset_tracker: Device will reboot in 300 seconds

[0m

 

 

[00:03:00.769,653]

[1;31m<err> asset_tracker: LTE link disconnect

[0m

 

 

+CSCON: 1

 

 

[00:03:01.222,259]

[0m<inf> asset_tracker: RRC mode: Connected

[0m

 

 

+CEREG: 0,"765E","075D6450",9,0,0,"11100000","11100000"

 

 

+CSCON: 0

 

 

[00:03:06.757,415]

[0m<inf> asset_tracker: RRC mode: Idle

[0m

 

 

[00:03:07.170,684]

[1;31m<err> asset_tracker: Shutdown modem

[0m

[AlbertSerica]

I tried to configure ZZHC in asset_tracker, but still not working and only LED3 is blinking:

*** Booting Zephyr OS build v2.4.99-ncs2  ***
[00:00:00.212,280] [0m<inf> asset_tracker: Asset tracker started[0m
[00:00:00.218,444] [0m<inf> watchdog: Watchdog timeout installed. Timeout: 60000[0m
[00:00:00.225,952] [0m<inf> watchdog: Watchdog started[0m
[00:00:00.231,262] [0m<inf> watchdog: Watchdog feed enabled. Timeout: 30000[0m
[00:00:00.239,044] [0m<dbg> nrf_cloud_transport.nct_settings_set: Settings key: p_sesh, size: 4[0m
[00:00:00.247,863] [0m<dbg> nrf_cloud_transport.nct_settings_set: Read setting val: 1[0m
[00:00:00.262,878] [0m<dbg> nrf_cloud_transport.nct_client_id_get: client_id = nrf-352656100109613[0m
[00:00:00.271,972] [0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_base_topic: $aws/things/nrf-352656100109613/shadow[0m
[00:00:00.283,538] [0m<dbg> nrf_cloud_transport.nct_topics_populate: accepted_topic: nrf-352656100109613/shadow/get/accepted[0m
[00:00:00.294,921] [0m<dbg> nrf_cloud_transport.nct_topics_populate: rejected_topic: $aws/things/nrf-352656100109613/shadow/get/rejected[0m
[00:00:00.307,342] [0m<dbg> nrf_cloud_transport.nct_topics_populate: update_delta_topic: $aws/things/nrf-352656100109613/shadow/update/delta[0m
[00:00:00.320,129] [0m<dbg> nrf_cloud_transport.nct_topics_populate: update_topic: $aws/things/nrf-352656100109613/shadow/update[0m
[00:00:00.331,848] [0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_get_topic: $aws/things/nrf-352656100109613/shadow/get[0m
[00:00:00.343,688] [0m<inf> asset_tracker: Connecting to LTE network.[0m
[00:00:00.350,280] [0m<inf> asset_tracker: This may take several minutes.[0m
+CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
[00:00:58.980,285] [0m<inf> asset_tracker: LTE cell changed: Cell ID: -1, Tracking area: 65534
[0m

[Heidi]

Hi

First of all, please stop posting the logs like that, it makes the whole post really difficult to read. Use this button in LTE Link Monitor to get the log as a text file, and then you can either save the file or copy the text from there.

Here is the log you posted, cleaned up. 

+CSCON: 1
[00:00:08.419,586][0m<inf> asset_tracker: RRC mode: Connected[0m 
+CEREG: 1,"765E","075D6450",9,,,"11100000","00111000"
[00:00:10.095,031][0m<inf> asset_tracker: Connected to LTE network.[0m
[00:00:10.101,623][0m<inf> asset_tracker: Connecting to cloud, attempt 1 of 8[0m
[00:00:10.109,039][0m<inf> asset_tracker: Cloud connection request sent.[0m 
[00:00:10.115,966][0m<inf> asset_tracker: Connection response timeout is set to 30 seconds.[0m
[00:00:10.124,664][0m<inf> asset_tracker: Network registration status: Connected - home network[0m
[00:00:10.133,544][0m<inf> asset_tracker: PSM parameter update: TAU: 86400, Active time: -1[0m
[00:00:10.142,242][0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING[0m
[00:00:10.150,695][0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
[00:00:20.343,505][0m<dbg> nrf_cloud_transport.nct_connect: IPv4 address: 54.166.31.114[0m
[00:00:20.351,715][0m<dbg> nrf_cloud_transport.nct_mqtt_connect: MQTT clean session flag: 0[0m
[00:00:25.044,555][1;33m<wrn> date_time: sntp_query, error: -116[0m
[00:00:32.817,443][1;33m<wrn> date_time: sntp_query, error: -116[0m
[00:00:38.944,549][1;33m<wrn> date_time: sntp_query, error: -116[0m
[00:00:44.977,661][1;33m<wrn> date_time: sntp_query, error: -116[0m
[00:00:51.057,739][1;33m<wrn> date_time: sntp_query, error: -116[0m
[00:00:51.064,270][1;33m<wrn> date_time: Not getting time from any NTP server[0m
[00:00:51.072,357][0m<inf> asset_tracker: DATE_TIME_OBTAINED_MODEM[0m
+CSCON: 0 
[00:01:16.166,137][0m<inf> asset_tracker: RRC mode: Idle[0m
+CSCON: 1
[00:01:21.380,767][0m<inf> asset_tracker: RRC mode: Connected[0m
+CSCON: 0 
[00:01:43.162,567][0m<inf> asset_tracker: RRC mode: Idle[0m
+CSCON: 1
[00:02:13.541,534][0m<inf> asset_tracker: RRC mode: Connected[0m
+CSCON: 0
[00:02:35.173,370][0m<inf> asset_tracker: RRC mode: Idle[0m
[00:03:00.723,693][0m<dbg> nrf_cloud_transport.nct_mqtt_connect: mqtt_connect failed -22[0m
[00:03:00.732,025][0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING[0m
[00:03:00.740,509][0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
[00:03:00.746,582][1;31m<err> asset_tracker: Failed to connect to cloud, error -7[0m
[00:03:00.754,333][1;31m<err> asset_tracker: Ensure device has a valid private key[0m
[00:03:00.762,145][1;31m<err> asset_tracker: Device will reboot in 300 seconds[0m
[00:03:00.769,653][1;31m<err> asset_tracker: LTE link disconnect[0m
+CSCON: 1
[00:03:01.222,259][0m<inf> asset_tracker: RRC mode: Connected[0m
+CEREG: 0,"765E","075D6450",9,0,0,"11100000","11100000" 
+CSCON: 0
[00:03:06.757,415][0m<inf> asset_tracker: RRC mode: Idle[0m
[00:03:07.170,684][1;31m<err> asset_tracker: Shutdown modem[0m

From your logs, it looks like nRF Cloud isn't accepting the certificates that are on the device. Have you made sure to update the certificates?

Best regards,

Heidi

[AlbertSerica]

Hello, Heidi, 

Thanks for your reply, but I'm afraid it's not a certificate issue.

I download the certificate this morning to do the test again. The result is the same. While using China Telecom IOT card, LED3 blinks first, then LED4 blinks, LED1 and LED4 blinks at last. While using China Mobile 4G cellphone card, the DK can connect to cloud. Below is the log when I use China Telecom IOT card:

Fullscreen 2021-06-15T01_55_56.334Z-log.txt Download

2021-06-15T01:55:56.750Z INFO Application data folder: C:\Users\aaa\AppData\Roaming\nrfconnect\pc-nrfconnect-linkmonitor
2021-06-15T01:55:56.775Z DEBUG App pc-nrfconnect-linkmonitor v1.1.10 official
2021-06-15T01:55:56.775Z DEBUG App path: C:\Users\aaa\.nrfconnect-apps\node_modules\pc-nrfconnect-linkmonitor
2021-06-15T01:55:56.775Z DEBUG nRFConnect 3.6.1 is supported by the app (^3.6.0)
2021-06-15T01:55:56.776Z DEBUG nRFConnect path: C:\Users\aaa\AppData\Local\Programs\nrfconnect\resources\app.asar
2021-06-15T01:55:56.776Z DEBUG HomeDir: C:\Users\aaa
2021-06-15T01:55:56.776Z DEBUG TmpDir: C:\Users\aaa\AppData\Local\Temp
2021-06-15T01:56:06.334Z INFO Modem port is opened
2021-06-15T01:56:14.623Z DEBUG modem >> AT+CFUN=4
2021-06-15T01:56:14.638Z DEBUG modem << OK
2021-06-15T01:56:17.215Z DEBUG modem >> AT+CFUN?
2021-06-15T01:56:17.230Z DEBUG modem << +CFUN: 4
2021-06-15T01:56:17.238Z DEBUG modem << OK
2021-06-15T01:56:20.533Z INFO Updating CA certificate...
2021-06-15T01:56:20.535Z DEBUG modem >> AT%CMNG=0,16842753,0,"-----BEGIN CERTIFICATE-----
2021-06-15T01:56:20.550Z DEBUG modem >> MIIDQTCCAimgAwIBAgITBmyfz5m/jAo54vB4ikPmljZbyjANBgkqhkiG9w0BAQsF
2021-06-15T01:56:20.564Z DEBUG modem >> ADA5MQswCQYDVQQGEwJVUzEPMA0GA1UEChMGQW1hem9uMRkwFwYDVQQDExBBbWF6
2021-06-15T01:56:20.577Z DEBUG modem >> b24gUm9vdCBDQSAxMB4XDTE1MDUyNjAwMDAwMFoXDTM4MDExNzAwMDAwMFowOTEL
2021-06-15T01:56:20.591Z DEBUG modem >> MAkGA1UEBhMCVVMxDzANBgNVBAoTBkFtYXpvbjEZMBcGA1UEAxMQQW1hem9uIFJv
2021-06-15T01:56:20.604Z DEBUG modem >> b3QgQ0EgMTCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBALJ4gHHKeNXj
2021-06-15T01:56:20.618Z DEBUG modem >> ca9HgFB0fW7Y14h29Jlo91ghYPl0hAEvrAIthtOgQ3pOsqTQNroBvo3bSMgHFzZM
2021-06-15T01:56:20.632Z DEBUG modem >> 9O6II8c+6zf1tRn4SWiw3te5djgdYZ6k/oI2peVKVuRF4fn9tBb6dNqcmzU5L/qw
2021-06-15T01:56:20.645Z DEBUG modem >> IFAGbHrQgLKm+a/sRxmPUDgH3KKHOVj4utWp+UhnMJbulHheb4mjUcAwhmahRWa6
2021-06-15T01:56:20.660Z DEBUG modem >> VOujw5H5SNz/0egwLX0tdHA114gk957EWW67c4cX8jJGKLhD+rcdqsq08p8kDi1L
2021-06-15T01:56:20.673Z DEBUG modem >> 93FcXmn/6pUCyziKrlA4b9v7LWIbxcceVOF34GfID5yHI9Y/QCB/IIDEgEw+OyQm
2021-06-15T01:56:20.687Z DEBUG modem >> jgSubJrIqg0CAwEAAaNCMEAwDwYDVR0TAQH/BAUwAwEB/zAOBgNVHQ8BAf8EBAMC
2021-06-15T01:56:20.701Z DEBUG modem >> AYYwHQYDVR0OBBYEFIQYzIU07LwMlJQuCFmcx7IQTgoIMA0GCSqGSIb3DQEBCwUA
2021-06-15T01:56:20.714Z DEBUG modem >> A4IBAQCY8jdaQZChGsV2USggNiMOruYou6r4lK5IpDB/G/wkjUu0yKGX9rbxenDI
2021-06-15T01:56:20.727Z DEBUG modem >> U5PMCCjjmCXPI6T53iHTfIUJrU6adTrCC2qJeHZERxhlbI1Bjjt/msv0tadQ1wUs
2021-06-15T01:56:20.740Z DEBUG modem >> N+gDS63pYaACbvXy8MWy7Vu33PqUXHeeE6V/Uq2V8viTO96LXFvKWlJbYK8U90vv
2021-06-15T01:56:20.754Z DEBUG modem >> o/ufQJVtMVT8QtPHRh8jrdkPSHCa2XV4cdFyQzR1bldZwgJcJmApzyMZFo6IQ6XU
2021-06-15T01:56:20.768Z DEBUG modem >> 5MsI+yMRQ+hDKXJioaldXgjUkK642M4UwtBV8ob2xJNDd2ZhwLnoQdeXeGADbkpy
2021-06-15T01:56:20.782Z DEBUG modem >> rqXRfboQnoZsG4q5WTP468SQvvG5
2021-06-15T01:56:20.795Z DEBUG modem >> -----END CERTIFICATE-----"
2021-06-15T01:56:22.358Z DEBUG modem << OK
2021-06-15T01:56:22.359Z INFO Updating client certificate...
2021-06-15T01:56:22.361Z DEBUG modem >> AT%CMNG=0,16842753,1,"-----BEGIN CERTIFICATE-----
2021-06-15T01:56:22.377Z DEBUG modem >> MIICzTCCAbUCCQCjVj9XF/ScezANBgkqhkiG9w0BAQsFADCBizELMAkGA1UEBhMC
2021-06-15T01:56:22.390Z DEBUG modem >> Tk8xDzANBgNVBAgMBk5vcndheTESMBAGA1UEBwwJVHJvbmRoZWltMR0wGwYDVQQK
2021-06-15T01:56:22.404Z DEBUG modem >> DBROb3JkaWMgU2VtaWNvbmR1Y3RvcjE4MDYGA1UECwwvZWxpdmFnYXItcHJvZC1w
2021-06-15T01:56:22.417Z DEBUG modem >> Y2ExMDA5MC11cC10by0xOTA5MDItdGhpbmctZ3JvdXAwIBcNMjEwNjE1MDEzNjM5
2021-06-15T01:56:22.431Z DEBUG modem >> WhgPMjA1MTA2MDgwMTM2MzlaMIGNMQswCQYDVQQGEwJOTzESMBAGA1UECAwJVHJv
2021-06-15T01:56:22.444Z DEBUG modem >> bmRlbGFnMRIwEAYDVQQHDAlUcm9uZGhlaW0xITAfBgNVBAoMGE5vcmRpYyBTZW1p
2021-06-15T01:56:22.457Z DEBUG modem >> Y29uZHVjdG9yIEFTQTEcMBoGA1UEAwwTbnJmLTM1MjY1NjEwMDEwOTYxMzEVMBMG
2021-06-15T01:56:22.470Z DEBUG modem >> A1UELhMMRjU3NzhBMkRGMzAzMFkwEwYHKoZIzj0CAQYIKoZIzj0DAQcDQgAEcTfx
2021-06-15T01:56:22.500Z DEBUG modem >> qNpDLS0Dh7Z+pY4UE/g/vqkDCDSle0IX9k37RFlfKA7l8aNZ3xIzqsbGUWjxoivo
2021-06-15T01:56:22.512Z DEBUG modem >> dsFqM1P0dQVo5LwoYDANBgkqhkiG9w0BAQsFAAOCAQEAY8HwN3KkKPvjBvWOeM5T
2021-06-15T01:56:22.525Z DEBUG modem >> QZ9ABtS0+4+LmJVveAV6cBIbepql7OhgtRj/hcKz4NO7PKcgM5QsMbjfO/d360hT
2021-06-15T01:56:22.538Z DEBUG modem >> x6CbzYLA/bSk9uYEKlGKbd6y/hum7qfncsADqjiBL0AsPlqIDdCR5v73RHt/bThE
2021-06-15T01:56:22.551Z DEBUG modem >> G+QO+sVszi6QVjmWXOtwE3hIiK/XuJh5GiKZjdsDIPrW/mDEUbShcwE6FjG036r8
2021-06-15T01:56:22.565Z DEBUG modem >> o+CD3S0wOZL8isg9nfu652YHLcQxL9sQisYNfPmSUz3FwbsD10FJWq2Trnoi1XbE
2021-06-15T01:56:22.580Z DEBUG modem >> fiN+kcTFGXPIW09KH5PK0RQFd1Ou31drQwzAwuuSnx+1acCuLEcI3mtOA/vBnweI
2021-06-15T01:56:22.593Z DEBUG modem >> Ug==
2021-06-15T01:56:22.605Z DEBUG modem >> -----END CERTIFICATE-----
2021-06-15T01:56:22.619Z DEBUG modem >> -----BEGIN CERTIFICATE-----
2021-06-15T01:56:22.634Z DEBUG modem >> MIID6zCCAtOgAwIBAgIJAOJ1S6aVKTU5MA0GCSqGSIb3DQEBCwUAMIGLMQswCQYD
2021-06-15T01:56:22.647Z DEBUG modem >> VQQGEwJOTzEPMA0GA1UECAwGTm9yd2F5MRIwEAYDVQQHDAlUcm9uZGhlaW0xHTAb
2021-06-15T01:56:22.660Z DEBUG modem >> BgNVBAoMFE5vcmRpYyBTZW1pY29uZHVjdG9yMTgwNgYDVQQLDC9lbGl2YWdhci1w
2021-06-15T01:56:22.673Z DEBUG modem >> cm9kLXBjYTEwMDkwLXVwLXRvLTE5MDkwMi10aGluZy1ncm91cDAeFw0xOTA5MTEy
2021-06-15T01:56:22.685Z DEBUG modem >> 
2021-06-15T01:56:39.744Z DEBUG modem << *** Booting Zephyr OS build v2.4.99-ncs1  ***
2021-06-15T01:56:39.746Z DEBUG modem << I: Starting bootloader
2021-06-15T01:56:39.755Z DEBUG modem << I: Primary image: magic=unset, swap_type=0x1, copy_done=0x3, image_ok=0x3
2021-06-15T01:56:39.761Z DEBUG modem << I: Secondary image: magic=unset, swap_type=0x1, copy_done=0x3, image_ok=0x3
2021-06-15T01:56:39.763Z DEBUG modem << I: Boot source: none
2021-06-15T01:56:39.764Z DEBUG modem << I: Swap type: none
2021-06-15T01:56:40.038Z DEBUG modem << I: Bootloader chainload address offset: 0x10000
2021-06-15T01:56:40.041Z DEBUG modem << I: Jumping to the first image slot
2021-06-15T01:56:40.046Z DEBUG modem << *** Booting Zephyr OS build v2.4.99-ncs1  ***
2021-06-15T01:56:40.047Z DEBUG modem << Flash regionsDomainPermissions
2021-06-15T01:56:40.051Z DEBUG modem << 00 02 0x00000 0x18000 Securerwxl
2021-06-15T01:56:40.057Z DEBUG modem << 03 31 0x18000 0x100000 Non-Securerwxl
2021-06-15T01:56:40.061Z DEBUG modem << Non-secure callable region 0 placed in flash region 2 with size 32.
2021-06-15T01:56:40.233Z DEBUG modem << SRAM regionDomainPermissions
2021-06-15T01:56:40.242Z DEBUG modem << 00 07 0x00000 0x10000 Securerwxl
2021-06-15T01:56:40.245Z DEBUG modem << 08 31 0x10000 0x40000 Non-Securerwxl
2021-06-15T01:56:40.246Z DEBUG modem << PeripheralDomainStatus
2021-06-15T01:56:40.247Z DEBUG modem << 00 NRF_P0               Non-SecureOK
2021-06-15T01:56:40.249Z DEBUG modem << 01 NRF_CLOCK            Non-SecureOK
2021-06-15T01:56:40.250Z DEBUG modem << 02 NRF_RTC0             Non-SecureOK
2021-06-15T01:56:40.257Z DEBUG modem << 03 NRF_RTC1             Non-SecureOK
2021-06-15T01:56:40.259Z DEBUG modem << 04 NRF_NVMC             Non-SecureOK
2021-06-15T01:56:40.261Z DEBUG modem << 05 NRF_UARTE1           Non-SecureOK
2021-06-15T01:56:40.264Z DEBUG modem << 06 NRF_UARTE2           SecureSKIP
2021-06-15T01:56:40.267Z DEBUG modem << 07 NRF_TWIM2            Non-SecureOK
2021-06-15T01:56:40.273Z DEBUG modem << 08 NRF_SPIM3            Non-SecureOK
2021-06-15T01:56:40.275Z DEBUG modem << 09 NRF_TIMER0           Non-SecureOK
2021-06-15T01:56:40.278Z DEBUG modem << 10 NRF_TIMER1           Non-SecureOK
2021-06-15T01:56:40.281Z DEBUG modem << 11 NRF_TIMER2           Non-SecureOK
2021-06-15T01:56:40.284Z DEBUG modem << 12 NRF_SAADC            Non-SecureOK
2021-06-15T01:56:40.290Z DEBUG modem << 13 NRF_PWM0             Non-SecureOK
2021-06-15T01:56:40.292Z DEBUG modem << 14 NRF_PWM1             Non-SecureOK
2021-06-15T01:56:40.295Z DEBUG modem << 15 NRF_PWM2             Non-SecureOK
2021-06-15T01:56:40.298Z DEBUG modem << 16 NRF_PWM3             Non-SecureOK
2021-06-15T01:56:40.301Z DEBUG modem << 17 NRF_WDT              Non-SecureOK
2021-06-15T01:56:40.307Z DEBUG modem << 18 NRF_IPC              Non-SecureOK
2021-06-15T01:56:40.309Z DEBUG modem << 19 NRF_VMC              Non-SecureOK
2021-06-15T01:56:40.312Z DEBUG modem << 20 NRF_FPU              Non-SecureOK
2021-06-15T01:56:40.315Z DEBUG modem << 21 NRF_EGU1             Non-SecureOK
2021-06-15T01:56:40.318Z DEBUG modem << 22 NRF_EGU2             Non-SecureOK
2021-06-15T01:56:40.324Z DEBUG modem << 23 NRF_DPPIC            Non-SecureOK
2021-06-15T01:56:40.326Z DEBUG modem << 24 NRF_REGULATORS       Non-SecureOK
2021-06-15T01:56:40.329Z DEBUG modem << 25 NRF_GPIOTE1          Non-SecureOK
2021-06-15T01:56:40.331Z DEBUG modem << SPM: NS image at 0x1c200
2021-06-15T01:56:40.334Z DEBUG modem << SPM: NS MSP at 0x20025598
2021-06-15T01:56:40.341Z DEBUG modem << SPM: NS reset vector at 0x26805
2021-06-15T01:56:40.342Z DEBUG modem << SPM: prepare to jump to Non-Secure image.
2021-06-15T01:56:40.551Z DEBUG modem << *** Booting Zephyr OS build v2.4.99-ncs1  ***
2021-06-15T01:56:40.563Z DEBUG modem << [00:00:00.212,280] [0m<inf> asset_tracker: Asset tracker started[0m
2021-06-15T01:56:40.579Z DEBUG modem << [00:00:00.218,414] [0m<inf> watchdog: Watchdog timeout installed. Timeout: 60000[0m
2021-06-15T01:56:40.580Z DEBUG modem << [00:00:00.225,921] [0m<inf> watchdog: Watchdog started[0m
2021-06-15T01:56:40.583Z DEBUG modem << [00:00:00.231,231] [0m<inf> watchdog: Watchdog feed enabled. Timeout: 30000[0m
2021-06-15T01:56:40.600Z DEBUG modem << [00:00:00.245,635] [0m<dbg> nrf_cloud_transport.nct_client_id_get: client_id = nrf-352656100109613[0m
2021-06-15T01:56:40.611Z DEBUG modem << [00:00:00.254,730] [0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_base_topic: $aws/things/nrf-352656100109613/shadow[0m
2021-06-15T01:56:40.624Z DEBUG modem << [00:00:00.266,265] [0m<dbg> nrf_cloud_transport.nct_topics_populate: accepted_topic: nrf-352656100109613/shadow/get/accepted[0m
2021-06-15T01:56:40.635Z DEBUG modem << [00:00:00.277,618] [0m<dbg> nrf_cloud_transport.nct_topics_populate: rejected_topic: $aws/things/nrf-352656100109613/shadow/get/rejected[0m
2021-06-15T01:56:40.648Z DEBUG modem << [00:00:00.290,008] [0m<dbg> nrf_cloud_transport.nct_topics_populate: update_delta_topic: $aws/things/nrf-352656100109613/shadow/update/delta[0m
2021-06-15T01:56:40.660Z DEBUG modem << [00:00:00.302,764] [0m<dbg> nrf_cloud_transport.nct_topics_populate: update_topic: $aws/things/nrf-352656100109613/shadow/update[0m
2021-06-15T01:56:40.674Z DEBUG modem << [00:00:00.314,483] [0m<dbg> nrf_cloud_transport.nct_topics_populate: shadow_get_topic: $aws/things/nrf-352656100109613/shadow/get[0m
2021-06-15T01:56:40.679Z DEBUG modem << [00:00:00.326,293] [0m<inf> asset_tracker: Connecting to LTE network.[0m
2021-06-15T01:56:40.685Z DEBUG modem << [00:00:00.332,824] [0m<inf> asset_tracker: This may take several minutes.[0m
2021-06-15T01:56:47.756Z DEBUG modem << +CEREG: 2,"765E","075D6450",9,0,0,"11100000","11100000"
2021-06-15T01:56:47.764Z DEBUG modem << [00:00:07.409,698] [0m<inf> asset_tracker: LTE cell changed: Cell ID: 123561040, Tracking area: 30302[0m
2021-06-15T01:56:48.404Z DEBUG modem << +CSCON: 1
2021-06-15T01:56:48.410Z DEBUG modem << [00:00:08.058,502] [0m<inf> asset_tracker: RRC mode: Connected[0m
2021-06-15T01:56:50.448Z DEBUG modem << +CEREG: 1,"765E","075D6450",9,,,"11100000","00111000"
2021-06-15T01:56:50.457Z DEBUG modem << [00:00:10.103,912] [0m<inf> asset_tracker: Connected to LTE network.[0m
2021-06-15T01:56:50.463Z DEBUG modem << [00:00:10.110,504] [0m<inf> asset_tracker: Connecting to cloud, attempt 1 of 8[0m
2021-06-15T01:56:50.476Z DEBUG modem << [00:00:10.117,919] [0m<inf> asset_tracker: Cloud connection request sent.[0m
2021-06-15T01:56:50.478Z DEBUG modem << [00:00:10.124,816] [0m<inf> asset_tracker: Connection response timeout is set to 30 seconds.[0m
2021-06-15T01:56:50.491Z DEBUG modem << [00:00:10.133,514] [0m<inf> asset_tracker: Network registration status: Connected - home network[0m
2021-06-15T01:56:50.496Z DEBUG modem << [00:00:10.142,364] [0m<inf> asset_tracker: PSM parameter update: TAU: 86400, Active time: -1[0m
2021-06-15T01:56:50.508Z DEBUG modem << [00:00:10.151,062] [0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING[0m
2021-06-15T01:56:50.510Z DEBUG modem << [00:00:10.159,484] [0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
2021-06-15T01:56:51.057Z DEBUG modem << [00:00:10.704,376] [0m<dbg> nrf_cloud_transport.nct_connect: IPv4 address: 52.203.187.192[0m
2021-06-15T01:56:51.066Z DEBUG modem << [00:00:10.712,677] [0m<dbg> nrf_cloud_transport.nct_mqtt_connect: MQTT clean session flag: 1[0m
2021-06-15T01:56:55.705Z DEBUG modem << [00:00:15.354,339] [1;33m<wrn> date_time: sntp_query, error: -116[0m
2021-06-15T01:57:01.099Z DEBUG modem << [00:00:20.748,199] [1;33m<wrn> date_time: sntp_query, error: -116[0m
2021-06-15T01:57:07.047Z DEBUG modem << [00:00:26.696,258] [1;33m<wrn> date_time: sntp_query, error: -116[0m
2021-06-15T01:57:13.128Z DEBUG modem << [00:00:32.776,367] [1;33m<wrn> date_time: sntp_query, error: -116[0m
2021-06-15T01:57:19.208Z DEBUG modem << [00:00:38.856,475] [1;33m<wrn> date_time: sntp_query, error: -116[0m
2021-06-15T01:57:19.215Z DEBUG modem << [00:00:38.863,006] [1;33m<wrn> date_time: Not getting time from any NTP server[0m
2021-06-15T01:57:19.225Z DEBUG modem << [00:00:38.871,063] [0m<inf> asset_tracker: DATE_TIME_OBTAINED_MODEM[0m
2021-06-15T01:57:32.030Z DEBUG modem >> AT+CFUN?
2021-06-15T01:57:32.041Z DEBUG modem << +CFUN: 1
2021-06-15T01:57:32.047Z DEBUG modem << OK
2021-06-15T01:57:46.693Z DEBUG modem << +CSCON: 0
2021-06-15T01:57:46.704Z DEBUG modem << [00:01:06.346,893] [0m<inf> asset_tracker: RRC mode: Idle[0m
2021-06-15T01:57:51.766Z DEBUG modem << +CSCON: 1
2021-06-15T01:57:51.771Z DEBUG modem << [00:01:11.419,494] [0m<inf> asset_tracker: RRC mode: Connected[0m
2021-06-15T01:58:13.700Z DEBUG modem << +CSCON: 0
2021-06-15T01:58:13.711Z DEBUG modem << [00:01:33.355,316] [0m<inf> asset_tracker: RRC mode: Idle[0m
2021-06-15T01:58:45.851Z DEBUG modem << +CSCON: 1
2021-06-15T01:58:45.865Z DEBUG modem << [00:02:05.506,317] [0m<inf> asset_tracker: RRC mode: Connected[0m
2021-06-15T01:59:07.701Z DEBUG modem << +CSCON: 0
2021-06-15T01:59:07.712Z DEBUG modem << [00:02:27.356,109] [0m<inf> asset_tracker: RRC mode: Idle[0m
2021-06-15T01:59:32.583Z DEBUG modem << [00:02:52.230,072] [0m<dbg> nrf_cloud_transport.nct_mqtt_connect: mqtt_connect failed -22[0m
2021-06-15T01:59:32.591Z DEBUG modem << [00:02:52.238,372] [0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING[0m
2021-06-15T01:59:32.597Z DEBUG modem << [00:02:52.246,856] [0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
2021-06-15T01:59:32.607Z DEBUG modem << [00:02:52.252,929] [1;31m<err> asset_tracker: Failed to connect to cloud, error -7[0m
2021-06-15T01:59:32.612Z DEBUG modem << [00:02:52.260,650] [1;31m<err> asset_tracker: Ensure device has a valid private key[0m
2021-06-15T01:59:32.624Z DEBUG modem << [00:02:52.268,463] [1;31m<err> asset_tracker: Device will reboot in 300 seconds[0m
2021-06-15T01:59:32.627Z DEBUG modem << [00:02:52.276,031] [1;31m<err> asset_tracker: LTE link disconnect[0m
2021-06-15T01:59:33.206Z DEBUG modem << +CSCON: 1
2021-06-15T01:59:33.218Z DEBUG modem << [00:02:52.860,992] [0m<inf> asset_tracker: RRC mode: Connected[0m
2021-06-15T01:59:38.680Z DEBUG modem << +CEREG: 0,"765E","075D6450",9,0,0,"11100000","11100000"
2021-06-15T01:59:38.740Z DEBUG modem << +CSCON: 0
2021-06-15T01:59:38.746Z DEBUG modem << [00:02:58.396,148] [0m<inf> asset_tracker: RRC mode: Idle[0m
2021-06-15T01:59:39.160Z DEBUG modem << [00:02:58.810,089] [1;31m<err> asset_tracker: Shutdown modem[0m

[Heidi]

Hi!

1. When using the Chine Mobile Cellphone SIM, is it connecting through LTE-M or NB-IoT? The +CEREG response field AcT will return 7 for LTE-M and 9 for NB-IoT.

2. You say LED1 and LED4 blinks at last, which isn't one of the defined application states (see Asset Tracker: User interface). Could you take a look at the documentation and tell me if the LED blinking pattern matches any of them?

3. From the iBasis log it doesn't look like it's done connecting to the network. Please wait at least 10 minutes as it can take a while for the device to connect to the network and to nRF Cloud. 

[00:00:00.343,688] [0m<inf> asset_tracker: Connecting to LTE network.[0m
[00:00:00.350,280] [0m<inf> asset_tracker: This may take several minutes.[0m
+CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
[00:00:58.980,285] [0m<inf> asset_tracker: LTE cell changed: Cell ID: -1, Tracking area: 65534[0m

4. As for the issues with China Telecom NB-IoT SIM, we're going to need a modem trace to investigate further (see Collecting a modem trace for the nRF9160 DK). 

[AlbertSerica]

Hello, 

China doesn't have LTE-M so only NB-IoT is used. CEREG returns 9.

Blinking in cross pattern (LED 1 and 4, LED 2 and 3): Communication error with the nRF Connect for Cloud.

The asset tracker connected to the Internet after a few minutes. 

2021-06-15T01:56:50.457Z DEBUG modem << [00:00:10.103,912] [0m<inf> asset_tracker: Connected to LTE network.[0m

The problem I encountered seems to be related to zzhc library, there is a page about zzhc but it's not clear about how to use it:

developer.nordicsemi.com/.../zzhc.html