nRF9160 NB-IoT SIM registration step by step guide

[5prinG]

hi 

I have nRF9160 dev kit, which I am using in a LAB with a private LTE SIM card, which has 99920 PLMN ID.

The network supports Band 3, and NB-IoT is configured as an in-band signalling.

I am using nRF connect 3.6.1 software to fire up the AT commands, which includes scanning of the network, and then it should allow me to register to the network

which is not happening, 

at this stage, can you please provide me step by step AT command guide to troubleshoot the problem, 

I am attaching the initial device logs collected, 

Moreover, I have also tried with the Vodafone commercial SIM card, which is also not connecting.

I am using this kit with a windows 10 machine, 

looking foward

[5prinG]

Fullscreen 3073.2021-06-01T15_24_10.526Z-log.txt Download

2021-06-01T15:24:10.987Z INFO Application data folder: C:\Users\testb\AppData\Roaming\nrfconnect\pc-nrfconnect-linkmonitor
2021-06-01T15:24:11.010Z DEBUG App pc-nrfconnect-linkmonitor v1.1.10 official
2021-06-01T15:24:11.010Z DEBUG App path: C:\Users\testb\.nrfconnect-apps\node_modules\pc-nrfconnect-linkmonitor
2021-06-01T15:24:11.010Z DEBUG nRFConnect 3.6.1 is supported by the app (^3.6.0)
2021-06-01T15:24:11.010Z DEBUG nRFConnect path: C:\Users\testb\AppData\Local\Programs\nrfconnect\resources\app.asar
2021-06-01T15:24:11.010Z DEBUG HomeDir: C:\Users\testb
2021-06-01T15:24:11.010Z DEBUG TmpDir: C:\Users\testb\AppData\Local\Temp
2021-06-01T15:24:15.762Z INFO Modem port is opened
2021-06-01T15:24:15.768Z DEBUG modem >> AT+CFUN?
2021-06-01T15:24:15.790Z DEBUG modem << +CFUN: 1
2021-06-01T15:24:15.793Z DEBUG modem << OK
2021-06-01T15:24:15.811Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:24:15.818Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:24:15.819Z DEBUG modem << OK
2021-06-01T15:24:15.821Z DEBUG modem >> AT+CGMI
2021-06-01T15:24:15.828Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:24:15.829Z DEBUG modem << OK
2021-06-01T15:24:15.831Z DEBUG modem >> AT+CGMM
2021-06-01T15:24:15.835Z DEBUG modem << nRF9160-SICA
2021-06-01T15:24:15.837Z DEBUG modem << 
2021-06-01T15:24:15.838Z DEBUG modem << OK
2021-06-01T15:24:15.845Z DEBUG modem >> AT+CGMR
2021-06-01T15:24:15.849Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:24:15.851Z DEBUG modem << 
2021-06-01T15:24:15.852Z DEBUG modem << OK
2021-06-01T15:24:15.853Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:24:15.854Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:24:15.862Z DEBUG modem << +CEMODE: 2
2021-06-01T15:24:15.865Z DEBUG modem << OK
2021-06-01T15:24:15.870Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:24:15.880Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:24:15.882Z DEBUG modem << OK
2021-06-01T15:24:15.886Z DEBUG modem >> AT+CMEE?
2021-06-01T15:24:15.895Z DEBUG modem << +CMEE: 0
2021-06-01T15:24:15.898Z DEBUG modem << OK
2021-06-01T15:24:15.900Z DEBUG modem >> AT+CMEE=1
2021-06-01T15:24:15.904Z DEBUG modem << OK
2021-06-01T15:24:15.907Z DEBUG modem >> AT+CNEC?
2021-06-01T15:24:15.912Z DEBUG modem << +CNEC: 0
2021-06-01T15:24:15.914Z DEBUG modem << OK
2021-06-01T15:24:15.918Z DEBUG modem >> AT+CNEC=24
2021-06-01T15:24:15.921Z DEBUG modem << OK
2021-06-01T15:24:15.930Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:24:15.935Z DEBUG modem << +CGEREP: 0,0
2021-06-01T15:24:15.937Z DEBUG modem << OK
2021-06-01T15:24:15.939Z DEBUG modem >> AT+CGDCONT?
2021-06-01T15:24:15.945Z DEBUG modem << OK
2021-06-01T15:24:15.948Z DEBUG modem >> AT+CGACT?
2021-06-01T15:24:15.952Z DEBUG modem << OK
2021-06-01T15:24:15.955Z DEBUG modem >> AT+CGEREP=1
2021-06-01T15:24:15.961Z DEBUG modem << OK
2021-06-01T15:24:15.965Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:24:15.971Z DEBUG modem << OK
2021-06-01T15:24:15.977Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:24:15.981Z DEBUG modem << OK
2021-06-01T15:24:15.984Z DEBUG modem >> AT+CEREG?
2021-06-01T15:24:15.995Z DEBUG modem << +CEREG: 5,90,"FFFE","FFFFFFFF",7,0,0,"00000000","00000000"
2021-06-01T15:24:15.996Z DEBUG modem << OK
2021-06-01T15:24:16.001Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:24:16.005Z DEBUG modem << OK
2021-06-01T15:24:16.012Z DEBUG modem >> AT+CESQ
2021-06-01T15:24:16.018Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:24:16.019Z DEBUG modem << 
2021-06-01T15:24:16.020Z DEBUG modem << OK
2021-06-01T15:24:16.023Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:24:16.028Z DEBUG modem << OK
2021-06-01T15:24:16.031Z DEBUG modem >> AT%XSIM?
2021-06-01T15:24:16.035Z DEBUG modem << %XSIM: 0
2021-06-01T15:24:16.037Z DEBUG modem << 
2021-06-01T15:24:16.037Z DEBUG modem << OK
2021-06-01T15:24:58.024Z DEBUG modem >> AT+COPS=?
2021-06-01T15:25:54.330Z DEBUG modem << +COPS: 
2021-06-01T15:25:54.335Z DEBUG modem << OK
2021-06-01T15:25:54.338Z DEBUG modem >> AT+COPS?
2021-06-01T15:25:54.340Z DEBUG modem << +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:25:54.349Z DEBUG modem << [00:02:38.738,800] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:25:54.351Z DEBUG modem << [0m
2021-06-01T15:25:54.353Z DEBUG modem << [00:02:38.750,549] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:25:54.355Z DEBUG modem << [0m
2021-06-01T15:25:54.356Z DEBUG modem << +COPS: 0
2021-06-01T15:25:54.358Z DEBUG modem << OK
2021-06-01T15:26:52.642Z DEBUG modem >> AT+CFUN=1
2021-06-01T15:26:52.647Z DEBUG modem << OK
2021-06-01T15:26:53.306Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:26:53.317Z DEBUG modem << [00:03:37.711,364] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:26:53.323Z DEBUG modem << [0m
2021-06-01T15:26:53.325Z DEBUG modem << [00:03:37.723,083] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:26:53.326Z DEBUG modem << [0m
2021-06-01T15:26:53.328Z DEBUG modem << %XSIM: 1
2021-06-01T15:26:53.340Z DEBUG modem >> AT+CPIN?
2021-06-01T15:26:53.355Z DEBUG modem << +CPIN: READY
2021-06-01T15:26:53.357Z DEBUG modem << OK
2021-06-01T15:26:53.363Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:26:53.383Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:26:53.390Z DEBUG modem << OK
2021-06-01T15:26:53.396Z DEBUG modem >> AT+CIMI
2021-06-01T15:26:53.409Z DEBUG modem << 999200000000000
2021-06-01T15:26:53.410Z DEBUG modem << OK
2021-06-01T15:26:53.411Z INFO IMSIdentity: 999200000000000
2021-06-01T15:26:59.210Z DEBUG modem >> AT
2021-06-01T15:26:59.225Z DEBUG modem << OK
2021-06-01T15:27:00.178Z DEBUG modem >> AT+CFUN?
2021-06-01T15:27:00.195Z DEBUG modem << +CFUN: 1
2021-06-01T15:27:00.199Z DEBUG modem << OK
2021-06-01T15:27:00.201Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:27:00.215Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:27:00.216Z DEBUG modem << OK
2021-06-01T15:27:00.219Z DEBUG modem >> AT+CGMI
2021-06-01T15:27:00.233Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:27:00.234Z DEBUG modem << OK
2021-06-01T15:27:00.241Z DEBUG modem >> AT+CGMM
2021-06-01T15:27:00.258Z DEBUG modem << nRF9160-SICA
2021-06-01T15:27:00.259Z DEBUG modem << OK
2021-06-01T15:27:00.262Z DEBUG modem >> AT+CGMR
2021-06-01T15:27:00.277Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:27:00.278Z DEBUG modem << OK
2021-06-01T15:27:00.279Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:27:00.281Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:27:00.294Z DEBUG modem << +CEMODE: 2
2021-06-01T15:27:00.295Z DEBUG modem << OK
2021-06-01T15:27:00.298Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:27:00.314Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:27:00.315Z DEBUG modem << OK
2021-06-01T15:27:00.318Z DEBUG modem >> AT+CMEE?
2021-06-01T15:27:00.331Z DEBUG modem << +CMEE: 1
2021-06-01T15:27:00.332Z DEBUG modem << OK
2021-06-01T15:27:00.334Z DEBUG modem >> AT+CNEC?
2021-06-01T15:27:00.346Z DEBUG modem << +CNEC: 24
2021-06-01T15:27:00.347Z DEBUG modem << OK
2021-06-01T15:27:00.350Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:27:00.363Z DEBUG modem << +CGEREP: 1,0
2021-06-01T15:27:00.363Z DEBUG modem << OK
2021-06-01T15:27:00.366Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:27:00.378Z DEBUG modem << OK
2021-06-01T15:27:00.382Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:27:00.400Z DEBUG modem << OK
2021-06-01T15:27:00.411Z DEBUG modem >> AT+CEREG?
2021-06-01T15:27:00.429Z DEBUG modem << +CEREG: 5,2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:27:00.430Z DEBUG modem << OK
2021-06-01T15:27:00.433Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:27:00.446Z DEBUG modem << OK
2021-06-01T15:27:00.448Z DEBUG modem >> AT+CESQ
2021-06-01T15:27:00.462Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:27:00.463Z DEBUG modem << 
2021-06-01T15:27:00.463Z DEBUG modem << OK
2021-06-01T15:27:00.467Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:27:00.480Z DEBUG modem << OK
2021-06-01T15:27:00.482Z DEBUG modem >> AT%XSIM?
2021-06-01T15:27:00.495Z DEBUG modem << %XSIM: 1
2021-06-01T15:27:00.496Z DEBUG modem << OK
2021-06-01T15:27:00.500Z DEBUG modem >> AT+CPIN?
2021-06-01T15:27:00.510Z DEBUG modem << +CPIN: READY
2021-06-01T15:27:00.511Z DEBUG modem << OK
2021-06-01T15:27:00.514Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:27:00.534Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:27:00.535Z DEBUG modem << OK
2021-06-01T15:27:00.543Z DEBUG modem >> AT+CIMI
2021-06-01T15:27:00.558Z DEBUG modem << 999200000000000
2021-06-01T15:27:00.559Z DEBUG modem << OK
2021-06-01T15:27:00.560Z INFO IMSIdentity: 999200000000000
2021-06-01T15:27:46.342Z INFO Generating system report...
2021-06-01T15:27:48.436Z INFO System report: C:\Users\testb\AppData\Roaming\nrfconnect\pc-nrfconnect-linkmonitor\nrfconnect-system-report-2021-06-01T15-27-46.342Z.txt
2021-06-01T15:30:35.280Z ERROR Network search failed: Cannot read property 'testPLMNSelection' of undefined
2021-06-01T15:30:43.583Z ERROR Network search failed: Cannot read property 'testPLMNSelection' of undefined
2021-06-01T15:30:49.406Z INFO Modem port is opened
2021-06-01T15:30:49.410Z DEBUG modem >> AT+CFUN?
2021-06-01T15:30:49.415Z DEBUG modem << +CFUN: 1
2021-06-01T15:30:49.417Z DEBUG modem << OK
2021-06-01T15:30:49.421Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:30:49.429Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:30:49.430Z DEBUG modem << OK
2021-06-01T15:30:49.434Z DEBUG modem >> AT+CGMI
2021-06-01T15:30:49.439Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:30:49.440Z DEBUG modem << OK
2021-06-01T15:30:49.446Z DEBUG modem >> AT+CGMM
2021-06-01T15:30:49.452Z DEBUG modem << nRF9160-SICA
2021-06-01T15:30:49.453Z DEBUG modem << 
2021-06-01T15:30:49.453Z DEBUG modem << OK
2021-06-01T15:30:49.457Z DEBUG modem >> AT+CGMR
2021-06-01T15:30:49.464Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:30:49.465Z DEBUG modem << OK
2021-06-01T15:30:49.465Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:30:49.467Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:30:49.470Z DEBUG modem << +CEMODE: 2
2021-06-01T15:30:49.472Z DEBUG modem << OK
2021-06-01T15:30:49.480Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:30:49.488Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:30:49.495Z DEBUG modem << OK
2021-06-01T15:30:49.500Z DEBUG modem >> AT+CMEE?
2021-06-01T15:30:49.504Z DEBUG modem << +CMEE: 0
2021-06-01T15:30:49.506Z DEBUG modem << 
2021-06-01T15:30:49.506Z DEBUG modem << OK
2021-06-01T15:30:49.512Z DEBUG modem >> AT+CMEE=1
2021-06-01T15:30:49.516Z DEBUG modem << OK
2021-06-01T15:30:49.519Z DEBUG modem >> AT+CNEC?
2021-06-01T15:30:49.522Z DEBUG modem << +CNEC: 0
2021-06-01T15:30:49.524Z DEBUG modem << OK
2021-06-01T15:30:49.530Z DEBUG modem >> AT+CNEC=24
2021-06-01T15:30:49.533Z DEBUG modem << OK
2021-06-01T15:30:49.537Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:30:49.546Z DEBUG modem << +CGEREP: 0,0
2021-06-01T15:30:49.548Z DEBUG modem << OK
2021-06-01T15:30:49.552Z DEBUG modem >> AT+CGDCONT?
2021-06-01T15:30:49.555Z DEBUG modem << OK
2021-06-01T15:30:49.563Z DEBUG modem >> AT+CGACT?
2021-06-01T15:30:49.569Z DEBUG modem << OK
2021-06-01T15:30:49.572Z DEBUG modem >> AT+CGEREP=1
2021-06-01T15:30:49.578Z DEBUG modem << OK
2021-06-01T15:30:49.582Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:30:49.586Z DEBUG modem << OK
2021-06-01T15:30:49.588Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:30:49.596Z DEBUG modem << OK
2021-06-01T15:30:49.599Z DEBUG modem >> AT+CEREG?
2021-06-01T15:30:49.614Z DEBUG modem << +CEREG: 5,4,"FFFE","FFFFFFFF",7,0,0,"00000000","00000000"
2021-06-01T15:30:49.615Z DEBUG modem << OK
2021-06-01T15:30:49.619Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:30:49.622Z DEBUG modem << OK
2021-06-01T15:30:49.630Z DEBUG modem >> AT+CESQ
2021-06-01T15:30:49.635Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:30:49.636Z DEBUG modem << 
2021-06-01T15:30:49.637Z DEBUG modem << OK
2021-06-01T15:30:49.640Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:30:49.647Z DEBUG modem << OK
2021-06-01T15:30:49.649Z DEBUG modem >> AT%XSIM?
2021-06-01T15:30:49.654Z DEBUG modem << %XSIM: 1
2021-06-01T15:30:49.655Z DEBUG modem << OK
2021-06-01T15:30:49.666Z DEBUG modem >> AT+CPIN?
2021-06-01T15:30:49.670Z DEBUG modem << +CPIN: READY
2021-06-01T15:30:49.672Z DEBUG modem << OK
2021-06-01T15:30:49.682Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:30:49.698Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:30:49.699Z DEBUG modem << OK
2021-06-01T15:30:49.703Z DEBUG modem >> AT+CIMI
2021-06-01T15:30:49.707Z DEBUG modem << 999200000000000
2021-06-01T15:30:49.710Z DEBUG modem << OK
2021-06-01T15:30:49.711Z INFO IMSIdentity: 999200000000000
2021-06-01T15:30:55.506Z DEBUG modem >> AT+COPS=?
2021-06-01T15:31:21.835Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:31:21.846Z DEBUG modem << [00:00:59.647,644] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:31:21.848Z DEBUG modem << [0m
2021-06-01T15:31:21.854Z DEBUG modem << [00:00:59.659,362] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:31:21.856Z DEBUG modem << [0m
2021-06-01T15:32:19.170Z DEBUG modem << +CEREG: 90
2021-06-01T15:32:19.191Z DEBUG modem << [00:01:56.981,903] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 90
2021-06-01T15:32:19.194Z DEBUG modem << [0m
2021-06-01T15:32:19.195Z DEBUG modem << [00:01:56.989,562] [1;31m<err> lte_lc: Could not get tracking area code, error: -22[0m
2021-06-01T15:32:19.197Z DEBUG modem << [00:01:56.997,436] [1;31m<err> lte_lc: Failed to parse notification (error -22): +CEREG: 90
2021-06-01T15:32:19.198Z DEBUG modem << [0m
2021-06-01T15:32:19.200Z DEBUG modem << +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:32:19.217Z DEBUG modem << [00:01:57.011,199] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:32:19.218Z DEBUG modem << [0m
2021-06-01T15:32:19.219Z DEBUG modem << [00:01:57.022,918] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:32:19.220Z DEBUG modem << [0m
2021-06-01T15:32:19.220Z DEBUG modem << %XSIM: 0
2021-06-01T15:32:49.094Z DEBUG modem << %XSIM: 1
2021-06-01T15:32:49.123Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:32:49.134Z DEBUG modem << [00:02:26.937,255] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:32:49.135Z DEBUG modem << [0m
2021-06-01T15:32:49.142Z DEBUG modem << [00:02:26.948,974] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:32:49.144Z DEBUG modem << [0m
2021-06-01T15:32:53.461Z INFO Modem port is closed
2021-06-01T15:32:53.468Z INFO Modem port is opened
2021-06-01T15:32:53.470Z DEBUG modem >> AT+CFUN?
2021-06-01T15:33:07.008Z DEBUG modem >> AT+COPS=?
2021-06-01T15:34:22.798Z INFO Modem port is opened
2021-06-01T15:34:22.801Z DEBUG modem >> AT+CFUN?
2021-06-01T15:34:22.805Z DEBUG modem << +CFUN: 1
2021-06-01T15:34:22.812Z DEBUG modem << OK
2021-06-01T15:34:22.817Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:34:22.829Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:34:22.830Z DEBUG modem << OK
2021-06-01T15:34:22.832Z DEBUG modem >> AT+CGMI
2021-06-01T15:34:22.837Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:34:22.838Z DEBUG modem << OK
2021-06-01T15:34:22.845Z DEBUG modem >> AT+CGMM
2021-06-01T15:34:22.849Z DEBUG modem << nRF9160-SICA
2021-06-01T15:34:22.850Z DEBUG modem << OK
2021-06-01T15:34:22.853Z DEBUG modem >> AT+CGMR
2021-06-01T15:34:22.863Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:34:22.864Z DEBUG modem << OK
2021-06-01T15:34:22.865Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:34:22.868Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:34:22.872Z DEBUG modem << +CEMODE: 2
2021-06-01T15:34:22.881Z DEBUG modem << 
2021-06-01T15:34:22.882Z DEBUG modem << OK
2021-06-01T15:34:22.886Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:34:22.898Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:34:22.899Z DEBUG modem << OK
2021-06-01T15:34:22.904Z DEBUG modem >> AT+CMEE?
2021-06-01T15:34:22.913Z DEBUG modem << +CMEE: 0
2021-06-01T15:34:22.915Z DEBUG modem << OK
2021-06-01T15:34:22.919Z DEBUG modem >> AT+CMEE=1
2021-06-01T15:34:22.928Z DEBUG modem << OK
2021-06-01T15:34:22.932Z DEBUG modem >> AT+CNEC?
2021-06-01T15:34:22.936Z DEBUG modem << +CNEC: 0
2021-06-01T15:34:22.937Z DEBUG modem << OK
2021-06-01T15:34:22.945Z DEBUG modem >> AT+CNEC=24
2021-06-01T15:34:22.949Z DEBUG modem << OK
2021-06-01T15:34:22.952Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:34:22.963Z DEBUG modem << +CGEREP: 0,0
2021-06-01T15:34:22.964Z DEBUG modem << OK
2021-06-01T15:34:22.967Z DEBUG modem >> AT+CGDCONT?
2021-06-01T15:34:22.970Z DEBUG modem << OK
2021-06-01T15:34:22.979Z DEBUG modem >> AT+CGACT?
2021-06-01T15:34:22.983Z DEBUG modem << OK
2021-06-01T15:34:22.985Z DEBUG modem >> AT+CGEREP=1
2021-06-01T15:34:22.989Z DEBUG modem << OK
2021-06-01T15:34:22.997Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:34:23.001Z DEBUG modem << OK
2021-06-01T15:34:23.002Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:34:23.013Z DEBUG modem << OK
2021-06-01T15:34:23.015Z DEBUG modem >> AT+CEREG?
2021-06-01T15:34:23.029Z DEBUG modem << +CEREG: 5,4,"FFFE","FFFFFFFF",7,0,0,"00000000","00000000"
2021-06-01T15:34:23.030Z DEBUG modem << OK
2021-06-01T15:34:23.034Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:34:23.037Z DEBUG modem << OK
2021-06-01T15:34:23.047Z DEBUG modem >> AT+CESQ
2021-06-01T15:34:23.052Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:34:23.053Z DEBUG modem << OK
2021-06-01T15:34:23.064Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:34:23.067Z DEBUG modem << OK
2021-06-01T15:34:23.071Z DEBUG modem >> AT%XSIM?
2021-06-01T15:34:23.082Z DEBUG modem << %XSIM: 1
2021-06-01T15:34:23.084Z DEBUG modem << 
2021-06-01T15:34:23.086Z DEBUG modem << OK
2021-06-01T15:34:23.098Z DEBUG modem >> AT+CPIN?
2021-06-01T15:34:23.102Z DEBUG modem << +CPIN: READY
2021-06-01T15:34:23.103Z DEBUG modem << OK
2021-06-01T15:34:23.115Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:34:23.130Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:34:23.131Z DEBUG modem << OK
2021-06-01T15:34:23.135Z DEBUG modem >> AT+CIMI
2021-06-01T15:34:23.147Z DEBUG modem << 204080813563512
2021-06-01T15:34:23.148Z DEBUG modem << OK
2021-06-01T15:34:23.149Z INFO IMSIdentity: 204080813563512
2021-06-01T15:34:39.800Z DEBUG modem >> AT+COPS=?
2021-06-01T15:35:15.759Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:35:15.770Z DEBUG modem << [00:01:01.629,943] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:35:15.771Z DEBUG modem << [0m
2021-06-01T15:35:15.787Z DEBUG modem << [00:01:01.641,662] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:35:15.788Z DEBUG modem << [0m
2021-06-01T15:36:07.021Z ERROR Network search failed: Error: 'AT+COPS=?
' timed out
2021-06-01T15:37:45.707Z DEBUG modem << +COPS: 
2021-06-01T15:37:45.710Z DEBUG modem << OK
2021-06-01T15:37:45.718Z DEBUG modem >> AT+CFUN?
2021-06-01T15:37:45.731Z DEBUG modem << +CFUN: 1
2021-06-01T15:37:45.736Z DEBUG modem << OK
2021-06-01T15:37:45.744Z DEBUG modem >> AT+COPS=?
2021-06-01T15:39:10.083Z DEBUG modem << +CEREG: 90
2021-06-01T15:39:10.091Z DEBUG modem << [00:04:55.958,312] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 90
2021-06-01T15:39:10.092Z DEBUG modem << [0m
2021-06-01T15:39:10.098Z DEBUG modem << [00:04:55.965,972] [1;31m<err> lte_lc: Could not get tracking area code, error: -22[0m
2021-06-01T15:39:10.106Z DEBUG modem << [00:04:55.973,846] [1;31m<err> lte_lc: Failed to parse notification (error -22): +CEREG: 90
2021-06-01T15:39:10.109Z DEBUG modem << [0m
2021-06-01T15:39:10.112Z DEBUG modem << +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:39:10.123Z DEBUG modem << [00:04:55.987,579] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:39:10.124Z DEBUG modem << [0m
2021-06-01T15:39:10.138Z DEBUG modem << [00:04:55.999,298] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:39:10.139Z DEBUG modem << [0m
2021-06-01T15:39:10.140Z DEBUG modem << %XSIM: 0
2021-06-01T15:39:45.305Z DEBUG modem << +COPS: 
2021-06-01T15:39:45.308Z DEBUG modem << OK
2021-06-01T15:39:45.318Z DEBUG modem >> AT+COPS?
2021-06-01T15:39:45.337Z DEBUG modem << +COPS: 0
2021-06-01T15:39:45.340Z DEBUG modem << OK
2021-06-01T15:39:45.353Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:39:45.370Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:39:45.371Z DEBUG modem << OK
2021-06-01T15:39:45.374Z DEBUG modem >> AT+COPS?
2021-06-01T15:39:45.387Z DEBUG modem << +COPS: 0
2021-06-01T15:39:45.389Z DEBUG modem << OK
2021-06-01T15:39:45.392Z DEBUG modem >> AT+CGMI
2021-06-01T15:39:45.406Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:39:45.407Z DEBUG modem << OK
2021-06-01T15:39:45.409Z DEBUG modem >> AT+CGMM
2021-06-01T15:39:45.422Z DEBUG modem << nRF9160-SICA
2021-06-01T15:39:45.423Z DEBUG modem << OK
2021-06-01T15:39:45.426Z DEBUG modem >> AT+CGMR
2021-06-01T15:39:45.439Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:39:45.440Z DEBUG modem << 
2021-06-01T15:39:45.441Z DEBUG modem << OK
2021-06-01T15:39:45.441Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:39:45.443Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:39:45.455Z DEBUG modem << +CEMODE: 2
2021-06-01T15:39:45.456Z DEBUG modem << 
2021-06-01T15:39:45.457Z DEBUG modem << OK
2021-06-01T15:39:45.460Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:39:45.476Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:39:45.477Z DEBUG modem << OK
2021-06-01T15:39:45.488Z DEBUG modem >> AT+CMEE?
2021-06-01T15:39:45.503Z DEBUG modem << +CMEE: 1
2021-06-01T15:39:45.504Z DEBUG modem << OK
2021-06-01T15:39:45.505Z DEBUG modem >> AT+CNEC?
2021-06-01T15:39:45.520Z DEBUG modem << +CNEC: 24
2021-06-01T15:39:45.521Z DEBUG modem << OK
2021-06-01T15:39:45.523Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:39:45.539Z DEBUG modem << +CGEREP: 1,0
2021-06-01T15:39:45.541Z DEBUG modem << OK
2021-06-01T15:39:45.554Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:39:45.570Z DEBUG modem << OK
2021-06-01T15:39:45.573Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:39:45.586Z DEBUG modem << OK
2021-06-01T15:39:45.588Z DEBUG modem >> AT+CEREG?
2021-06-01T15:39:45.605Z DEBUG modem << +CEREG: 5,90,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:39:45.606Z DEBUG modem << 
2021-06-01T15:39:45.607Z DEBUG modem << OK
2021-06-01T15:39:45.610Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:39:45.622Z DEBUG modem << OK
2021-06-01T15:39:45.624Z DEBUG modem >> AT+CESQ
2021-06-01T15:39:45.638Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:39:45.639Z DEBUG modem << 
2021-06-01T15:39:45.640Z DEBUG modem << OK
2021-06-01T15:39:45.643Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:39:45.656Z DEBUG modem << OK
2021-06-01T15:39:45.659Z DEBUG modem >> AT%XSIM?
2021-06-01T15:39:45.672Z DEBUG modem << %XSIM: 0
2021-06-01T15:39:45.674Z DEBUG modem << OK
2021-06-01T15:40:10.141Z DEBUG modem << %XSIM: 1
2021-06-01T15:40:10.156Z DEBUG modem >> AT+CPIN?
2021-06-01T15:40:10.170Z DEBUG modem << +CPIN: READY
2021-06-01T15:40:10.172Z DEBUG modem << OK
2021-06-01T15:40:10.182Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:40:10.197Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:40:10.198Z DEBUG modem << OK
2021-06-01T15:40:10.201Z DEBUG modem >> AT+CIMI
2021-06-01T15:40:10.214Z DEBUG modem << 901288002463551
2021-06-01T15:40:10.215Z DEBUG modem << OK
2021-06-01T15:40:10.215Z INFO IMSIdentity: 901288002463551
2021-06-01T15:40:29.251Z INFO Modem port is opened
2021-06-01T15:40:29.253Z DEBUG modem >> AT+CFUN?
2021-06-01T15:40:29.257Z DEBUG modem << +CFUN: 1
2021-06-01T15:40:29.258Z DEBUG modem << OK
2021-06-01T15:40:29.269Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:40:29.275Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:40:29.276Z DEBUG modem << OK
2021-06-01T15:40:29.278Z DEBUG modem >> AT+CGMI
2021-06-01T15:40:29.288Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:40:29.289Z DEBUG modem << OK
2021-06-01T15:40:29.292Z DEBUG modem >> AT+CGMM
2021-06-01T15:40:29.304Z DEBUG modem << nRF9160-SICA
2021-06-01T15:40:29.305Z DEBUG modem << OK
2021-06-01T15:40:29.307Z DEBUG modem >> AT+CGMR
2021-06-01T15:40:29.312Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:40:29.325Z DEBUG modem << OK
2021-06-01T15:40:29.326Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:40:29.328Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:40:29.343Z DEBUG modem << +CEMODE: 2
2021-06-01T15:40:29.344Z DEBUG modem << OK
2021-06-01T15:40:29.360Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:40:29.372Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:40:29.374Z DEBUG modem << OK
2021-06-01T15:40:29.378Z DEBUG modem >> AT+CMEE?
2021-06-01T15:40:29.389Z DEBUG modem << +CMEE: 0
2021-06-01T15:40:29.391Z DEBUG modem << OK
2021-06-01T15:40:29.393Z DEBUG modem >> AT+CMEE=1
2021-06-01T15:40:29.404Z DEBUG modem << OK
2021-06-01T15:40:29.408Z DEBUG modem >> AT+CNEC?
2021-06-01T15:40:29.425Z DEBUG modem << +CNEC: 0
2021-06-01T15:40:29.427Z DEBUG modem << OK
2021-06-01T15:40:29.436Z DEBUG modem >> AT+CNEC=24
2021-06-01T15:40:29.440Z DEBUG modem << OK
2021-06-01T15:40:29.443Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:40:29.457Z DEBUG modem << +CGEREP: 0,0
2021-06-01T15:40:29.459Z DEBUG modem << OK
2021-06-01T15:40:29.461Z DEBUG modem >> AT+CGDCONT?
2021-06-01T15:40:29.473Z DEBUG modem << OK
2021-06-01T15:40:29.476Z DEBUG modem >> AT+CGACT?
2021-06-01T15:40:29.487Z DEBUG modem << OK
2021-06-01T15:40:29.490Z DEBUG modem >> AT+CGEREP=1
2021-06-01T15:40:29.494Z DEBUG modem << OK
2021-06-01T15:40:29.505Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:40:29.510Z DEBUG modem << OK
2021-06-01T15:40:29.520Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:40:29.524Z DEBUG modem << OK
2021-06-01T15:40:29.527Z DEBUG modem >> AT+CEREG?
2021-06-01T15:40:29.538Z DEBUG modem << +CEREG: 5,4,"FFFE","FFFFFFFF",7,0,0,"00000000","00000000"
2021-06-01T15:40:29.539Z DEBUG modem << OK
2021-06-01T15:40:29.542Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:40:29.554Z DEBUG modem << OK
2021-06-01T15:40:29.558Z DEBUG modem >> AT+CESQ
2021-06-01T15:40:29.572Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:40:29.573Z DEBUG modem << OK
2021-06-01T15:40:29.576Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:40:29.589Z DEBUG modem << OK
2021-06-01T15:40:29.592Z DEBUG modem >> AT%XSIM?
2021-06-01T15:40:29.605Z DEBUG modem << %XSIM: 1
2021-06-01T15:40:29.606Z DEBUG modem << OK
2021-06-01T15:40:29.609Z DEBUG modem >> AT+CPIN?
2021-06-01T15:40:29.622Z DEBUG modem << +CPIN: READY
2021-06-01T15:40:29.623Z DEBUG modem << OK
2021-06-01T15:40:29.626Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:40:29.639Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:40:29.640Z DEBUG modem << OK
2021-06-01T15:40:29.644Z DEBUG modem >> AT+CIMI
2021-06-01T15:40:29.655Z DEBUG modem << 901288002463551
2021-06-01T15:40:29.657Z DEBUG modem << OK
2021-06-01T15:40:29.657Z INFO IMSIdentity: 901288002463551
2021-06-01T15:40:40.337Z DEBUG modem >> AT+COPS=?
2021-06-01T15:41:21.194Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:41:21.205Z DEBUG modem << 
2021-06-01T15:41:21.206Z DEBUG modem << [00:00:59.464,233] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:41:21.207Z DEBUG modem << 
2021-06-01T15:41:21.208Z DEBUG modem << [0m
2021-06-01T15:41:21.214Z DEBUG modem << [00:00:59.475,952] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:41:21.215Z DEBUG modem << [0m
2021-06-01T15:44:50.408Z DEBUG modem << +CME ERROR: 0
2021-06-01T15:44:50.412Z ERROR Network search failed: Error: AT+COPS=?
 failed: phone failure
2021-06-01T15:44:50.421Z DEBUG modem >> AT
2021-06-01T15:44:50.424Z DEBUG modem << OK
2021-06-01T15:44:50.426Z DEBUG modem >> AT+CFUN?
2021-06-01T15:44:50.442Z DEBUG modem << +CFUN: 1
2021-06-01T15:44:50.447Z DEBUG modem << OK
2021-06-01T15:44:50.460Z DEBUG modem >> AT+CFUN=1
2021-06-01T15:44:50.465Z DEBUG modem << OK
2021-06-01T15:44:50.468Z DEBUG modem >> at+cgdcont?
2021-06-01T15:44:50.471Z DEBUG modem << OK
2021-06-01T15:44:50.473Z DEBUG modem >> AT+CGSN=1
2021-06-01T15:44:50.487Z DEBUG modem << +CGSN: "352656106132247"
2021-06-01T15:44:50.488Z DEBUG modem << OK
2021-06-01T15:44:50.492Z DEBUG modem >> AT+CGMI
2021-06-01T15:44:50.503Z DEBUG modem << Nordic Semiconductor ASA
2021-06-01T15:44:50.505Z DEBUG modem << OK
2021-06-01T15:44:50.507Z DEBUG modem >> AT+CGMM
2021-06-01T15:44:50.519Z DEBUG modem << nRF9160-SICA
2021-06-01T15:44:50.520Z DEBUG modem << OK
2021-06-01T15:44:50.523Z DEBUG modem >> AT+CGMR
2021-06-01T15:44:50.527Z DEBUG modem << mfw_nrf9160_1.2.3
2021-06-01T15:44:50.541Z DEBUG modem << 
2021-06-01T15:44:50.542Z DEBUG modem << OK
2021-06-01T15:44:50.543Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.3] SerNr: 352656106132247
2021-06-01T15:44:50.544Z DEBUG modem >> AT+CEMODE?
2021-06-01T15:44:50.553Z DEBUG modem << +CEMODE: 2
2021-06-01T15:44:50.554Z DEBUG modem << OK
2021-06-01T15:44:50.558Z DEBUG modem >> AT%XCBAND=?
2021-06-01T15:44:50.573Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2021-06-01T15:44:50.574Z DEBUG modem << OK
2021-06-01T15:44:50.588Z DEBUG modem >> AT+CMEE?
2021-06-01T15:44:50.592Z DEBUG modem << +CMEE: 1
2021-06-01T15:44:50.593Z DEBUG modem << OK
2021-06-01T15:44:50.603Z DEBUG modem >> AT+CNEC?
2021-06-01T15:44:50.608Z DEBUG modem << +CNEC: 24
2021-06-01T15:44:50.609Z DEBUG modem << OK
2021-06-01T15:44:50.619Z DEBUG modem >> AT+CGEREP?
2021-06-01T15:44:50.624Z DEBUG modem << +CGEREP: 1,0
2021-06-01T15:44:50.625Z DEBUG modem << 
2021-06-01T15:44:50.626Z DEBUG modem << OK
2021-06-01T15:44:50.636Z DEBUG modem >> AT+CIND=1,1,1
2021-06-01T15:44:50.641Z DEBUG modem << OK
2021-06-01T15:44:50.644Z DEBUG modem >> AT+CEREG=5
2021-06-01T15:44:50.654Z DEBUG modem << OK
2021-06-01T15:44:50.656Z DEBUG modem >> AT+CEREG?
2021-06-01T15:44:50.670Z DEBUG modem << +CEREG: 5,2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:44:50.671Z DEBUG modem << OK
2021-06-01T15:44:50.675Z DEBUG modem >> AT%CESQ=1
2021-06-01T15:44:50.687Z DEBUG modem << OK
2021-06-01T15:44:50.691Z DEBUG modem >> AT+CESQ
2021-06-01T15:44:50.705Z DEBUG modem << +CESQ: 99,99,255,255,255,255
2021-06-01T15:44:50.706Z DEBUG modem << OK
2021-06-01T15:44:50.721Z DEBUG modem >> AT%XSIM=1
2021-06-01T15:44:50.725Z DEBUG modem << OK
2021-06-01T15:44:50.727Z DEBUG modem >> AT%XSIM?
2021-06-01T15:44:50.738Z DEBUG modem << %XSIM: 1
2021-06-01T15:44:50.740Z DEBUG modem << OK
2021-06-01T15:44:50.743Z DEBUG modem >> AT+CPIN?
2021-06-01T15:44:50.755Z DEBUG modem << +CPIN: READY
2021-06-01T15:44:50.756Z DEBUG modem << OK
2021-06-01T15:44:50.760Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:44:50.773Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:44:50.774Z DEBUG modem << OK
2021-06-01T15:44:50.778Z DEBUG modem >> AT+CIMI
2021-06-01T15:44:50.789Z DEBUG modem << 901288002463551
2021-06-01T15:44:50.790Z DEBUG modem << OK
2021-06-01T15:44:50.791Z INFO IMSIdentity: 901288002463551
2021-06-01T15:50:02.712Z DEBUG modem >> at+cgdcont?
2021-06-01T15:50:02.726Z DEBUG modem << OK
2021-06-01T15:50:18.167Z DEBUG modem >> at+qcfgext="pdp_type",1,"IP","arkessalp.com","arkessa","arkessa"
2021-06-01T15:50:18.185Z DEBUG modem << +CME ERROR: 0
2021-06-01T15:50:18.186Z ERROR Error: at+qcfgext="pdp_type",1,"IP","arkessalp.com","arkessa","arkessa"
 failed: phone failure
2021-06-01T15:50:22.169Z DEBUG modem << [00:10:00.444,183] [0m<inf> lte_lc: Network connection attempt timed out[0m
2021-06-01T15:50:22.184Z DEBUG modem << +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:50:22.200Z DEBUG modem << [00:10:00.465,454] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 0,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"
2021-06-01T15:50:22.201Z DEBUG modem << [0m
2021-06-01T15:50:22.203Z DEBUG modem << [00:10:00.477,203] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:50:22.218Z DEBUG modem << [0m
2021-06-01T15:50:22.219Z DEBUG modem << %XSIM: 0
2021-06-01T15:50:22.224Z DEBUG modem << [00:10:00.486,236] [0m<inf> lte_lc: Using fallback network mode[0m
2021-06-01T15:50:22.237Z DEBUG modem << [00:10:00.492,340] [0m<dbg> lte_lc.lte_lc_system_mode_set: Sending AT command to set system mode: AT%XSYSTEMMODE=0,1,1,0[0m
2021-06-01T15:50:23.167Z DEBUG modem << %XSIM: 1
2021-06-01T15:50:23.181Z DEBUG modem >> AT+CPIN?
2021-06-01T15:50:23.206Z DEBUG modem << +CPIN: READY
2021-06-01T15:50:23.208Z DEBUG modem << OK
2021-06-01T15:50:23.216Z DEBUG modem >> AT+CPINR="SIM PIN"
2021-06-01T15:50:23.232Z DEBUG modem << +CPINR: "SIM PIN",3
2021-06-01T15:50:23.234Z DEBUG modem << OK
2021-06-01T15:50:23.237Z DEBUG modem >> AT+CIMI
2021-06-01T15:50:23.250Z DEBUG modem << 901288002463551
2021-06-01T15:50:23.251Z DEBUG modem << OK
2021-06-01T15:50:23.252Z INFO IMSIdentity: 901288002463551
2021-06-01T15:51:34.824Z DEBUG modem << %CESQ: 57,2,20,2
2021-06-01T15:51:34.843Z DEBUG modem << +CEREG: 2,"E406","00168A15",9,0,0,"11100000","11100000"
2021-06-01T15:51:34.847Z DEBUG modem << [00:11:13.111,511] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 2,"E406","00168A15",9,0,0,"11100000","11100000"
2021-06-01T15:51:34.848Z DEBUG modem << [0m
2021-06-01T15:51:34.851Z DEBUG modem << [00:11:13.123,229] [0m<dbg> lte_lc.parse_psm_cfg: TAU: -1 sec, active time: -1 sec
2021-06-01T15:51:34.853Z DEBUG modem << [0m
2021-06-01T15:51:35.440Z DEBUG modem << +CSCON: 1
2021-06-01T15:51:35.444Z DEBUG modem << [00:11:13.716,369] [0m<dbg> lte_lc.at_handler: +CSCON notification[0m
2021-06-01T15:51:35.447Z DEBUG modem << %CESQ: 56,2,28,4
2021-06-01T15:51:38.588Z DEBUG modem << +CGEV: ME PDN ACT 0,0
2021-06-01T15:51:38.594Z DEBUG modem << +CNEC_ESM: 50,0
2021-06-01T15:51:38.598Z DEBUG modem >> AT+CGDCONT?
2021-06-01T15:51:38.617Z DEBUG modem << +CEREG: 5,"E406","00168A15",9,,,"11100000","00101000"
2021-06-01T15:51:38.621Z DEBUG modem << [00:11:16.874,694] [0m<dbg> lte_lc.at_handler: +CEREG notification: +CEREG: 5,"E406","00168A15",9,,,"11100000","00101000"
2021-06-01T15:51:38.623Z DEBUG modem << [0m
2021-06-01T15:51:38.624Z DEBUG modem << [00:11:16.886,230] [0m<dbg> lte_lc.parse_psm_cfg: TAU: 28800 sec, active time: -1 sec
2021-06-01T15:51:38.626Z DEBUG modem << [0m
2021-06-01T15:51:38.627Z DEBUG modem << [00:11:16.894,439] [0m<inf> asset_tracker: Connected to LTE network.[0m
2021-06-01T15:51:38.630Z DEBUG modem << [00:11:16.901,000] [0m<inf> asset_tracker: Connecting to cloud, attempt 1 of 8[0m
2021-06-01T15:51:38.632Z DEBUG modem << [00:11:16.908,447] [0m<inf> asset_tracker: Cloud connection request sent.[0m
2021-06-01T15:51:38.659Z DEBUG modem << [00:11:16.915,405] [0m<inf> asset_tracker: Connection response timeout is set to 30 seconds.[0m
2021-06-01T15:51:38.660Z DEBUG modem << +CIND: "service",1
2021-06-01T15:51:38.661Z DEBUG modem << +CIND: "roam",1
2021-06-01T15:51:38.662Z DEBUG modem << [00:11:16.927,612] [0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
2021-06-01T15:51:38.663Z DEBUG modem << +CGDCONT: 0,"IP","arkessalp.com","10.72.6.2",0,0
2021-06-01T15:51:38.663Z DEBUG modem << OK
2021-06-01T15:51:38.683Z DEBUG modem >> AT+CGACT?
2021-06-01T15:51:38.690Z DEBUG modem << +CGACT: 0,1
2021-06-01T15:51:38.692Z DEBUG modem << 
2021-06-01T15:51:38.693Z DEBUG modem << OK
2021-06-01T15:51:39.540Z DEBUG modem << [00:11:17.814,453] [0m<dbg> nrf_cloud_transport.nct_connect: IPv4 address: 34.197.138.70[0m
2021-06-01T15:51:39.549Z DEBUG modem << [00:11:17.822,723] [0m<dbg> nrf_cloud_transport.nct_mqtt_connect: mqtt_connect requesting persistent session[0m
2021-06-01T15:51:41.142Z DEBUG modem << %CESQ: 56,2,22,3
2021-06-01T15:51:42.532Z DEBUG modem << %CESQ: 57,2,27,3
2021-06-01T15:51:50.962Z DEBUG modem << [00:11:29.239,044] [0m<inf> nrf_cloud_transport: Using non-blocking socket[0m
2021-06-01T15:51:50.970Z DEBUG modem << [00:11:29.246,093] [0m<dbg> nrf_cloud.nrf_cloud_run: Cloud connection request sent.[0m
2021-06-01T15:51:52.899Z DEBUG modem << [00:11:31.171,813] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_CONNACK: result -111[0m
2021-06-01T15:51:52.917Z DEBUG modem << [00:11:31.181,060] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 1[0m
2021-06-01T15:51:52.919Z DEBUG modem << [00:11:31.188,720] [0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_ERROR: -111[0m
2021-06-01T15:51:52.921Z DEBUG modem << [00:11:31.196,472] [0m<inf> asset_tracker: CLOUD_EVT_ERROR[0m
2021-06-01T15:51:53.428Z DEBUG modem << [00:11:31.702,331] [0m<dbg> nrf_cloud.nrf_cloud_run: Socket error: POLLNVAL[0m
2021-06-01T15:51:53.435Z DEBUG modem << [00:11:31.709,472] [0m<dbg> nrf_cloud.nrf_cloud_run: The cloud socket was unexpectedly closed.[0m
2021-06-01T15:51:53.452Z DEBUG modem << [00:11:31.718,231] [0m<inf> asset_tracker: CLOUD_EVT_DISCONNECTED: 2[0m
2021-06-01T15:51:53.453Z DEBUG modem << [00:11:31.724,761] [0m<inf> asset_tracker: Cloud connection closed.[0m
2021-06-01T15:51:53.468Z DEBUG modem << [00:11:31.731,201] [0m<inf> asset_tracker: This can occur during initial nRF Cloud provisioning.[0m
2021-06-01T15:51:53.470Z DEBUG modem << [00:11:31.740,173] [0m<inf> asset_tracker: Attempting reconnect in 10 seconds...[0m
2021-06-01T15:51:53.486Z DEBUG modem << [00:11:31.747,772] [0m<dbg> nrf_cloud_transport.nct_disconnect: nct_disconnect[0m
2021-06-01T15:52:00.963Z DEBUG modem << %CESQ: 62,3,26,3
2021-06-01T15:52:03.471Z DEBUG modem << [00:11:41.747,802] [0m<inf> asset_tracker: Connecting to cloud, attempt 2 of 8[0m
2021-06-01T15:52:03.487Z DEBUG modem << [00:11:41.755,249] [0m<inf> asset_tracker: Cloud connection request sent.[0m
2021-06-01T15:52:03.489Z DEBUG modem << [00:11:41.762,207] [0m<inf> asset_tracker: Connection response timeout is set to 30 seconds.[0m
2021-06-01T15:52:03.504Z DEBUG modem << [00:11:41.770,843] [0m<inf> asset_tracker: CLOUD_EVT_CONNECTING[0m
2021-06-01T15:52:03.520Z DEBUG modem << [00:11:41.785,797] [0m<dbg> nrf_cloud_transport.nct_connect: IPv4 address: 34.197.138.70[0m
2021-06-01T15:52:05.617Z DEBUG modem << %CESQ: 57,2,25,3
2021-06-01T15:52:17.442Z DEBUG modem << [00:11:55.718,780] [0m<inf> nrf_cloud_transport: Using non-blocking socket[0m
2021-06-01T15:52:17.460Z DEBUG modem << [00:11:55.725,860] [0m<dbg> nrf_cloud.nrf_cloud_run: Cloud connection request sent.[0m
2021-06-01T15:52:19.491Z DEBUG modem << [00:11:57.765,930] [0m<inf> aws_jobs: Subscribe: $aws/things/nrf-352656106132247/jobs/notify-next[0m
2021-06-01T15:52:19.511Z DEBUG modem << [00:11:57.775,878] [0m<inf> aws_jobs: Subscribe: $aws/things/nrf-352656106132247/jobs/$next/get/#[0m
2021-06-01T15:52:19.512Z DEBUG modem << [00:11:57.785,705] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_CONNACK: result 0[0m
2021-06-01T15:52:19.528Z DEBUG modem << [00:11:57.794,647] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 2[0m
2021-06-01T15:52:19.530Z DEBUG modem << [00:11:57.802,337] [0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTED[0m
2021-06-01T15:52:19.545Z DEBUG modem << [00:11:57.810,760] [0m<inf> asset_tracker: CLOUD_EVT_CONNECTED[0m
2021-06-01T15:52:19.546Z DEBUG modem << [00:11:57.816,772] [0m<inf> asset_tracker: Persistent Sessions = 0[0m
2021-06-01T15:52:19.547Z DEBUG modem << [00:11:57.823,150] [0m<dbg> nrf_cloud_transport.nct_cc_connect: nct_cc_connect[0m
2021-06-01T15:52:19.563Z DEBUG modem << [00:11:57.831,268] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 3[0m
2021-06-01T15:52:21.680Z DEBUG modem << [00:11:59.956,451] [0m<inf> aws_fota: subscribed to notify-next topic[0m
2021-06-01T15:52:21.705Z DEBUG modem << [00:11:59.963,165] [0m<inf> aws_jobs: Publish topic: $aws/things/nrf-352656106132247/jobs/$next/get[0m
2021-06-01T15:52:21.707Z DEBUG modem << [00:11:59.972,351] [0m<inf> aws_jobs: Publish payload {"clientToken": ""}[0m
2021-06-01T15:52:23.558Z DEBUG modem << [00:12:01.832,611] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 2114 result = 0[0m
2021-06-01T15:52:23.619Z DEBUG modem << [00:12:01.892,486] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 1234 result = 0[0m
2021-06-01T15:52:23.626Z DEBUG modem << [00:12:01.902,404] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 4[0m
2021-06-01T15:52:23.645Z DEBUG modem << [00:12:01.910,064] [0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 5678 opcode = 0 len = 0[0m
2021-06-01T15:52:23.647Z DEBUG modem << [00:12:01.920,471] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 5[0m
2021-06-01T15:52:25.605Z DEBUG modem << [00:12:03.878,662] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 64858 result = 0[0m
2021-06-01T15:52:25.700Z DEBUG modem << [00:12:03.972,625] [0m<dbg> aws_fota.on_publish_evt: Received topic: $aws/things/nrf-352656106132247/jobs/$next/get/accepted[0m
2021-06-01T15:52:25.712Z DEBUG modem << [00:12:03.984,008] [0m<inf> aws_fota: Checking for an available job[0m
2021-06-01T15:52:25.717Z DEBUG modem << [00:12:03.990,539] [0m<dbg> aws_fota.get_job_execution: Job doc: {"clientToken":"","timestamp":1622562739}[0m
2021-06-01T15:52:25.731Z DEBUG modem << [00:12:04.000,640] [0m<dbg> aws_fota.get_job_execution: Got only one field[0m
2021-06-01T15:52:25.733Z DEBUG modem << [00:12:04.007,690] [0m<inf> aws_fota: No queued jobs for this device[0m
2021-06-01T15:52:26.932Z DEBUG modem << [00:12:05.206,634] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 5678 result = 0[0m
2021-06-01T15:52:26.960Z DEBUG modem << [00:12:05.216,522] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 5[0m
2021-06-01T15:52:27.029Z DEBUG modem << [00:12:05.303,222] [0m<dbg> aws_fota.on_publish_evt: Received topic: nrf-352656106132247/shadow/get/accepted[0m
2021-06-01T15:52:27.047Z DEBUG modem << [00:12:05.313,201] [0m<dbg> aws_fota.on_publish_evt: received an unhandled MQTT publish event on topic: nrf-352656106132247/shadow/get/accepted[0m
2021-06-01T15:52:27.064Z DEBUG modem << [00:12:05.326,232] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 0 len = 50[0m
2021-06-01T15:52:27.066Z DEBUG modem << [00:12:05.337,524] [0m<dbg> nrf_cloud_transport.nct_cc_send: mqtt_publish: id = 1 opcode = 1 len = 136[0m
2021-06-01T15:52:27.082Z DEBUG modem << [00:12:05.348,724] [0m<dbg> nrf_cloud.nfsm_set_current_state_and_notify: state: 6[0m
2021-06-01T15:52:27.083Z DEBUG modem << [00:12:05.356,384] [0m<dbg> nrf_cloud.api_event_handler: NRF_CLOUD_EVT_USER_ASSOCIATION_REQUEST[0m
2021-06-01T15:52:27.098Z DEBUG modem << [00:12:05.365,234] [0m<inf> asset_tracker: CLOUD_EVT_PAIR_REQUEST[0m
2021-06-01T15:52:27.100Z DEBUG modem << [00:12:05.371,520] [0m<inf> asset_tracker: Add device to cloud account.[0m
2021-06-01T15:52:27.101Z DEBUG modem << [00:12:05.378,295] [0m<inf> asset_tracker: Waiting for cloud association...[0m
2021-06-01T15:52:29.733Z DEBUG modem << [00:12:08.007,202] [0m<dbg> nrf_cloud_transport.nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 1 result = 0[0m
2021-06-01T15:52:52.244Z DEBUG modem << +CSCON: 0
2021-06-01T15:52:52.274Z DEBUG modem << [00:12:30.528,045] [0m<dbg> lte_lc.at_handler: +CSCON notification[0m
2021-06-01T15:52:52.470Z DEBUG modem << %CESQ: 58,2,19,2
2021-06-01T15:52:53.541Z DEBUG modem << %CESQ: 56,2,28,4

[Albrecht Markus Schellenberger]

Greetings!

The applications you are running on your nRF9160 DK are configured to connect to an LTE-M network, which is not supported by the device:

2021-06-01T15:26:53.306Z DEBUG modem << +CEREG: 2,"FFFE","FFFFFFFF",7,0,0,"11100000","11100000"

See the +CEREG command.

<AcT> 7 – E-UTRAN = LTE-M

You have to change your prj.conf as following:

CONFIG_LTE_NETWORK_MODE_LTE_M=n
CONFIG_LTE_NETWORK_MODE_NBIOT=y

or

CONFIG_LTE_NETWORK_MODE_LTE_M_NBIOT_GPS=y

if you want to add GPS support.

I hope this will help you!

Regards,

Markus

[5prinG]

hi Marcus

Yesterday after few hours, the device has recognized VF SIM and registered with NB-IoT

now, this morning i have switched to the testbed SIM card, starting with 99920

This is still not accepting, 

I am trying to set up Band 3, with AT command (below are the example AT commands from Quectel, I could not find the replacement AT commands for nRF9160)

Select Band 3
AT+QCFG=“band”,0,0,4,1
OK

LTE Cat NB1
AT+QCFG=“nwscanseq”,03,1
OK

LTE only
AT+QCFG=“nwscanmode”,3
OK

LTE Cat NB1
at+qcfg=“iotopmode”,1
OK

Define PDP Context
AT+CGDCONT=1,“IP”,“nbiot”
OK

the device is not accepting any AT command, 

i have done few restarts, 

though it is showing a flashing amber on the screen, 

How can I verify that the device is scanning for NB-IoT, 

if it does then it should be showing me a print like this

at+cops=?
+COPS: (1,"999 20","999 20","99920",9),,(0,1,2,3,4),(0,1,2)

2021-06-01T15_24_10.526Z-log-VF-working-private-not.zip

[5prinG]

hi Marcus

Yesterday after few hours, the device has recognized VF SIM and registered with NB-IoT

now, this morning i have switched to the testbed SIM card, starting with 99920

This is still not accepting, 

I am trying to set up Band 3, with AT command (below are the example AT commands from Quectel, I could not find the replacement AT commands for nRF9160)

Select Band 3
AT+QCFG=“band”,0,0,4,1
OK

LTE Cat NB1
AT+QCFG=“nwscanseq”,03,1
OK

LTE only
AT+QCFG=“nwscanmode”,3
OK

LTE Cat NB1
at+qcfg=“iotopmode”,1
OK

Define PDP Context
AT+CGDCONT=1,“IP”,“nbiot”
OK

the device is not accepting any AT command, 

i have done few restarts, 

though it is showing a flashing amber on the screen, 

How can I verify that the device is scanning for NB-IoT, 

if it does then it should be showing me a print like this

at+cops=?
+COPS: (1,"999 20","999 20","99920",9),,(0,1,2,3,4),(0,1,2)0871.2021-06-01T15_24_10.526Z-log-VF-working-private-not.zip

[Albrecht Markus Schellenberger]

Thanks for the feedback! Which application are using for your AT-commands?

Regards,

Markus