Hello,
I am currently testing the reception of a Thingy 91 (hardware rev 1.5) in the Netherlands using the asset tracker v2 code.
It is running the stock code, but I have included the debug Kconfig in the build options to help with troubleshooting.
Upon initial power up, the device appears to connect to the network without issue. However, after allowing it to go back to sleep (where it only feeds the watchdog), I often encounter connection failures when attempting to reconnect by pressing the button.It seems to timeout/run out of retrys.
I am wondering if there are any network settings that can be adjusted to improve this behavior.
For context, the Thingy is situated in front of a window to allow better reception.
This is the log file from the LTE Link Monitor:
2023-05-02T12:44:39.710Z DEBUG Application data folder: /Users/huubsmeitink/Library/Application Support/nrfconnect/pc-nrfconnect-linkmonitor
2023-05-02T12:44:40.568Z INFO Using nrf-device-lib-js version: 0.6.5
2023-05-02T12:44:40.569Z INFO Using nrf-device-lib version: 0.14.7
2023-05-02T12:44:40.569Z INFO Using nrfjprog DLL version: 10.19.1
2023-05-02T12:44:40.569Z INFO Using JLink version: JLink_V7.58b
2023-05-02T12:44:40.601Z DEBUG App pc-nrfconnect-linkmonitor v2.0.3 local
2023-05-02T12:44:40.601Z DEBUG App path: /Users/huubsmeitink/.nrfconnect-apps/node_modules/pc-nrfconnect-linkmonitor
2023-05-02T12:44:40.601Z DEBUG nRFConnect 4.0.1, required by the app is (>=4.0.0)
2023-05-02T12:44:40.601Z DEBUG nRFConnect path: /Applications/nRF Connect.app/Contents/Resources/app.asar
2023-05-02T12:44:40.602Z DEBUG HomeDir: /Users/huubsmeitink
2023-05-02T12:44:40.602Z DEBUG TmpDir: /var/folders/8j/zrt67lcj3_d0tk2ryvygj6h00000gn/T/
2023-05-02T12:44:40.604Z INFO Installed JLink version does not match the provided version (V7.80c)
2023-05-02T12:44:56.460Z INFO Modem port is opened
2023-05-02T12:44:56.471Z DEBUG modem >> AT+CFUN?
2023-05-02T12:44:56.495Z DEBUG modem << +CFUN: 1
2023-05-02T12:44:56.499Z DEBUG modem << OK
2023-05-02T12:44:56.518Z DEBUG modem >> AT+CGSN=1
2023-05-02T12:44:56.533Z DEBUG modem << +CGSN: "352656106116307"
2023-05-02T12:44:56.537Z DEBUG modem << OK
2023-05-02T12:44:56.545Z DEBUG modem >> AT+CGMI
2023-05-02T12:44:56.554Z DEBUG modem << Nordic Semiconductor ASA
2023-05-02T12:44:56.558Z DEBUG modem << OK
2023-05-02T12:44:56.567Z DEBUG modem >> AT+CGMM
2023-05-02T12:44:56.577Z DEBUG modem << nRF9160-SICA
2023-05-02T12:44:56.581Z DEBUG modem << OK
2023-05-02T12:44:56.585Z DEBUG modem >> AT+CGMR
2023-05-02T12:44:56.604Z DEBUG modem << mfw_nrf9160_1.2.1
2023-05-02T12:44:56.607Z DEBUG modem << OK
2023-05-02T12:44:56.610Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.1] SerNr: 352656106116307
2023-05-02T12:44:56.614Z DEBUG modem >> AT+CEMODE?
2023-05-02T12:44:56.631Z DEBUG modem << +CEMODE: 2
2023-05-02T12:44:56.634Z DEBUG modem << OK
2023-05-02T12:44:56.649Z DEBUG modem >> AT%XCBAND=?
2023-05-02T12:44:56.669Z DEBUG modem << %XCBAND: (1,2,3,4,5,8,12,13,18,19,20,25,26,28,66)
2023-05-02T12:44:56.672Z DEBUG modem << OK
2023-05-02T12:44:56.689Z DEBUG modem >> AT+CMEE?
2023-05-02T12:44:56.697Z DEBUG modem << +CMEE: 0
2023-05-02T12:44:56.700Z DEBUG modem << OK
2023-05-02T12:44:56.705Z DEBUG modem >> AT+CMEE=1
2023-05-02T12:44:56.714Z DEBUG modem << OK
2023-05-02T12:44:56.717Z DEBUG modem >> AT+CNEC?
2023-05-02T12:44:56.728Z DEBUG modem << +CNEC: 16
2023-05-02T12:44:56.730Z DEBUG modem << OK
2023-05-02T12:44:56.734Z DEBUG modem >> AT+CNEC=24
2023-05-02T12:44:56.746Z DEBUG modem << OK
2023-05-02T12:44:56.749Z DEBUG modem >> AT+CGEREP?
2023-05-02T12:44:56.762Z DEBUG modem << +CGEREP: 1,0
2023-05-02T12:44:56.765Z DEBUG modem << OK
2023-05-02T12:44:56.768Z DEBUG modem >> AT+CIND=1,1,1
2023-05-02T12:44:56.797Z DEBUG modem << OK
2023-05-02T12:44:56.813Z DEBUG modem >> AT+CEREG=5
2023-05-02T12:44:56.832Z DEBUG modem << OK
2023-05-02T12:44:56.836Z DEBUG modem >> AT+CEREG?
2023-05-02T12:44:56.868Z DEBUG modem << +CEREG: 5,1,"7EF6","011ED70D",7,,,"00001010","00100001"
2023-05-02T12:44:56.872Z DEBUG modem << OK
2023-05-02T12:44:56.914Z DEBUG modem >> AT+COPS=3,2
2023-05-02T12:44:56.933Z DEBUG modem << OK
2023-05-02T12:44:56.937Z DEBUG modem >> AT+COPS?
2023-05-02T12:44:56.954Z DEBUG modem << +COPS: 0,2,"20408",7
2023-05-02T12:44:56.958Z DEBUG modem << OK
2023-05-02T12:44:56.976Z DEBUG modem >> AT%XCBAND
2023-05-02T12:44:57.011Z DEBUG modem << %XCBAND: 20
2023-05-02T12:44:57.014Z DEBUG modem << OK
2023-05-02T12:44:57.029Z DEBUG modem >> AT+CGDCONT?
2023-05-02T12:44:57.041Z DEBUG modem << +CGDCONT: 0,"IP","IBASIS.IOT","10.160.147.175",0,0
2023-05-02T12:44:57.044Z DEBUG modem << OK
2023-05-02T12:44:57.054Z DEBUG modem >> AT+CGACT?
2023-05-02T12:44:57.065Z DEBUG modem << +CGACT: 0,1
2023-05-02T12:44:57.068Z DEBUG modem << OK
2023-05-02T12:44:57.076Z DEBUG modem >> AT%CESQ=1
2023-05-02T12:44:57.088Z DEBUG modem << OK
2023-05-02T12:44:57.099Z DEBUG modem >> AT+CESQ
2023-05-02T12:44:57.117Z DEBUG modem << +CESQ: 99,99,255,255,24,66
2023-05-02T12:44:57.121Z DEBUG modem << OK
2023-05-02T12:44:57.140Z DEBUG modem >> AT%XSIM=1
2023-05-02T12:44:57.157Z DEBUG modem << OK
2023-05-02T12:44:57.161Z DEBUG modem >> AT%XSIM?
2023-05-02T12:44:57.180Z DEBUG modem << %XSIM: 1
2023-05-02T12:44:57.183Z DEBUG modem << OK
2023-05-02T12:44:57.194Z DEBUG modem >> AT+CPIN?
2023-05-02T12:44:57.209Z DEBUG modem << +CPIN: READY
2023-05-02T12:44:57.212Z DEBUG modem << OK
2023-05-02T12:44:57.221Z DEBUG modem >> AT+CPINR="SIM PIN"
2023-05-02T12:44:57.244Z DEBUG modem << +CPINR: "SIM PIN",3
2023-05-02T12:44:57.246Z DEBUG modem << OK
2023-05-02T12:44:57.252Z DEBUG modem >> AT+CIMI
2023-05-02T12:44:57.268Z DEBUG modem << 204080813637970
2023-05-02T12:44:57.270Z DEBUG modem << OK
2023-05-02T12:44:57.273Z INFO IMSIdentity: 204080813637970
2023-05-02T12:45:00.242Z DEBUG modem << %CESQ: 67,3,20,2
2023-05-02T12:45:08.215Z DEBUG modem << +CSCON: 0
2023-05-02T12:45:08.270Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:45:08.315Z DEBUG modem << +CSCON: 1
2023-05-02T12:45:09.226Z DEBUG modem << [00:00:22.430,603] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_AGPS_NEEDED[0m
2023-05-02T12:45:22.606Z DEBUG modem << +CSCON: 0
2023-05-02T12:45:34.790Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:45:42.610Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:45:42.617Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:45:52.375Z DEBUG modem >> AT+COPS=?
2023-05-02T12:45:59.042Z DEBUG modem << [00:01:12.247,314] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_INACTIVITY_DETECTED[0m
2023-05-02T12:46:45.190Z DEBUG modem << %CESQ: 63,3,20,2
2023-05-02T12:46:45.194Z DEBUG modem << %CESQ: 63,3,20,2
2023-05-02T12:46:45.714Z DEBUG modem << +CSCON: 1
2023-05-02T12:46:46.146Z DEBUG modem << [00:01:59.340,850] [0m<inf> app_event_manager: DATA_EVT_DATA_READY[0m
2023-05-02T12:46:46.149Z DEBUG modem << [00:01:59.356,079] [0m<inf> app_event_manager: DATA_EVT_DATA_SEND_BATCH[0m
2023-05-02T12:46:46.151Z DEBUG modem << [00:01:59.356,903] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:47:06.189Z DEBUG modem << +COP+CSCON: 0
2023-05-02T12:47:06.192Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:47:06.194Z DEBUG modem << S: (2,"","","20408",7),(1,"","","20404",7)
2023-05-02T12:47:06.197Z DEBUG modem << OK
2023-05-02T12:47:06.208Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.227Z DEBUG modem << +CESQ: 99,99,255,255,20,63
2023-05-02T12:47:06.230Z DEBUG modem << OK
2023-05-02T12:47:06.249Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.267Z DEBUG modem << +CESQ: 99,99,255,255,20,63
2023-05-02T12:47:06.269Z DEBUG modem << OK
2023-05-02T12:47:06.288Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.302Z DEBUG modem << +CESQ: 99,99,255,255,20,63
2023-05-02T12:47:06.304Z DEBUG modem << OK
2023-05-02T12:47:06.324Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.343Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.345Z DEBUG modem << OK
2023-05-02T12:47:06.353Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.371Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.373Z DEBUG modem << OK
2023-05-02T12:47:06.382Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.399Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.402Z DEBUG modem << OK
2023-05-02T12:47:06.422Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.439Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.442Z DEBUG modem << OK
2023-05-02T12:47:06.449Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.467Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.470Z DEBUG modem << OK
2023-05-02T12:47:06.487Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.521Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.526Z DEBUG modem << OK
2023-05-02T12:47:06.551Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.569Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.571Z DEBUG modem << OK
2023-05-02T12:47:06.593Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.613Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.616Z DEBUG modem << OK
2023-05-02T12:47:06.628Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.644Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.647Z DEBUG modem << OK
2023-05-02T12:47:06.656Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.673Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.676Z DEBUG modem << OK
2023-05-02T12:47:06.686Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.703Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.705Z DEBUG modem << OK
2023-05-02T12:47:06.713Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.733Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.735Z DEBUG modem << OK
2023-05-02T12:47:06.753Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.771Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.774Z DEBUG modem << OK
2023-05-02T12:47:06.782Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.804Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.807Z DEBUG modem << OK
2023-05-02T12:47:06.823Z DEBUG modem >> AT+COPS?
2023-05-02T12:47:06.845Z DEBUG modem << +COPS: 0,2,"20408",7
2023-05-02T12:47:06.848Z DEBUG modem << OK
2023-05-02T12:47:06.855Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:06.872Z DEBUG modem << +CESQ: 99,99,255,255,17,64
2023-05-02T12:47:06.875Z DEBUG modem << OK
2023-05-02T12:47:07.226Z DEBUG modem << [00:02:20.406,616] [1;33m<wrn> location: Failed to initiate neighbor cell measurements: -14, next: fallback to get modem parameters[0m
2023-05-02T12:47:07.229Z DEBUG modem << [00:02:20.407,562] [1;31m<err> location: Location acquisition failed and fallbacks are also done[0m
2023-05-02T12:47:07.247Z DEBUG modem << [00:02:20.407,653] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_TIMEOUT[0m
2023-05-02T12:47:07.250Z DEBUG modem << [00:02:20.408,111] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_INACTIVE[0m
2023-05-02T12:47:08.778Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:08.795Z DEBUG modem << +CESQ: 99,99,255,255,15,63
2023-05-02T12:47:08.798Z DEBUG modem << OK
2023-05-02T12:47:10.776Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:10.794Z DEBUG modem << +CESQ: 99,99,255,255,20,63
2023-05-02T12:47:10.797Z DEBUG modem << OK
2023-05-02T12:47:12.776Z DEBUG modem >> AT+CESQ
2023-05-02T12:47:12.803Z DEBUG modem << +CESQ: 99,99,255,255,20,63
2023-05-02T12:47:12.806Z DEBUG modem << OK
2023-05-02T12:47:17.034Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:47:17.042Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:47:25.697Z DEBUG modem << [00:02:38.858,856] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_ACTIVITY_DETECTED[0m
2023-05-02T12:47:25.701Z DEBUG modem << [00:02:38.859,191] [0m<inf> app_event_manager: APP_EVT_DATA_GET_ALL[0m
2023-05-02T12:47:25.719Z DEBUG modem << [00:02:38.859,863] [0m<inf> app_event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, BAT, ENV, LOCATION)[0m
2023-05-02T12:47:25.721Z DEBUG modem << [00:02:38.860,504] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_ACTIVE[0m
2023-05-02T12:47:25.725Z DEBUG modem << [00:02:38.863,800] [0m<inf> app_event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2023-05-02T12:47:25.728Z DEBUG modem << [00:02:38.946,350] [0m<inf> app_event_manager: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2023-05-02T12:47:25.730Z DEBUG modem << [00:02:38.959,045] [0m<inf> app_event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
2023-05-02T12:47:37.550Z DEBUG modem << %CESQ: 67,3,23,3
2023-05-02T12:47:37.559Z DEBUG modem << %CESQ: 67,3,23,3
2023-05-02T12:47:38.074Z DEBUG modem << +CSCON: 1
2023-05-02T12:47:38.499Z DEBUG modem << [00:02:51.689,117] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T12:47:38.503Z DEBUG modem << [00:02:51.689,453] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T12:47:38.505Z DEBUG modem << [00:02:51.691,131] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T12:47:38.506Z DEBUG modem << [00:02:51.691,955] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:47:51.345Z DEBUG modem << +CSCON: 0
2023-05-02T12:47:54.305Z DEBUG modem << [00:03:07.495,422] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T12:47:54.308Z DEBUG modem << [00:03:07.495,666] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T12:47:54.310Z DEBUG modem << [00:03:07.497,344] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T12:47:54.312Z DEBUG modem << [00:03:07.498,199] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:48:03.509Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:48:03.555Z DEBUG modem << +CSCON: 1
2023-05-02T12:48:03.557Z DEBUG modem << %CESQ: 63,3,21,3
2023-05-02T12:48:16.925Z DEBUG modem << +CSCON: 0
2023-05-02T12:48:24.749Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:48:36.928Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:48:36.935Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:48:54.789Z DEBUG modem << %CESQ: 64,3,11,1
2023-05-02T12:48:54.798Z DEBUG modem << %CESQ: 64,3,11,1
2023-05-02T12:48:55.313Z DEBUG modem << +CSCON: 1
2023-05-02T12:48:55.688Z DEBUG modem << [00:04:08.884,338] [1;33m<wrn> location: Failed to initiate neighbor cell measurements: -14, next: fallback to get modem parameters[0m
2023-05-02T12:48:55.707Z DEBUG modem << [00:04:08.885,314] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_NEIGHBOR_CELLS_DATA_READY[0m
2023-05-02T12:48:55.730Z DEBUG modem << [00:04:08.885,833] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_INACTIVE[0m
2023-05-02T12:48:55.733Z DEBUG modem << [00:04:08.886,688] [0m<inf> app_event_manager: DATA_EVT_DATA_READY[0m
2023-05-02T12:48:55.735Z DEBUG modem << [00:04:08.889,709] [0m<inf> app_event_manager: DATA_EVT_NEIGHBOR_CELLS_DATA_SEND[0m
2023-05-02T12:48:55.737Z DEBUG modem << [00:04:08.898,742] [0m<inf> app_event_manager: DATA_EVT_DATA_SEND_BATCH[0m
2023-05-02T12:48:55.742Z DEBUG modem << [00:04:08.899,566] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:48:55.744Z DEBUG modem << [00:04:08.899,841] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:48:56.665Z DEBUG modem << %CESQ: 64,3,16,2
2023-05-02T12:48:59.128Z DEBUG modem << [00:04:12.292,572] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_INACTIVITY_DETECTED[0m
2023-05-02T12:48:59.131Z DEBUG modem << [00:04:12.292,907] [0m<inf> app_event_manager: APP_EVT_DATA_GET_ALL[0m
2023-05-02T12:48:59.133Z DEBUG modem << [00:04:12.293,579] [0m<inf> app_event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, BAT, ENV, LOCATION)[0m
2023-05-02T12:48:59.158Z DEBUG modem << [00:04:12.294,219] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_ACTIVE[0m
2023-05-02T12:48:59.160Z DEBUG modem << [00:04:12.297,515] [0m<inf> app_event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2023-05-02T12:48:59.163Z DEBUG modem << [00:04:12.401,489] [0m<inf> app_event_manager: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2023-05-02T12:48:59.165Z DEBUG modem << [00:04:12.460,479] [0m<inf> app_event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
2023-05-02T12:48:59.224Z DEBUG modem << %CESQ: 64,3,21,3
2023-05-02T12:49:08.797Z DEBUG modem << +CSCON: 0
2023-05-02T12:49:08.831Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:49:22.001Z DEBUG modem << %CESQ: 64,3,16,2
2023-05-02T12:49:28.804Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:49:28.812Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:50:38.909Z DEBUG modem << %CESQ: 65,3,8,1
2023-05-02T12:50:38.918Z DEBUG modem << %CESQ: 65,3,8,1
2023-05-02T12:50:39.464Z DEBUG modem << +CSCON: 1
2023-05-02T12:50:39.467Z DEBUG modem << %CESQ: 66,3,18,2
2023-05-02T12:50:39.862Z DEBUG modem << [00:05:53.022,888] [1;33m<wrn> location: Failed to initiate neighbor cell measurements: -14, next: fallback to get modem parameters[0m
2023-05-02T12:50:39.889Z DEBUG modem << [00:05:53.024,047] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_NEIGHBOR_CELLS_DATA_READY[0m
2023-05-02T12:50:39.892Z DEBUG modem << [00:05:53.024,566] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_INACTIVE[0m
2023-05-02T12:50:39.895Z DEBUG modem << [00:05:53.025,421] [0m<inf> app_event_manager: DATA_EVT_DATA_READY[0m
2023-05-02T12:50:39.897Z DEBUG modem << [00:05:53.028,411] [0m<inf> app_event_manager: DATA_EVT_NEIGHBOR_CELLS_DATA_SEND[0m
2023-05-02T12:50:39.901Z DEBUG modem << [00:05:53.037,536] [0m<inf> app_event_manager: DATA_EVT_DATA_SEND_BATCH[0m
2023-05-02T12:50:39.904Z DEBUG modem << [00:05:53.038,360] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:50:39.906Z DEBUG modem << [00:05:53.038,635] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:50:44.144Z DEBUG modem << %CESQ: 65,3,18,2
2023-05-02T12:50:52.757Z DEBUG modem << +CSCON: 0
2023-05-02T12:50:52.787Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:51:12.785Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:51:12.792Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:54:12.556Z DEBUG modem << [00:09:25.730,499] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_ACTIVITY_DETECTED[0m
2023-05-02T12:54:12.559Z DEBUG modem << [00:09:25.730,834] [0m<inf> app_event_manager: APP_EVT_DATA_GET_ALL[0m
2023-05-02T12:54:12.561Z DEBUG modem << [00:09:25.731,506] [0m<inf> app_event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, BAT, ENV, LOCATION)[0m
2023-05-02T12:54:12.588Z DEBUG modem << [00:09:25.732,147] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_ACTIVE[0m
2023-05-02T12:54:12.590Z DEBUG modem << [00:09:25.735,443] [0m<inf> app_event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2023-05-02T12:54:12.593Z DEBUG modem << [00:09:25.817,901] [0m<inf> app_event_manager: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2023-05-02T12:54:12.595Z DEBUG modem << [00:09:25.830,291] [0m<inf> app_event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
2023-05-02T12:54:18.828Z DEBUG modem << %CESQ: 63,3,17,2
2023-05-02T12:54:18.837Z DEBUG modem << %CESQ: 63,3,17,2
2023-05-02T12:54:19.351Z DEBUG modem << +CSCON: 1
2023-05-02T12:54:19.756Z DEBUG modem << [00:09:32.959,564] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T12:54:19.782Z DEBUG modem << [00:09:32.959,808] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T12:54:19.784Z DEBUG modem << [00:09:32.961,486] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T12:54:19.787Z DEBUG modem << [00:09:32.962,341] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:54:21.479Z DEBUG modem << %CESQ: 63,3,22,3
2023-05-02T12:54:32.651Z DEBUG modem << +CSCON: 0
2023-05-02T12:54:44.828Z DEBUG modem << %CESQ: 63,3,16,2
2023-05-02T12:54:44.837Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:54:52.721Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:54:52.729Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:55:26.328Z DEBUG modem << [00:10:39.551,971] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_INACTIVITY_DETECTED[0m
2023-05-02T12:55:41.627Z DEBUG modem << %CESQ: 62,3,14,2
2023-05-02T12:55:41.637Z DEBUG modem << %CESQ: 62,3,14,2
2023-05-02T12:55:42.201Z DEBUG modem << +CSCON: 1
2023-05-02T12:55:42.585Z DEBUG modem << [00:10:55.756,134] [1;33m<wrn> location: Failed to initiate neighbor cell measurements: -14, next: fallback to get modem parameters[0m
2023-05-02T12:55:42.617Z DEBUG modem << [00:10:55.757,110] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_NEIGHBOR_CELLS_DATA_READY[0m
2023-05-02T12:55:42.620Z DEBUG modem << [00:10:55.757,629] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_INACTIVE[0m
2023-05-02T12:55:42.623Z DEBUG modem << [00:10:55.758,483] [0m<inf> app_event_manager: DATA_EVT_DATA_READY[0m
2023-05-02T12:55:42.626Z DEBUG modem << [00:10:55.761,474] [0m<inf> app_event_manager: DATA_EVT_NEIGHBOR_CELLS_DATA_SEND[0m
2023-05-02T12:55:42.629Z DEBUG modem << [00:10:55.770,599] [0m<inf> app_event_manager: DATA_EVT_DATA_SEND_BATCH[0m
2023-05-02T12:55:42.632Z DEBUG modem << [00:10:55.771,423] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:55:42.639Z DEBUG modem << [00:10:55.771,697] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:55:42.684Z DEBUG modem << %CESQ: 62,3,19,2
2023-05-02T12:55:50.726Z DEBUG modem << %CESQ: 62,3,24,3
2023-05-02T12:55:53.579Z DEBUG modem << +CSCON: 0
2023-05-02T12:55:53.625Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:55:53.678Z DEBUG modem << %CESQ: 62,3,19,2
2023-05-02T12:56:13.604Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:56:13.640Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:58:24.346Z DEBUG modem << %CESQ: 64,3,16,2
2023-05-02T12:58:24.355Z DEBUG modem << %CESQ: 64,3,16,2
2023-05-02T12:58:24.870Z DEBUG modem << +CSCON: 1
2023-05-02T12:58:25.281Z DEBUG modem << [00:13:38.491,699] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T12:58:25.283Z DEBUG modem << [00:13:38.491,943] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T12:58:25.286Z DEBUG modem << [00:13:38.493,621] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T12:58:25.289Z DEBUG modem << [00:13:38.494,476] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:58:27.157Z DEBUG modem << %CESQ: 64,3,21,3
2023-05-02T12:58:39.293Z DEBUG modem << +CSCON: 0
2023-05-02T12:58:39.345Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:58:42.397Z DEBUG modem << [00:13:55.580,871] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_ACTIVITY_DETECTED[0m
2023-05-02T12:58:42.400Z DEBUG modem << [00:13:55.581,207] [0m<inf> app_event_manager: APP_EVT_DATA_GET_ALL[0m
2023-05-02T12:58:42.430Z DEBUG modem << [00:13:55.581,878] [0m<inf> app_event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, BAT, ENV, LOCATION)[0m
2023-05-02T12:58:42.432Z DEBUG modem << [00:13:55.582,519] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_ACTIVE[0m
2023-05-02T12:58:42.434Z DEBUG modem << [00:13:55.587,219] [0m<inf> app_event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2023-05-02T12:58:42.437Z DEBUG modem << [00:13:55.660,522] [0m<inf> app_event_manager: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2023-05-02T12:58:42.439Z DEBUG modem << [00:13:55.690,826] [0m<inf> app_event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
2023-05-02T12:58:43.278Z DEBUG modem << %CESQ: 58,2,19,2
2023-05-02T12:58:43.918Z DEBUG modem << %CESQ: 57,2,21,3
2023-05-02T12:58:45.198Z DEBUG modem << %CESQ: 51,2,21,3
2023-05-02T12:58:47.758Z DEBUG modem << %CESQ: 52,2,20,2
2023-05-02T12:58:50.958Z DEBUG modem << %CESQ: 56,2,21,3
2023-05-02T12:58:52.878Z DEBUG modem << %CESQ: 62,3,21,3
2023-05-02T12:58:59.314Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:58:59.326Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:59:30.190Z DEBUG modem << *** Booting Zephyr OS build v3.2.99-ncs1 ***
2023-05-02T12:59:30.345Z DEBUG modem << [00:00:01.455,261] [0m<dbg> watchdog: watchdog_timeout_install: Watchdog timeout installed. Timeout: 60[0m
2023-05-02T12:59:30.349Z DEBUG modem << [00:00:01.455,291] [0m<dbg> watchdog: watchdog_start: Watchdog started[0m
2023-05-02T12:59:30.380Z DEBUG modem << [00:00:01.455,322] [0m<dbg> watchdog: watchdog_feed_enable: Watchdog feed enabled. Timeout: 30000[0m
2023-05-02T12:59:30.382Z DEBUG modem << [00:00:01.455,718] [0m<inf> app_event_manager: APP_EVT_START[0m
2023-05-02T12:59:30.385Z DEBUG modem << [00:00:01.455,780] [0m<dbg> location_module: state_set: State: STATE_INIT[0m
2023-05-02T12:59:30.389Z DEBUG modem << [00:00:01.455,902] [0m<dbg> ui_module: state_set: State transition STATE_INIT --> STATE_RUNNING[0m
2023-05-02T12:59:30.392Z DEBUG modem << [00:00:01.455,932] [0m<dbg> ui_module: sub_state_set: Sub state: SUB_STATE_ACTIVE[0m
2023-05-02T12:59:30.394Z DEBUG modem << [00:00:01.455,963] [0m<dbg> ui_module: sub_sub_state_set: Sub state: SUB_SUB_STATE_LOCATION_INACTIVE[0m
2023-05-02T12:59:30.397Z DEBUG modem << [00:00:01.456,054] [0m<dbg> util_module: state_set: State: STATE_INIT[0m
2023-05-02T12:59:30.400Z DEBUG modem << [00:00:01.456,573] [0m<dbg> cloud_module: state_set: State: STATE_LTE_INIT[0m
2023-05-02T12:59:30.403Z DEBUG modem << [00:00:01.456,604] [0m<dbg> cloud_module: sub_state_set: Sub state: SUB_STATE_CLOUD_DISCONNECTED[0m
2023-05-02T12:59:30.406Z DEBUG modem << [00:00:01.456,787] [0m<dbg> data_module: state_set: State: STATE_CLOUD_DISCONNECTED[0m
2023-05-02T12:59:30.409Z DEBUG modem << [00:00:01.457,122] [0m<dbg> modem_module: state_set: State transition STATE_INIT --> STATE_DISCONNECTED[0m
2023-05-02T12:59:30.412Z DEBUG modem << [00:00:01.457,183] [0m<inf> app_event_manager: MODEM_EVT_INITIALIZED[0m
2023-05-02T12:59:30.448Z DEBUG modem << [00:00:01.457,824] [0m<dbg> location: location_core_init: Initialized 'GNSS' method successfully[0m
2023-05-02T12:59:30.450Z DEBUG modem << [00:00:01.457,916] [0m<dbg> location: location_core_init: Initialized 'Cellular' method successfully[0m
2023-05-02T12:59:30.452Z DEBUG modem << [00:00:01.457,946] [0m<dbg> location: location_init: Location library initialized[0m
2023-05-02T12:59:30.455Z DEBUG modem << [00:00:01.457,977] [0m<dbg> location_module: state_set: State transition STATE_INIT --> STATE_RUNNING[0m
2023-05-02T12:59:30.458Z DEBUG modem << [00:00:01.458,282] [0m<dbg> sensor_module: state_set: State: STATE_INIT[0m
2023-05-02T12:59:30.504Z DEBUG modem << [00:00:01.610,473] [0m<dbg> cloud_module: state_set: State transition STATE_LTE_INIT --> STATE_LTE_DISCONNECTED[0m
2023-05-02T12:59:30.507Z DEBUG modem << [00:00:01.617,462] [0m<dbg> nrf_cloud_transport: nct_client_id_set: client_id = nrf-352656106116307[0m
2023-05-02T12:59:30.509Z DEBUG modem << [00:00:01.617,889] [0m<dbg> nrf_cloud_transport: nct_topics_populate: accepted_topic: nrf-352656106116307/shadow/get/accepted[0m
2023-05-02T12:59:30.511Z DEBUG modem << [00:00:01.617,919] [0m<dbg> nrf_cloud_transport: nct_topics_populate: rejected_topic: $aws/things/nrf-352656106116307/shadow/get/rejected[0m
2023-05-02T12:59:30.513Z DEBUG modem << [00:00:01.617,980] [0m<dbg> nrf_cloud_transport: nct_topics_populate: update_delta_topic: $aws/things/nrf-352656106116307/shadow/update/delta[0m
2023-05-02T12:59:30.515Z DEBUG modem << [00:00:01.618,011] [0m<dbg> nrf_cloud_transport: nct_topics_populate: update_topic: $aws/things/nrf-352656106116307/shadow/update[0m
2023-05-02T12:59:30.518Z DEBUG modem << [00:00:01.618,072] [0m<dbg> nrf_cloud_transport: nct_topics_populate: shadow_get_topic: $aws/things/nrf-352656106116307/shadow/get[0m
2023-05-02T12:59:30.520Z DEBUG modem << [00:00:01.618,103] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 1[0m
2023-05-02T12:59:30.522Z DEBUG modem << [00:00:01.618,133] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: ********************************************[0m
2023-05-02T12:59:30.567Z DEBUG modem << [00:00:01.618,133] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: The Asset Tracker v2 has started[0m
2023-05-02T12:59:30.570Z DEBUG modem << [00:00:01.618,164] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: Version: 0.0.0-development[0m
2023-05-02T12:59:30.573Z DEBUG modem << [00:00:01.618,225] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: Cloud: nRF Cloud[0m
2023-05-02T12:59:30.578Z DEBUG modem << [00:00:01.618,255] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: Endpoint: mqtt.nrfcloud.com[0m
2023-05-02T12:59:30.581Z DEBUG modem << [00:00:01.618,286] [0m<dbg> nrf_cloud_integration: cloud_wrap_init: ********************************************[0m
2023-05-02T12:59:30.584Z DEBUG modem << [00:00:01.618,316] [0m<dbg> qos: qos_init: Registering handler 0x1e7cd[0m
2023-05-02T12:59:31.240Z DEBUG modem << [00:00:01.776,611] [0m<dbg> modem_module: configure_low_power: PSM requested[0m
2023-05-02T12:59:31.244Z DEBUG modem << [00:00:01.777,099] [1;33m<wrn> modem_module: lte_lc_modem_events_enable failed, error: -14[0m
2023-05-02T12:59:31.246Z DEBUG modem << [00:00:01.777,130] [0m<dbg> modem_module: setup: Modem firmware versions older than 1.3.0 do not support enabling modem domain events[0m
2023-05-02T12:59:31.283Z DEBUG modem << [00:00:01.827,270] [0m<inf> app_event_manager: MODEM_EVT_LTE_CONNECTING[0m
2023-05-02T12:59:31.285Z DEBUG modem << [00:00:01.827,514] [0m<dbg> ui_module: state_set: State transition STATE_RUNNING --> STATE_LTE_CONNECTING[0m
2023-05-02T12:59:31.417Z DEBUG modem << [00:00:01.828,338] [0m<dbg> modem_module: state_set: State transition STATE_DISCONNECTED --> STATE_CONNECTING[0m
2023-05-02T12:59:31.420Z DEBUG modem << [00:00:02.457,092] [0m<dbg> data_module: setup: Failed retrieveing the device configuration from flash in time[0m
2023-05-02T12:59:31.422Z DEBUG modem << [00:00:02.457,092] [0m<dbg> date_time: date_time_core_register_handler: Registering handler 0x22859[0m
2023-05-02T12:59:31.462Z DEBUG modem << [00:00:02.457,153] [0m<dbg> data_module: config_print_all: Device mode: Passive[0m
2023-05-02T12:59:31.464Z DEBUG modem << [00:00:02.457,183] [0m<dbg> data_module: config_print_all: Active wait timeout: 120[0m
2023-05-02T12:59:31.467Z DEBUG modem << [00:00:02.457,183] [0m<dbg> data_module: config_print_all: Movement resolution: 120[0m
2023-05-02T12:59:31.469Z DEBUG modem << [00:00:02.457,244] [0m<dbg> data_module: config_print_all: Movement timeout: 3600[0m
2023-05-02T12:59:31.471Z DEBUG modem << [00:00:02.457,244] [0m<dbg> data_module: config_print_all: Location timeout: 300[0m
2023-05-02T12:59:31.474Z DEBUG modem << [00:00:02.457,275] [0m<dbg> data_module: config_print_all: Accelerometer act threshold: 4.00[0m
2023-05-02T12:59:31.476Z DEBUG modem << [00:00:02.457,275] [0m<dbg> data_module: config_print_all: Accelerometer inact threshold: 4.00[0m
2023-05-02T12:59:31.480Z DEBUG modem << [00:00:02.457,305] [0m<dbg> data_module: config_print_all: Accelerometer inact timeout: 60.00[0m
2023-05-02T12:59:31.483Z DEBUG modem << [00:00:02.457,336] [0m<dbg> data_module: config_print_all: Requesting of neighbor cell data is enabled[0m
2023-05-02T12:59:31.484Z DEBUG modem << [00:00:02.457,336] [0m<dbg> data_module: config_print_all: Requesting of GNSS data is enabled[0m
2023-05-02T12:59:31.486Z DEBUG modem << [00:00:02.457,427] [0m<inf> app_event_manager: DATA_EVT_CONFIG_INIT[0m
2023-05-02T12:59:31.525Z DEBUG modem << [00:00:02.457,519] [0m<dbg> ui_module: sub_state_set: Sub state transition SUB_STATE_ACTIVE --> SUB_STATE_PASSIVE[0m
2023-05-02T12:59:31.528Z DEBUG modem << [00:00:02.458,007] [0m<dbg> main: passive_mode_timers_start_all: Device mode: Passive[0m
2023-05-02T12:59:31.531Z DEBUG modem << [00:00:02.458,007] [0m<dbg> main: passive_mode_timers_start_all: Start movement timeout: 3600 seconds interval[0m
2023-05-02T12:59:31.534Z DEBUG modem << [00:00:02.458,038] [0m<dbg> main: passive_mode_timers_start_all: 120 seconds until movement can trigger a new data sample/publication[0m
2023-05-02T12:59:31.536Z DEBUG modem << [00:00:02.458,129] [0m<dbg> main: state_set: State transition STATE_INIT --> STATE_RUNNING[0m
2023-05-02T12:59:31.539Z DEBUG modem << [00:00:02.458,160] [0m<dbg> main: sub_state_set: Sub state transition SUB_STATE_ACTIVE_MODE --> SUB_STATE_PASSIVE_MODE[0m
2023-05-02T12:59:31.945Z DEBUG modem << %CESQ: 61,3,12,1
2023-05-02T12:59:31.954Z DEBUG modem << %CESQ: 63,3,14,2
2023-05-02T12:59:31.961Z DEBUG modem << +CEREG: 2,"7EF6","011ED70D",7,0,0,"11100000","11100000"
2023-05-02T12:59:32.010Z DEBUG modem << +CSCON: 1
2023-05-02T12:59:32.012Z DEBUG modem << %CESQ: 65,3,20,2
2023-05-02T12:59:32.189Z DEBUG modem << %CESQ: 61,3,17,2
2023-05-02T12:59:32.493Z DEBUG modem << [00:00:02.682,098] [0m<dbg> sensor_module: state_set: State transition STATE_INIT --> STATE_RUNNING[0m
2023-05-02T12:59:32.496Z DEBUG modem << [00:00:03.203,674] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -79[0m
2023-05-02T12:59:32.498Z DEBUG modem << [00:00:03.205,352] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -77[0m
2023-05-02T12:59:32.501Z DEBUG modem << [00:00:03.211,090] [0m<dbg> modem_module: lte_evt_handler: LTE cell changed: Cell ID: 18798349, Tracking area: 32502[0m
2023-05-02T12:59:32.503Z DEBUG modem << [00:00:03.211,303] [0m<inf> app_event_manager: MODEM_EVT_LTE_CELL_UPDATE[0m
2023-05-02T12:59:32.504Z DEBUG modem << [00:00:03.254,974] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T12:59:32.506Z DEBUG modem << [00:00:03.256,683] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -75[0m
2023-05-02T12:59:32.510Z DEBUG modem << [00:00:03.454,620] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -79[0m
2023-05-02T12:59:33.205Z DEBUG modem << +CGEV: ME PDN ACT 0,0
2023-05-02T12:59:33.214Z DEBUG modem << +CNEC_ESM: 50,0
2023-05-02T12:59:33.219Z DEBUG modem << +CEREG: 1,"7EF6","011ED70D",7,,,"00001010","00100001"
2023-05-02T12:59:33.266Z DEBUG modem >> AT+CGDCONT?
2023-05-02T12:59:33.269Z DEBUG modem << %XTIME: "80","32502021953380","01"
2023-05-02T12:59:33.314Z DEBUG modem << [00:00:04.463,592] [0m<dbg> modem_module: pdn_event_handler: PDN_EVENT_ACTIVATED[0m
2023-05-02T12:59:33.317Z DEBUG modem << [00:00:04.465,118] [1;31m<err> modem_module: Event: PDP context 0, PDN type IPv4 only allowed[0m
2023-05-02T12:59:33.319Z DEBUG modem << [00:00:04.470,306] [0m<dbg> modem_module: lte_evt_handler: Network registration status: Connected - home network[0m
2023-05-02T12:59:33.322Z DEBUG modem << [00:00:04.471,221] [0m<dbg> modem_module: lte_evt_handler: PSM parameter update: TAU: 3600, Active time: 20[0m
2023-05-02T12:59:33.325Z DEBUG modem << [00:00:04.474,487] [0m<dbg> date_time: date_time_core_current_check: Date time never set[0m
2023-05-02T12:59:33.327Z DEBUG modem << [00:00:04.474,517] [0m<dbg> date_time: date_time_at_xtime_handler: Time obtained from cellular network (XTIME notification)[0m
2023-05-02T12:59:33.330Z DEBUG modem << [00:00:04.474,548] [0m<dbg> date_time: date_time_core_sc+CGDCONT: 0,"IP","IBASIS.IOT","10.160.159.111",0,0
2023-05-02T12:59:33.332Z DEBUG modem << OK
2023-05-02T12:59:33.334Z DEBUG modem << hedule_update: New periodic date time update in: 14400 seconds[0m
2023-05-02T12:59:33.336Z DEBUG modem << [00:00:04.474,578] [0m<dbg> date_time: date_time_core_store: System time updated: 2023-05-02 12:59:33[0m
2023-05-02T12:59:33.387Z DEBUG modem >> AT+COPS=3,2
2023-05-02T12:59:33.390Z DEBUG modem << [00:00:04.474,639] [0m<dbg> date_time: date_time_core_register_handler: Previously registered handler (nil) de-registered[0m
2023-05-02T12:59:33.393Z DEBUG modem << [00:00:04.474,700] [0m<inf> app_event_manager: MODEM_EVT_LTE_CONNECTED[0m
2023-05-02T12:59:33.395Z DEBUG modem << [00:00:04.474,945] [0m<dbg> ui_module: state_set: State transition STATE_LTE_CONNECTING --> STATE_RUNNING[0m
2023-05-02T12:59:33.398Z DEBUG modem << [00:00:04.475,524] [0m<inf> app_event_manager: MODEM_EVT_LTE_PSM_UPDATE[0m
2023-05-02T12:59:33.400Z DEBUG modem << [00:00:04.476,196] [0m<inf> app_event_manager: DATA_EVT_DATE_TIME_OBTAINED[0m
2023-05-02T12:59:33.402Z DEBUG modem << [00:00:04.477,081] [0m<dbg> modem_module: state_set: State transition STATE_CONNECTING --> STATE_CONNECTED[0m
2023-05-02T12:59:33.463Z DEBUG modem << OK
2023-05-02T12:59:33.527Z DEBUG modem >> AT+CGACT?
2023-05-02T12:59:33.586Z DEBUG modem << [00:00:04.609,466] [0m<dbg> cloud_module: state_set: State transition STATE_LTE_DISCONNECTED --> STATE_LTE_CONNECTED[0m
2023-05-02T12:59:33.589Z DEBUG modem << [00:00:04.609,497] [0m<dbg> cloud_module: connect_cloud: Connecting to cloud[0m
2023-05-02T12:59:33.592Z DEBUG modem << [00:00:04.609,527] [0m<dbg> cloud_module: connect_cloud: Cloud connection establishment in progress[0m
2023-05-02T12:59:33.596Z DEBUG modem << [00:00:04.609,558] [0m<dbg> cloud_module: connect_cloud: New connection attempt in 32 seconds if not successful[0m
2023-05-02T12:59:33.599Z DEBUG modem << [00:00:04.609,710] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 1[0m
2023-05-02T12:59:33.602Z DEBUG modem << [00:00:04.609,710] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTING[0m
2023-05-02T12:59:33.604Z DEBUG modem << [00:00:04.609,741] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_CONNECTING[0m
2023-05-02T12:59:33.606Z DEBUG modem << [00:00:04.609,832] [0m<inf> app_event_manager: CLOUD_EVT_CONNECTING[0m
2023-05-02T12:59:33.609Z DEBUG modem << [00:00:04.610,107] [0m<dbg> ui_module: state_set: State transition STATE_RUNNING --> STATE_CLOUD_CONNECTING[0m
2023-05-02T12:59:33.612Z DEBUG modem << [00:00:04.717,315] [0m<d+CGACT: 0,1
2023-05-02T12:59:33.615Z DEBUG modem << OK
2023-05-02T12:59:33.678Z DEBUG modem >> AT+COPS?
2023-05-02T12:59:33.682Z DEBUG modem << bg> nrf_cloud_transport: nct_connect: IPv4 address: 44.199.26.17[0m
2023-05-02T12:59:33.685Z DEBUG modem << [00:00:04.717,376] [0m<dbg> nrf_cloud_transport: nct_mqtt_connect: MQTT clean session flag: 1[0m
2023-05-02T12:59:33.688Z DEBUG modem << %CESQ: 61,3,22,3
2023-05-02T12:59:33.752Z DEBUG modem << +COPS: 0,2,"20408",7
2023-05-02T12:59:33.756Z DEBUG modem << OK
2023-05-02T12:59:33.823Z DEBUG modem >> AT%XCBAND
2023-05-02T12:59:33.884Z DEBUG modem << %XCBAND: 20
2023-05-02T12:59:33.888Z DEBUG modem << OK
2023-05-02T12:59:33.966Z DEBUG modem >> AT+CGDCONT?
2023-05-02T12:59:34.033Z DEBUG modem << +CGDCONT: 0,"IP","IBASIS.IOT","10.160.159.111",0,0
2023-05-02T12:59:34.036Z DEBUG modem << OK
2023-05-02T12:59:34.051Z DEBUG modem >> AT+CGACT?
2023-05-02T12:59:34.108Z DEBUG modem << +CGACT: 0,1
2023-05-02T12:59:34.111Z DEBUG modem << OK
2023-05-02T12:59:34.626Z DEBUG modem << [00:00:04.880,676] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -79[0m
2023-05-02T12:59:37.479Z DEBUG modem << [00:00:08.165,618] [0m<dbg> nrf_cloud_transport: nct_mqtt_connect: Using socket send timeout of 60 seconds[0m
2023-05-02T12:59:37.482Z DEBUG modem << [00:00:08.165,679] [0m<dbg> nrf_cloud: nrf_cloud_run: Cloud connection request sent[0m
2023-05-02T12:59:37.530Z DEBUG modem << [00:00:08.418,579] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_CONNACK: result 0[0m
2023-05-02T12:59:37.532Z DEBUG modem << [00:00:08.418,579] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 2[0m
2023-05-02T12:59:37.534Z DEBUG modem << [00:00:08.418,609] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_TRANSPORT_CONNECTED[0m
2023-05-02T12:59:37.537Z DEBUG modem << [00:00:08.418,640] [0m<dbg> nrf_cloud_transport: nct_cc_connect: nct_cc_connect[0m
2023-05-02T12:59:37.539Z DEBUG modem << [00:00:08.419,616] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 3[0m
2023-05-02T12:59:37.542Z DEBUG modem << [00:00:08.648,376] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 100 result = 0[0m
2023-05-02T12:59:37.544Z DEBUG modem << [00:00:08.648,406] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 4[0m
2023-05-02T12:59:37.546Z DEBUG modem << [00:00:08.648,437] [0m<dbg> nrf_cloud_transport: nct_cc_send: mqtt_publish: id = 200 opcode = 0 len = 0[0m
2023-05-02T12:59:37.549Z DEBUG modem << [00:00:08.649,291] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 5[0m
2023-05-02T12:59:37.707Z DEBUG modem << Decoded message:
2023-05-02T12:59:37.711Z DEBUG modem << {
2023-05-02T12:59:37.713Z DEBUG modem << "desired":{
2023-05-02T12:59:37.715Z DEBUG modem << "pairing":{
2023-05-02T12:59:37.717Z DEBUG modem << "state":"paired",
2023-05-02T12:59:37.719Z DEBUG modem << "topics":{
2023-05-02T12:59:37.721Z DEBUG modem << "d2c":"prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/m/d/nrf-352656106116307/d2c",
2023-05-02T12:59:37.770Z DEBUG modem << "c2d":"prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/m/d/nrf-352656106116307/+/r"
2023-05-02T12:59:37.773Z DEBUG modem << }
2023-05-02T12:59:37.775Z DEBUG modem << },
2023-05-02T12:59:37.777Z DEBUG modem << "nrfcloud_mqtt_topic_prefix":"prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/"
2023-05-02T12:59:37.780Z DEBUG modem << },
2023-05-02T12:59:37.782Z DEBUG modem << "config":{
2023-05-02T12:59:37.785Z DEBUG modem << "activeMode":false,
2023-05-02T12:59:37.788Z DEBUG modem << "locationTimeout":300,
2023-05-02T12:59:37.791Z DEBUG modem << "activeWaitTime":120,
2023-05-02T12:59:37.793Z DEBUG modem << "movementResolution":120,
2023-05-02T12:59:37.796Z DEBUG modem << "movementTimeout":3600,
2023-05-02T12:59:37.799Z DEBUG modem << "accThreshAct":4,
2023-05-02T12:59:37.802Z DEBUG modem << "accThreshInact":4,
2023-05-02T12:59:37.804Z DEBUG modem << "accTimeoutInact":60,
2023-05-02T12:59:37.806Z DEBUG modem << "nod":[]
2023-05-02T12:59:37.808Z DEBUG modem << }
2023-05-02T12:59:37.811Z DEBUG modem << }
2023-05-02T12:59:37.863Z DEBUG modem << Encoded message:
2023-05-02T12:59:37.865Z DEBUG modem << {
2023-05-02T12:59:37.868Z DEBUG modem << "state":{
2023-05-02T12:59:37.870Z DEBUG modem << "reported":{
2023-05-02T12:59:37.873Z DEBUG modem << "config":{
2023-05-02T12:59:37.876Z DEBUG modem << "activeMode":false,
2023-05-02T12:59:37.878Z DEBUG modem << "locationTimeout":300,
2023-05-02T12:59:37.881Z DEBUG modem << "activeWaitTime":120,
2023-05-02T12:59:37.884Z DEBUG modem << "movementResolution":120,
2023-05-02T12:59:37.886Z DEBUG modem << "movementTimeout":3600,
2023-05-02T12:59:37.889Z DEBUG modem << "accThreshAct":4,
2023-05-02T12:59:37.891Z DEBUG modem << "accThreshInact":4,
2023-05-02T12:59:37.893Z DEBUG modem << "accTimeoutInact":60,
2023-05-02T12:59:37.895Z DEBUG modem << "nod":[]
2023-05-02T12:59:37.897Z DEBUG modem << }
2023-05-02T12:59:37.899Z DEBUG modem << }
2023-05-02T12:59:37.901Z DEBUG modem << }
2023-05-02T12:59:37.902Z DEBUG modem << }
2023-05-02T12:59:37.904Z DEBUG modem << [00:00:08.803,527] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 200 result = 0[0m
2023-05-02T12:59:37.971Z DEBUG modem << [00:00:08.803,558] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 5[0m
2023-05-02T12:59:37.974Z DEBUG modem << [00:00:08.914,184] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 8064 len = 470, topic = nrf-352656106116307/shadow/get/accepted[0m
2023-05-02T12:59:37.977Z DEBUG modem << [00:00:08.915,710] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 5[0m
2023-05-02T12:59:37.980Z DEBUG modem << [00:00:08.915,740] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_RX_DATA_SHADOW[0m
2023-05-02T12:59:37.984Z DEBUG modem << [00:00:08.915,771] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_DATA_RECEIVED[0m
2023-05-02T12:59:37.987Z DEBUG modem << [00:00:08.972,869] [0m<dbg> cloud_module: config_data_handle: Device configuration encoded[0m
2023-05-02T12:59:37.990Z DEBUG modem << [00:00:08.972,930] [0m<inf> app_event_manager: CLOUD_EVT_CONFIG_RECEIVED[0m
2023-05-02T12:59:37.993Z DEBUG modem << [00:00:08.976,562] [0m<dbg> nrf_cloud_transport: nct_dc_endpoint_set: nct_dc_endpoint_set[0m
2023-05-02T12:59:37.996Z DEBUG modem << [00:00:08.977,050] [0m<dbg> nrf_cloud_transport: nct_dc_endpoint_get: nct_dc_endpoint_get[0m
2023-05-02T12:59:38.000Z DEBUG modem << [00:00:08.978,485] [0m<dbg> nrf_cloud_transport: nct_cc_send: mqtt_publish: id = 301 opcode = 1 len = 361[0m
2023-05-02T12:59:38.069Z DEBUG modem << [00:00:08.978,668] [0m<dbg> data_module: new_config_handle: No new values in incoming device configuration update message[0m
2023-05-02T12:59:38.073Z DEBUG modem << [00:00:08.978,668] [0m<dbg> data_module: new_config_handle: Acknowledge currently applied configuration back to cloud[0m
2023-05-02T12:59:38.077Z DEBUG modem << [00:00:09.010,925] [0m<inf> app_event_manager: DATA_EVT_CONFIG_SEND[0m
2023-05-02T12:59:38.080Z DEBUG modem << [00:00:09.139,739] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_NEW[0m
2023-05-02T12:59:38.083Z DEBUG modem << [00:00:09.139,831] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T12:59:38.086Z DEBUG modem << [00:00:09.140,045] [0m<dbg> qos: qos_message_print: Notified count: 1[0m
2023-05-02T12:59:38.089Z DEBUG modem << [00:00:09.140,045] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T12:59:38.092Z DEBUG modem << [00:00:09.140,075] [0m<dbg> qos: qos_message_print: Message ID: 15000[0m
2023-05-02T12:59:38.095Z DEBUG modem << [00:00:09.140,075] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c848[0m
2023-05-02T12:59:38.098Z DEBUG modem << [00:00:09.140,106] [0m<dbg> qos: qos_message_print: Message Buffer length: 211[0m
2023-05-02T12:59:38.100Z DEBUG modem << [00:00:09.140,136] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T12:59:38.183Z DEBUG modem << [00:00:09.140,136] [0m<dbg> qos: qos_message_print: Message type: 6[0m
2023-05-02T12:59:38.187Z DEBUG modem << [00:00:09.140,167] [0m<dbg> nrf_cloud_transport: nct_cc_send: mqtt_publish: id = 15000 opcode = 1 len = 211[0m
2023-05-02T12:59:38.190Z DEBUG modem << [00:00:09.140,441] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 7[0m
2023-05-02T12:59:38.193Z DEBUG modem << [00:00:09.140,502] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_USER_ASSOCIATED[0m
2023-05-02T12:59:38.760Z DEBUG modem << [00:00:09.608,428] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 301 result = 0[0m
2023-05-02T12:59:38.819Z DEBUG modem << [00:00:09.608,459] [0m<dbg> nrf_cloud_transport: nct_dc_connect: nct_dc_connect[0m
2023-05-02T12:59:38.821Z DEBUG modem << [00:00:09.609,130] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 8[0m
2023-05-02T12:59:38.824Z DEBUG modem << [00:00:09.928,436] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 15000 result = 0[0m
2023-05-02T12:59:38.826Z DEBUG modem << [00:00:09.928,436] [0m<dbg> nrf_cloud_fsm: cc_tx_ack_handler: Data ACK for user tag: 15000[0m
2023-05-02T12:59:38.829Z DEBUG modem << [00:00:09.928,466] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 8[0m
2023-05-02T12:59:38.832Z DEBUG modem << [00:00:09.928,497] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_SENSOR_DATA_ACK[0m
2023-05-02T12:59:38.834Z DEBUG modem << [00:00:09.928,527] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_DATA_ACK: 15000[0m
2023-05-02T12:59:38.837Z DEBUG modem << [00:00:09.928,527] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_REMOVED_FROM_LIST[0m
2023-05-02T12:59:38.838Z DEBUG modem << [00:00:09.928,558] [0m<dbg> cloud_module: qos_event_handler: Freeing pointer: 0x2001c848[0m
2023-05-02T12:59:38.840Z DEBUG modem << [00:00:09.928,588] [0m<dbg> qos: qos_message_remove: QoS list is empty, cancel ongoing delayed work[0m
2023-05-02T12:59:38.923Z DEBUG modem << [00:00:10.129,425] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_SUBACK: id = 101 result = 0[0m
2023-05-02T12:59:38.927Z DEBUG modem << [00:00:10.130,279] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 9[0m
2023-05-02T12:59:38.929Z DEBUG modem << [00:00:10.130,310] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_READY[0m
2023-05-02T12:59:38.932Z DEBUG modem << [00:00:10.131,195] [0m<dbg> nrf_cloud_transport: nct_cc_send: mqtt_publish: id = 1000 opcode = 1 len = 134[0m
2023-05-02T12:59:38.934Z DEBUG modem << [00:00:10.132,873] [0m<dbg> nrf_cloud_integration: send_service_info: nRF Cloud service info sent[0m
2023-05-02T12:59:39.160Z DEBUG modem << [00:00:10.132,904] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_CONNECTED[0m
2023-05-02T12:59:39.164Z DEBUG modem << [00:00:10.132,965] [0m<inf> app_event_manager: CLOUD_EVT_CONNECTED[0m
2023-05-02T12:59:39.166Z DEBUG modem << [00:00:10.133,239] [0m<dbg> ui_module: state_set: State transition STATE_CLOUD_CONNECTING --> STATE_RUNNING[0m
2023-05-02T12:59:39.224Z DEBUG modem << [00:00:10.133,941] [0m<inf> app_event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, BAT, ENV, MOD_STAT, LOCATION)[0m
2023-05-02T12:59:39.227Z DEBUG modem << [00:00:10.134,002] [0m<dbg> location_module: search_start: Requesting location...[0m
2023-05-02T12:59:39.229Z DEBUG modem << [00:00:10.134,033] [0m<dbg> location: location_core_config_log: Location configuration:[0m
2023-05-02T12:59:39.232Z DEBUG modem << [00:00:10.134,063] [0m<dbg> location: location_core_config_log: Methods count: 2[0m
2023-05-02T12:59:39.234Z DEBUG modem << [00:00:10.134,094] [0m<dbg> location: location_core_config_log: Interval: 0[0m
2023-05-02T12:59:39.236Z DEBUG modem << [00:00:10.134,094] [0m<dbg> location: location_core_config_log: Timeout: 300000ms[0m
2023-05-02T12:59:39.238Z DEBUG modem << [00:00:10.134,124] [0m<dbg> location: location_core_config_log: Mode: 0[0m
2023-05-02T12:59:39.241Z DEBUG modem << [00:00:10.134,124] [0m<dbg> location: location_core_config_log: List of methods:[0m
2023-05-02T12:59:39.243Z DEBUG modem << [00:00:10.134,155] [0m<dbg> location: location_core_config_log: Method #0[0m
2023-05-02T12:59:39.245Z DEBUG modem << [00:00:10.134,185] [0m<dbg> location: location_core_config_log: Method type: GNSS (2)[0m
2023-05-02T12:59:39.248Z DEBUG modem << [00:00:10.134,216] [0m<dbg> location: location_core_config_log: Timeout: 90000ms[0m
2023-05-02T12:59:39.310Z DEBUG modem << [00:00:10.134,246] [0m<dbg> location: location_core_config_log: Accuracy: normal (1)[0m
2023-05-02T12:59:39.312Z DEBUG modem << [00:00:10.134,246] [0m<dbg> location: location_core_config_log: Method #1[0m
2023-05-02T12:59:39.315Z DEBUG modem << [00:00:10.134,307] [0m<dbg> location: location_core_config_log: Method type: Cellular (1)[0m
2023-05-02T12:59:39.317Z DEBUG modem << [00:00:10.134,307] [0m<dbg> location: location_core_config_log: Timeout: 11000ms[0m
2023-05-02T12:59:39.319Z DEBUG modem << [00:00:10.134,338] [0m<dbg> location: location_core_config_log: Service: Any (0)[0m
2023-05-02T12:59:39.321Z DEBUG modem << [00:00:10.134,399] [0m<dbg> location: location_core_location_get_pos: Requesting location with 'GNSS' method[0m
2023-05-02T12:59:39.324Z DEBUG modem << [00:00:10.134,490] [0m<dbg> location: location_core_location_get_pos: Starting request timer with timeout=300000[0m
2023-05-02T12:59:39.326Z DEBUG modem << [00:00:10.135,040] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_ACTIVE[0m
2023-05-02T12:59:39.329Z DEBUG modem << [00:00:10.135,131] [0m<dbg> ui_module: sub_sub_state_set: Sub state transition SUB_SUB_STATE_LOCATION_INACTIVE --> SUB_SUB_STATE_LOCATION_ACTIVE[0m
2023-05-02T12:59:39.331Z DEBUG modem << [00:00:10.135,528] [0m<dbg> location_module: sub_state_set: Sub state transition SUB_STATE_IDLE --> SUB_STATE_SEARCH[0m
2023-05-02T12:59:39.396Z DEBUG modem << [00:00:10.136,199] [0m<dbg> cloud_module: sub_state_set: Sub state transition SUB_STATE_CLOUD_DISCONNECTED --> SUB_STATE_CLOUD_CONNECTED[0m
2023-05-02T12:59:39.399Z DEBUG modem << [00:00:10.136,657] [0m<dbg> data_module: state_set: State transition STATE_CLOUD_DISCONNECTED --> STATE_CLOUD_CONNECTED[0m
2023-05-02T12:59:39.402Z DEBUG modem << [00:00:10.137,359] [0m<dbg> location: method_gnss_request_assistance: A-GPS request from modem (ephe: 0xffffffff alm: 0xffffffff flags: 0x3b)[0m
2023-05-02T12:59:39.404Z DEBUG modem << %CESQ: 58,2,23,3
2023-05-02T12:59:40.010Z DEBUG modem << %CESQ: 56,2,22,3
2023-05-02T12:59:40.018Z DEBUG modem << [00:00:10.427,490] [0m<inf> app_event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2023-05-02T12:59:40.083Z DEBUG modem << [00:00:10.427,825] [0m<dbg> cloud_codec_ringbuffer: cloud_codec_populate_sensor_buffer: Entry: 1 of 9 in sensor buffer filled[0m
2023-05-02T12:59:40.085Z DEBUG modem << [00:00:10.431,823] [0m<dbg> location: method_gnss_allowed_to_start: Waiting for the RRC connection release...[0m
2023-05-02T12:59:40.088Z DEBUG modem << [00:00:10.515,533] [0m<inf> app_event_manager: MODEM_EVT_MODEM_STATIC_DATA_READY[0m
2023-05-02T12:59:40.090Z DEBUG modem << [00:00:10.545,898] [0m<inf> app_event_manager: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2023-05-02T12:59:40.093Z DEBUG modem << [00:00:10.546,813] [0m<dbg> cloud_codec_ringbuffer: cloud_codec_populate_modem_dynamic_buffer: Entry: 1 of 2 in dynamic modem buffer filled[0m
2023-05-02T12:59:40.096Z DEBUG modem << [00:00:10.566,925] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -82[0m
2023-05-02T12:59:40.099Z DEBUG modem << [00:00:10.578,338] [0m<inf> app_event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
2023-05-02T12:59:40.101Z DEBUG modem << [00:00:10.579,193] [0m<dbg> cloud_codec_ringbuffer: cloud_codec_populate_bat_buffer: Entry: 1 of 2 in battery buffer filled[0m
2023-05-02T12:59:40.103Z DEBUG modem << [00:00:10.728,790] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 1000 result = 0[0m
2023-05-02T12:59:40.170Z DEBUG modem << [00:00:11.169,860] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -84[0m
2023-05-02T12:59:43.464Z DEBUG modem << %CESQ: 61,3,22,3
2023-05-02T12:59:44.475Z DEBUG modem << [00:00:14.729,949] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -79[0m
2023-05-02T12:59:49.309Z DEBUG modem << %CESQ: 56,2,22,3
2023-05-02T12:59:49.689Z DEBUG modem << %CESQ: 61,3,22,3
2023-05-02T12:59:49.698Z DEBUG modem << [00:00:19.934,082] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -84[0m
2023-05-02T12:59:49.700Z DEBUG modem << [00:00:20.934,143] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -79[0m
2023-05-02T12:59:51.262Z DEBUG modem << +CSCON: 0
2023-05-02T12:59:51.321Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T12:59:51.389Z DEBUG modem << +CSCON: 1
2023-05-02T12:59:52.362Z DEBUG modem << [00:00:22.527,648] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T12:59:52.365Z DEBUG modem << [00:00:22.531,188] [0m<dbg> location: location_core_timer_start: Starting timer with timeout=90000[0m
2023-05-02T12:59:52.438Z DEBUG modem << [00:00:22.531,250] [0m<dbg> location: location_core_event_cb_agps_request: Request A-GPS data from application: ephe 0xffffffff, alm 0xffffffff, data_flags 0x3b[0m
2023-05-02T12:59:52.442Z DEBUG modem << [00:00:22.531,250] [0m<dbg> location_module: location_event_handler: Requested A-GPS data[0m
2023-05-02T12:59:52.455Z DEBUG modem << [00:00:22.531,341] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_AGPS_NEEDED[0m
2023-05-02T12:59:52.457Z DEBUG modem << [00:00:22.566,009] [0m<dbg> nrf_cloud_codec: json_send_to_cloud: Created request: {"appId":"AGPS","messageType":"DATA","data":{"mcc":204,"mnc":8,"tac":32502,"eci":18798349,"rsrp":-140,"types":[1,2,3,4,6,7,8,9]}}[0m
2023-05-02T12:59:52.459Z DEBUG modem << [00:00:22.569,030] [0m<dbg> nrf_cloud_codec: json_send_to_cloud: Request sent to cloud[0m
2023-05-02T12:59:52.462Z DEBUG modem << [00:00:22.569,183] [0m<dbg> data_module: agps_request_handle: A-GPS request sent[0m
2023-05-02T12:59:52.464Z DEBUG modem << [00:00:22.637,329] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T12:59:52.466Z DEBUG modem << [00:00:23.589,385] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:54.008Z DEBUG modem << [00:00:24.202,941] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 1001 result = 0[0m
2023-05-02T12:59:54.011Z DEBUG modem << [00:00:24.592,742] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:54.072Z DEBUG modem << [00:00:24.683,227] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 1 len = 1183, topic = prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/m/d/nrf-352656106116307/agps/r[0m
2023-05-02T12:59:54.075Z DEBUG modem << [00:00:24.711,181] [0m<dbg> nrf_cloud_fsm: agps_process: A-GPS data processed[0m
2023-05-02T12:59:54.078Z DEBUG modem << [00:00:24.779,541] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 2 len = 1945, topic = prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/m/d/nrf-352656106116307/agps/r[0m
2023-05-02T12:59:54.081Z DEBUG modem << [00:00:24.836,547] [0m<dbg> nrf_cloud_fsm: agps_process: A-GPS data processed[0m
2023-05-02T12:59:55.350Z DEBUG modem << [00:00:25.592,864] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:55.354Z DEBUG modem << [00:00:26.602,722] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:57.370Z DEBUG modem << [00:00:27.612,640] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:57.374Z DEBUG modem << [00:00:28.622,497] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T12:59:57.829Z DEBUG modem << %CESQ: 66,3,22,3
2023-05-02T12:59:58.851Z DEBUG modem << [00:00:29.095,336] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -74[0m
2023-05-02T12:59:58.924Z DEBUG modem << [00:00:29.632,354] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:00.407Z DEBUG modem << [00:00:30.642,303] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:00.411Z DEBUG modem << [00:00:31.455,413] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:00:00.482Z DEBUG modem << [00:00:31.651,153] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:02.408Z DEBUG modem << [00:00:32.651,062] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:02.489Z DEBUG modem << [00:00:33.660,919] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:03.269Z DEBUG modem << %CESQ: 57,2,23,3
2023-05-02T13:00:04.291Z DEBUG modem << [00:00:34.535,491] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -83[0m
2023-05-02T13:00:04.294Z DEBUG modem << [00:00:34.670,776] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:05.426Z DEBUG modem << [00:00:35.680,725] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:05.518Z DEBUG modem << [00:00:36.690,643] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:06.771Z DEBUG modem << +CSCON: 0
2023-05-02T13:00:07.465Z DEBUG modem << [00:00:37.700,683] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:07.467Z DEBUG modem << [00:00:38.027,832] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:00:07.469Z DEBUG modem << [00:00:38.070,129] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:08.829Z DEBUG modem << [00:00:39.072,113] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:08.833Z DEBUG modem << [00:00:40.071,380] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:10.828Z DEBUG modem << [00:00:41.070,892] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:10.832Z DEBUG modem << [00:00:42.071,105] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:12.828Z DEBUG modem << [00:00:43.071,014] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:12.831Z DEBUG modem << [00:00:44.071,380] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:14.829Z DEBUG modem << [00:00:45.072,174] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:14.832Z DEBUG modem << [00:00:46.070,922] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:16.828Z DEBUG modem << [00:00:47.071,258] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:16.899Z DEBUG modem << [00:00:48.070,983] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:18.816Z DEBUG modem << [00:00:49.071,044] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:18.997Z DEBUG modem << %CESQ: 69,3,22,3
2023-05-02T13:00:19.008Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:00:19.978Z DEBUG modem << [00:00:50.211,608] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -71[0m
2023-05-02T13:00:19.982Z DEBUG modem << [00:00:50.245,666] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:19.984Z DEBUG modem << [00:00:51.219,970] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:21.977Z DEBUG modem << [00:00:52.220,184] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:21.980Z DEBUG modem << [00:00:53.140,197] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:23.897Z DEBUG modem << [00:00:54.140,319] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:23.900Z DEBUG modem << [00:00:55.058,990] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:25.817Z DEBUG modem << [00:00:56.060,394] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:25.820Z DEBUG modem << [00:00:56.978,881] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:26.765Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:00:26.772Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:00:27.737Z DEBUG modem << [00:00:57.980,163] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:27.740Z DEBUG modem << [00:00:58.980,804] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:29.737Z DEBUG modem << [00:00:59.980,346] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:29.741Z DEBUG modem << [00:01:00.980,987] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:31.207Z DEBUG modem << [00:01:01.455,505] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:00:31.211Z DEBUG modem << [00:01:01.980,285] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:32.737Z DEBUG modem << [00:01:02.980,621] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:32.740Z DEBUG modem << [00:01:03.980,590] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:34.737Z DEBUG modem << [00:01:04.980,438] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:34.741Z DEBUG modem << [00:01:05.981,201] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:36.737Z DEBUG modem << [00:01:06.980,529] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:36.740Z DEBUG modem << [00:01:07.980,529] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:38.737Z DEBUG modem << [00:01:08.980,957] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:38.740Z DEBUG modem << [00:01:09.981,201] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:40.737Z DEBUG modem << [00:01:10.981,384] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:40.741Z DEBUG modem << [00:01:11.981,201] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:42.738Z DEBUG modem << [00:01:12.981,872] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:42.741Z DEBUG modem << [00:01:13.982,208] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:44.737Z DEBUG modem << [00:01:14.981,842] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:44.823Z DEBUG modem << [00:01:15.981,414] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:46.737Z DEBUG modem << [00:01:16.981,170] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:46.741Z DEBUG modem << [00:01:17.981,323] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:48.737Z DEBUG modem << [00:01:18.981,689] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:48.741Z DEBUG modem << [00:01:19.982,025] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:50.737Z DEBUG modem << [00:01:20.981,719] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:50.740Z DEBUG modem << [00:01:21.981,628] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:52.738Z DEBUG modem << [00:01:22.981,903] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:52.741Z DEBUG modem << [00:01:23.981,811] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:54.737Z DEBUG modem << [00:01:24.981,719] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:54.741Z DEBUG modem << [00:01:25.981,903] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:56.738Z DEBUG modem << [00:01:26.982,818] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:56.837Z DEBUG modem << [00:01:27.982,574] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:58.737Z DEBUG modem << [00:01:28.981,933] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:00:58.812Z DEBUG modem << [00:01:29.983,184] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:00.745Z DEBUG modem << [00:01:30.982,452] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:00.748Z DEBUG modem << [00:01:31.455,627] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:01:00.835Z DEBUG modem << [00:01:31.982,238] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:02.738Z DEBUG modem << [00:01:32.982,513] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:02.742Z DEBUG modem << [00:01:33.982,910] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:04.738Z DEBUG modem << [00:01:34.982,818] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:04.742Z DEBUG modem << [00:01:35.982,727] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:06.738Z DEBUG modem << [00:01:36.982,757] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:06.742Z DEBUG modem << [00:01:37.982,604] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:08.739Z DEBUG modem << [00:01:38.983,459] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:08.742Z DEBUG modem << [00:01:39.982,269] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:10.738Z DEBUG modem << [00:01:40.982,666] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:10.741Z DEBUG modem << [00:01:41.983,245] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:12.737Z DEBUG modem << [00:01:42.982,574] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:12.820Z DEBUG modem << [00:01:43.982,574] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:13.838Z DEBUG modem << [00:01:44.077,728] [0m<inf> app_event_manager: SENSOR_EVT_MOVEMENT_INACTIVITY_DETECTED[0m
2023-05-02T13:01:13.842Z DEBUG modem << [00:01:44.078,033] [0m<dbg> main: activity_event_handle: Sample request ongoing, abort request.[0m
2023-05-02T13:01:13.920Z DEBUG modem << [00:01:44.982,818] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:15.737Z DEBUG modem << [00:01:45.982,421] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:15.741Z DEBUG modem << [00:01:46.982,696] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:17.737Z DEBUG modem << [00:01:47.982,513] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:17.741Z DEBUG modem << [00:01:48.982,788] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:18.726Z DEBUG modem << [00:01:49.982,849] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:19.726Z DEBUG modem << [00:01:50.983,032] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:21.294Z DEBUG modem << Encoded message:
2023-05-02T13:01:21.298Z DEBUG modem << {
2023-05-02T13:01:21.300Z DEBUG modem << "appId":"GROUND_FIX",
2023-05-02T13:01:21.302Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.304Z DEBUG modem << "data":{
2023-05-02T13:01:21.306Z DEBUG modem << "lte":[{
2023-05-02T13:01:21.307Z DEBUG modem << "eci":18798349,
2023-05-02T13:01:21.309Z DEBUG modem << "mcc":204,
2023-05-02T13:01:21.311Z DEBUG modem << "mnc":8,
2023-05-02T13:01:21.314Z DEBUG modem << "tac":32502,
2023-05-02T13:01:21.316Z DEBUG modem << "earfcn":0,
2023-05-02T13:01:21.318Z DEBUG modem << "rsrp":-140,
2023-05-02T13:01:21.320Z DEBUG modem << "rsrq":-19.5,
2023-05-02T13:01:21.321Z DEBUG modem << "adv":0
2023-05-02T13:01:21.323Z DEBUG modem << }]
2023-05-02T13:01:21.326Z DEBUG modem << }
2023-05-02T13:01:21.328Z DEBUG modem << }
2023-05-02T13:01:21.422Z DEBUG modem << Encoded batch message:
2023-05-02T13:01:21.425Z DEBUG modem << [{
2023-05-02T13:01:21.428Z DEBUG modem << "appId":"HUMID",
2023-05-02T13:01:21.431Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.433Z DEBUG modem << "ts":1683032378952,
2023-05-02T13:01:21.436Z DEBUG modem << "data":"38.87"
2023-05-02T13:01:21.438Z DEBUG modem << }, {
2023-05-02T13:01:21.527Z DEBUG modem << "appId":"TEMP",
2023-05-02T13:01:21.530Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.534Z DEBUG modem << "ts":1683032378952,
2023-05-02T13:01:21.537Z DEBUG modem << "data":"26.96"
2023-05-02T13:01:21.540Z DEBUG modem << }, {
2023-05-02T13:01:21.545Z DEBUG modem << "appId":"AIR_PRESS",
2023-05-02T13:01:21.548Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.552Z DEBUG modem << "ts":1683032378952,
2023-05-02T13:01:21.555Z DEBUG modem << "data":"102.81"
2023-05-02T13:01:21.558Z DEBUG modem << }, {
2023-05-02T13:01:21.562Z DEBUG modem << "appId":"VOLTAGE",
2023-05-02T13:01:21.567Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.570Z DEBUG modem << "ts":1683032379104,
2023-05-02T13:01:21.573Z DEBUG modem << "data":"4425"
2023-05-02T13:01:21.576Z DEBUG modem << }, {
2023-05-02T13:01:21.579Z DEBUG modem << "appId":"DEVICE",
2023-05-02T13:01:21.582Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.586Z DEBUG modem << "ts":1683032379041,
2023-05-02T13:01:21.600Z DEBUG modem << "data":{
2023-05-02T13:01:21.603Z DEBUG modem << "deviceInfo":{
2023-05-02T13:01:21.604Z DEBUG modem << "imei":"352656106116307",
2023-05-02T13:01:21.607Z DEBUG modem << "iccid":"8931080520035848611",
2023-05-02T13:01:21.609Z DEBUG modem << "modemFirmware":"mfw_nrf9160_1.2.1",
2023-05-02T13:01:21.611Z DEBUG modem << "board":"thingy91_nrf9160",
2023-05-02T13:01:21.613Z DEBUG modem << "appVersion":"0.0.0-development"
2023-05-02T13:01:21.616Z DEBUG modem << }
2023-05-02T13:01:21.618Z DEBUG modem << }
2023-05-02T13:01:21.621Z DEBUG modem << }, {
2023-05-02T13:01:21.623Z DEBUG modem << "appId":"DEVICE",
2023-05-02T13:01:21.625Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.627Z DEBUG modem << "ts":1683032379070,
2023-05-02T13:01:21.629Z DEBUG modem << "data":{
2023-05-02T13:01:21.631Z DEBUG modem << "networkInfo":{
2023-05-02T13:01:21.634Z DEBUG modem << "currentBand":20,
2023-05-02T13:01:21.641Z DEBUG modem << "networkMode":"LTE-M",
2023-05-02T13:01:21.643Z DEBUG modem << "rsrp":-79,
2023-05-02T13:01:21.645Z DEBUG modem << "areaCode":32502,
2023-05-02T13:01:21.647Z DEBUG modem << "mccmnc":20408,
2023-05-02T13:01:21.649Z DEBUG modem << "cellID":18798349,
2023-05-02T13:01:21.651Z DEBUG modem << "ipAddress":"10.160.159.111"
2023-05-02T13:01:21.653Z DEBUG modem << }
2023-05-02T13:01:21.655Z DEBUG modem << }
2023-05-02T13:01:21.657Z DEBUG modem << }, {
2023-05-02T13:01:21.659Z DEBUG modem << "appId":"RSRP",
2023-05-02T13:01:21.661Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:01:21.663Z DEBUG modem << "ts":1683032379070,
2023-05-02T13:01:21.665Z DEBUG modem << "data":"-79"
2023-05-02T13:01:21.667Z DEBUG modem << }]
2023-05-02T13:01:21.759Z DEBUG modem << [00:01:51.983,398] [0m<dbg> location: method_gnss_print_pvt: Tracked satellites: 0, fix valid: false, insuf. time window: false[0m
2023-05-02T13:01:21.762Z DEBUG modem << [00:01:52.531,311] [0m<inf> location: Method specific timeout expired[0m
2023-05-02T13:01:21.764Z DEBUG modem << [00:01:52.531,860] [0m<inf> location: Location retrieval failed using 'GNSS', trying with 'Cellular' next[0m
2023-05-02T13:01:21.767Z DEBUG modem << [00:01:52.531,921] [0m<dbg> location: location_core_timer_start: Starting timer with timeout=11000[0m
2023-05-02T13:01:21.769Z DEBUG modem << [00:01:52.531,951] [0m<dbg> location: method_cellular_positioning_work_fn: Triggering neighbor cell measurements[0m
2023-05-02T13:01:21.772Z DEBUG modem << [00:01:52.531,982] [0m<dbg> location: method_cellular_ncellmeas_start: Triggering cell measurements[0m
2023-05-02T13:01:21.774Z DEBUG modem << [00:01:52.533,081] [1;33m<wrn> location: Failed to initiate neighbor cell measurements: -14, next: fallback to get modem parameters[0m
2023-05-02T13:01:21.776Z DEBUG modem << [00:01:52.534,088] [0m<dbg> location: location_utils_modem_params_read: parsed modem parameter%CESQ: 71,3,24,3
2023-05-02T13:01:21.779Z DEBUG modem << %CESQ: 71,3,24,3
2023-05-02T13:01:21.787Z DEBUG modem << s: mcc 204, mnc 8, tac 32502 (string: "7EF6"), cell_id 18798349 (string: "011ED70D") phys_cell_id 0[0m
2023-05-02T13:01:21.893Z DEBUG modem << [00:01:52.534,118] [0m<dbg> location_module: location_event_handler: Getting cellular request[0m
2023-05-02T13:01:21.897Z DEBUG modem << [00:01:52.534,210] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_NEIGHBOR_CELLS_DATA_READY[0m
2023-05-02T13:01:21.913Z DEBUG modem << [00:01:52.534,698] [0m<dbg> location: location_core_cellular_ext_result_set: Location cellular result set with result=unknown[0m
2023-05-02T13:01:21.915Z DEBUG modem << [00:01:52.534,759] [0m<dbg> location: location_core_event_cb_fn: Location acquisition completed and fallbacks are also done[0m
2023-05-02T13:01:21.917Z DEBUG modem << [00:01:52.534,790] [0m<dbg> location_module: location_event_handler: Getting location completed with undefined result[0m
2023-05-02T13:01:21.919Z DEBUG modem << [00:01:52.534,820] [0m<dbg> location_module: location_event_handler: search time: 102400[0m
2023-05-02T13:01:21.921Z DEBUG modem << [00:01:52.534,881] [0m<inf> app_event_manager: LOCATION_MODULE_EVT_INACTIVE[0m
2023-05-02T13:01:21.923Z DEBUG modem << [00:01:52.534,973] [0m<dbg> ui_module: sub_sub_state_set: Sub state transition SUB_SUB_STATE_LOCATION_ACTIVE --> SUB_SUB_STATE_LOCATION_INACTIVE[0m
2023-05-02T13:01:21.925Z DEBUG modem << [00:01:52.535,369] [0m<dbg> location_module: sub_state_set: Sub state transition SUB_STATE_SEARCH --> SUB_STATE_IDLE[0m
2023-05-02T13:01:22.031Z DEBUG modem << [00:01:52.535,858] [0m<inf> app_event_manager: DATA_EVT_DATA_READY[0m
2023-05-02T13:01:22.035Z DEBUG modem << [00:01:52.562,652] [0m<dbg> data_module: data_encode: Neighbor cell data encoded successfully[0m
2023-05-02T13:01:22.045Z DEBUG modem << [00:01:52.562,713] [0m<inf> app_event_manager: DATA_EVT_NEIGHBOR_CELLS_DATA_SEND[0m
2023-05-02T13:01:22.047Z DEBUG modem << [00:01:52.563,446] [0m<dbg> data_module: data_encode: Regular data updates are not supported[0m
2023-05-02T13:01:22.049Z DEBUG modem << [00:01:52.691,925] [0m<dbg> data_module: data_encode: Batch data encoded successfully[0m
2023-05-02T13:01:22.052Z DEBUG modem << [00:01:52.692,016] [0m<inf> app_event_manager: DATA_EVT_DATA_SEND_BATCH[0m
2023-05-02T13:01:22.054Z DEBUG modem << [00:01:52.692,810] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_NEW[0m
2023-05-02T13:01:22.057Z DEBUG modem << [00:01:52.692,901] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:01:22.059Z DEBUG modem << [00:01:52.693,115] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_NEW[0m
2023-05-02T13:01:22.062Z DEBUG modem << [00:01:52.693,206] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:01:22.064Z DEBUG modem << [00:01:52.693,389] [0m<dbg> qos: qos_message_print: Notified count: 1[0m
2023-05-02T13:01:22.066Z DEBUG modem << [00:01:52.693,389] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:01:22.175Z DEBUG modem << [00:01:52.693,420] [0m<dbg> qos: qos_message_print: Message ID: 15001[0m
2023-05-02T13:01:22.178Z DEBUG modem << [00:01:52.693,420] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c498[0m
2023-05-02T13:01:22.194Z DEBUG modem << [00:01:52.693,450] [0m<dbg> qos: qos_message_print: Message Buffer length: 151[0m
2023-05-02T13:01:22.197Z DEBUG modem << [00:01:52.693,481] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:01:22.199Z DEBUG modem << [00:01:52.693,481] [0m<dbg> qos: qos_message_print: Message type: 3[0m
2023-05-02T13:01:22.200Z DEBUG modem << [00:01:52.772,491] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:01:22.202Z DEBUG modem << [00:01:52.774,169] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:01:22.204Z DEBUG modem << +CSCON: 1
2023-05-02T13:01:22.336Z DEBUG modem << [00:01:53.017,700] [0m<dbg> qos: qos_message_print: Notified count: 1[0m
2023-05-02T13:01:22.341Z DEBUG modem << [00:01:53.017,730] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:01:22.344Z DEBUG modem << [00:01:53.017,730] [0m<dbg> qos: qos_message_print: Message ID: 15002[0m
2023-05-02T13:01:22.346Z DEBUG modem << [00:01:53.017,761] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001d100[0m
2023-05-02T13:01:22.348Z DEBUG modem << [00:01:53.017,761] [0m<dbg> qos: qos_message_print: Message Buffer length: 815[0m
2023-05-02T13:01:22.507Z DEBUG modem << [00:01:53.017,791] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:01:22.516Z DEBUG modem << [00:01:53.017,791] [0m<dbg> qos: qos_message_print: Message type: 1[0m
2023-05-02T13:01:22.521Z DEBUG modem << [00:01:53.307,891] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:01:22.526Z DEBUG modem << [00:01:53.558,227] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 15001 result = 0[0m
2023-05-02T13:01:22.530Z DEBUG modem << [00:01:53.558,258] [0m<dbg> nrf_cloud_fsm: cc_tx_ack_handler: Data ACK for user tag: 15001[0m
2023-05-02T13:01:22.533Z DEBUG modem << [00:01:53.558,288] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 9[0m
2023-05-02T13:01:22.536Z DEBUG modem << [00:01:53.558,319] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_SENSOR_DATA_ACK[0m
2023-05-02T13:01:22.538Z DEBUG modem << [00:01:53.558,349] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_DATA_ACK: 15001[0m
2023-05-02T13:01:22.541Z DEBUG modem << [00:01:53.558,380] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_REMOVED_FROM_LIST[0m
2023-05-02T13:01:22.544Z DEBUG modem << [00:01:53.558,380] [0m<dbg> cloud_module: qos_event_handler: Freeing pointer: 0x2001c498[0m
2023-05-02T13:01:22.682Z DEBUG modem << [00:01:53.722,564] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 15002 result = 0[0m
2023-05-02T13:01:22.686Z DEBUG modem << [00:01:53.722,595] [0m<dbg> nrf_cloud_fsm: cc_tx_ack_handler: Data ACK for user tag: 15002[0m
2023-05-02T13:01:22.690Z DEBUG modem << [00:01:53.722,625] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 9[0m
2023-05-02T13:01:22.732Z DEBUG modem << [00:01:53.722,625] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_SENSOR_DATA_ACK[0m
2023-05-02T13:01:22.736Z DEBUG modem << [00:01:53.722,656] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_DATA_ACK: 15002[0m
2023-05-02T13:01:22.738Z DEBUG modem << [00:01:53.722,686] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_REMOVED_FROM_LIST[0m
2023-05-02T13:01:22.742Z DEBUG modem << [00:01:53.722,686] [0m<dbg> cloud_module: qos_event_handler: Freeing pointer: 0x2001d100[0m
2023-05-02T13:01:22.744Z DEBUG modem << [00:01:53.722,717] [0m<dbg> qos: qos_message_remove: QoS list is empty, cancel ongoing delayed work[0m
2023-05-02T13:01:22.881Z DEBUG modem << [00:01:53.784,637] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBLISH: id = 8064 len = 130, topic = prod/8ae9b938-a7aa-4425-aab1-c5d9f493a9b3/m/d/nrf-352656106116307/ground_fix/r[0m
2023-05-02T13:01:22.885Z DEBUG modem << [00:01:53.784,759] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 9[0m
2023-05-02T13:01:22.899Z DEBUG modem << [00:01:53.784,790] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_RX_DATA_LOCATION[0m
2023-05-02T13:01:27.253Z DEBUG modem << %CESQ: 71,3,19,2
2023-05-02T13:01:28.263Z DEBUG modem << [00:01:58.521,942] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:01:31.194Z DEBUG modem << [00:02:01.455,718] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:01:34.932Z DEBUG modem << %CESQ: 71,3,24,3
2023-05-02T13:01:35.545Z DEBUG modem << +CSCON: 0
2023-05-02T13:01:35.640Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:01:35.950Z DEBUG modem << [00:02:06.201,965] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:01:35.954Z DEBUG modem << [00:02:06.814,849] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:01:36.716Z DEBUG modem << %CESQ: 71,3,19,2
2023-05-02T13:01:37.726Z DEBUG modem << [00:02:07.985,900] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:01:55.573Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:01:55.579Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:02:01.193Z DEBUG modem << [00:02:31.455,841] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:02:31.192Z DEBUG modem << [00:03:01.455,963] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:02:54.885Z DEBUG modem << Encoded message:
2023-05-02T13:02:54.889Z DEBUG modem << {
2023-05-02T13:02:54.891Z DEBUG modem << "data":"1",
2023-05-02T13:02:54.893Z DEBUG modem << "appId":"BUTTON",
2023-05-02T13:02:54.895Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:02:54.897Z DEBUG modem << "ts":1683032574670
2023-05-02T13:02:54.900Z DEBUG modem << }
2023-05-02T13:02:54.996Z DEBUG modem << [00:03:26.145,202] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T13:02:54.999Z DEBUG modem << [00:03:26.145,446] [0m<dbg> cloud_codec_ringbuffer: cloud_codec_populate_ui_buffer: Entry: 1 of 2 in UI buffer filled[0m
2023-05-02T13:02:55.002Z DEBUG modem << [00:03:26.145,507] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T13:02:55.004Z DEBUG modem << [00:03:26.157,165] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T13:02:55.007Z DEBUG modem << [00:03:26.157,989] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_NEW[0m
2023-05-02T13:02:55.010Z DEBUG modem << [00:03:26.158,050] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:02:55.013Z DEBUG modem << [00:03:26.158,264] [0m<dbg> qos: qos_message_print: Notified count: 1[0m
2023-05-02T13:02:55.017Z DEBUG modem << [00:03:26.158,294] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:02:55.020Z DEBUG modem << [00:03:26.158,294] [0m<dbg> qos: qos_message_print: Message ID: 15003[0m
2023-05-02T13:02:55.023Z DEBUG modem << [00:03:26.158,325] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c328[0m
2023-05-02T13:02:55.026Z DEBUG modem << [00:03:26.158,325] [0m<dbg> qos: qos_message_print: Message Buffer length: 69[0m
2023-05-02T13:02:55.028Z DEBUG modem << [00:03:26.158,355] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:02:55.148Z DEBUG modem << [00:03:26.158,386] [0m<dbg> qos: qos_message_print: Message type: 2[0m
2023-05-02T13:02:55.152Z DEBUG modem << %CESQ: 71,3,23,3
2023-05-02T13:02:55.168Z DEBUG modem << %CESQ: 71,3,23,3
2023-05-02T13:02:55.500Z DEBUG modem << +CSCON: 1
2023-05-02T13:02:55.504Z DEBUG modem << %CESQ: 66,3,21,3
2023-05-02T13:02:56.021Z DEBUG modem << [00:03:26.255,523] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:02:56.025Z DEBUG modem << [00:03:26.257,202] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:02:56.028Z DEBUG modem << [00:03:26.770,263] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:02:56.139Z DEBUG modem << [00:03:26.771,972] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -74[0m
2023-05-02T13:02:57.384Z DEBUG modem << [00:03:27.583,892] [0m<dbg> nrf_cloud_transport: nct_mqtt_evt_handler: MQTT_EVT_PUBACK: id = 15003 result = 0[0m
2023-05-02T13:02:57.388Z DEBUG modem << [00:03:27.583,923] [0m<dbg> nrf_cloud_fsm: cc_tx_ack_handler: Data ACK for user tag: 15003[0m
2023-05-02T13:02:57.391Z DEBUG modem << [00:03:27.583,953] [0m<dbg> nrf_cloud: nfsm_set_current_state_and_notify: state: 9[0m
2023-05-02T13:02:57.491Z DEBUG modem << [00:03:27.583,953] [0m<dbg> nrf_cloud_integration: nrf_cloud_event_handler: NRF_CLOUD_EVT_SENSOR_DATA_ACK[0m
2023-05-02T13:02:57.494Z DEBUG modem << [00:03:27.583,984] [0m<dbg> cloud_module: cloud_wrap_event_handler: CLOUD_WRAP_EVT_DATA_ACK: 15003[0m
2023-05-02T13:02:57.496Z DEBUG modem << [00:03:27.584,014] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_REMOVED_FROM_LIST[0m
2023-05-02T13:02:57.499Z DEBUG modem << [00:03:27.584,014] [0m<dbg> cloud_module: qos_event_handler: Freeing pointer: 0x2001c328[0m
2023-05-02T13:02:57.502Z DEBUG modem << [00:03:27.584,045] [0m<dbg> qos: qos_message_remove: QoS list is empty, cancel ongoing delayed work[0m
2023-05-02T13:03:01.191Z DEBUG modem << [00:03:31.456,085] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:03:08.768Z DEBUG modem << +CSCON: 0
2023-05-02T13:03:08.869Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:03:09.775Z DEBUG modem << [00:03:40.040,374] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:03:21.676Z DEBUG modem << %CESQ: 71,3,18,2
2023-05-02T13:03:22.686Z DEBUG modem << [00:03:52.948,760] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:03:28.796Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:03:28.804Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:03:31.190Z DEBUG modem << [00:04:01.456,207] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:04:01.189Z DEBUG modem << [00:04:31.456,329] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:04:31.189Z DEBUG modem << [00:05:01.456,451] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:05:01.187Z DEBUG modem << [00:05:31.456,573] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:05:31.187Z DEBUG modem << [00:06:01.456,695] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:06:01.185Z DEBUG modem << [00:06:31.456,817] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:06:31.185Z DEBUG modem << [00:07:01.456,939] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:07:01.184Z DEBUG modem << [00:07:31.457,061] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:07:31.184Z DEBUG modem << [00:08:01.457,183] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:08:01.182Z DEBUG modem << [00:08:31.457,305] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:08:31.182Z DEBUG modem << [00:09:01.457,427] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:09:01.181Z DEBUG modem << [00:09:31.457,550] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:09:31.180Z DEBUG modem << [00:10:01.457,672] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:10:01.179Z DEBUG modem << [00:10:31.457,794] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:10:31.178Z DEBUG modem << [00:11:01.457,916] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:10:43.791Z DEBUG modem << Encoded message:
2023-05-02T13:10:43.794Z DEBUG modem << {
2023-05-02T13:10:43.797Z DEBUG modem << "data":"1",
2023-05-02T13:10:43.799Z DEBUG modem << "appId":"BUTTON",
2023-05-02T13:10:43.802Z DEBUG modem << "messageType":"DATA",
2023-05-02T13:10:43.804Z DEBUG modem << "ts":1683033043592
2023-05-02T13:10:43.806Z DEBUG modem << }
2023-05-02T13:10:43.919Z DEBUG modem << [00:11:15.066,802] [0m<inf> app_event_manager: UI_EVT_BUTTON_DATA_READY[0m
2023-05-02T13:10:43.922Z DEBUG modem << [00:11:15.067,047] [0m<dbg> cloud_codec_ringbuffer: cloud_codec_populate_ui_buffer: Entry: 2 of 2 in UI buffer filled[0m
2023-05-02T13:10:43.925Z DEBUG modem << [00:11:15.067,108] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_READY[0m
2023-05-02T13:10:43.928Z DEBUG modem << [00:11:15.078,796] [0m<inf> app_event_manager: DATA_EVT_UI_DATA_SEND[0m
2023-05-02T13:10:43.931Z DEBUG modem << [00:11:15.079,620] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_NEW[0m
2023-05-02T13:10:43.933Z DEBUG modem << [00:11:15.079,711] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:10:43.936Z DEBUG modem << [00:11:15.079,895] [0m<dbg> qos: qos_message_print: Notified count: 1[0m
2023-05-02T13:10:43.939Z DEBUG modem << [00:11:15.079,925] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:10:43.943Z DEBUG modem << [00:11:15.079,956] [0m<dbg> qos: qos_message_print: Message ID: 15004[0m
2023-05-02T13:10:43.949Z DEBUG modem << [00:11:15.079,956] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c328[0m
2023-05-02T13:10:43.953Z DEBUG modem << [00:11:15.079,986] [0m<dbg> qos: qos_message_print: Message Buffer length: 69[0m
2023-05-02T13:10:43.955Z DEBUG modem << [00:11:15.080,017] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:10:44.088Z DEBUG modem << [00:11:15.080,047] [0m<dbg> qos: qos_message_print: Message type: 2[0m
2023-05-02T13:10:44.093Z DEBUG modem << %CESQ: 71,3,26,3
2023-05-02T13:10:44.110Z DEBUG modem << %CESQ: 71,3,26,3
2023-05-02T13:10:44.428Z DEBUG modem << +CSCON: 1
2023-05-02T13:10:44.432Z DEBUG modem << %CESQ: 67,3,21,3
2023-05-02T13:10:44.938Z DEBUG modem << [00:11:15.187,835] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:10:45.049Z DEBUG modem << [00:11:15.189,544] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:10:45.054Z DEBUG modem << [00:11:15.713,287] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:10:45.065Z DEBUG modem << [00:11:15.714,996] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -73[0m
2023-05-02T13:10:47.929Z DEBUG modem << %CESQ: 71,3,21,3
2023-05-02T13:10:48.939Z DEBUG modem << [00:11:19.217,041] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:10:49.209Z DEBUG modem << %CESQ: 71,3,16,2
2023-05-02T13:10:50.220Z DEBUG modem << [00:11:20.497,070] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:10:50.809Z DEBUG modem << %CESQ: 71,3,21,3
2023-05-02T13:10:51.820Z DEBUG modem << [00:11:22.097,106] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -69[0m
2023-05-02T13:10:55.902Z DEBUG modem << +CSCON: 0
2023-05-02T13:10:56.000Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:10:56.141Z DEBUG modem << +CSCON: 1
2023-05-02T13:10:56.917Z DEBUG modem << [00:11:27.190,124] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:10:56.921Z DEBUG modem << [00:11:27.403,564] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:11:00.863Z DEBUG modem << [00:11:31.079,925] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_TIMER_EXPIRED[0m
2023-05-02T13:11:00.867Z DEBUG modem << [00:11:31.080,047] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:11:00.869Z DEBUG modem << [00:11:31.080,200] [0m<dbg> qos: qos_message_print: Notified count: 2[0m
2023-05-02T13:11:00.986Z DEBUG modem << [00:11:31.080,200] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:11:00.990Z DEBUG modem << [00:11:31.080,230] [0m<dbg> qos: qos_message_print: Message ID: 15004[0m
2023-05-02T13:11:00.999Z DEBUG modem << [00:11:31.080,230] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c328[0m
2023-05-02T13:11:01.002Z DEBUG modem << [00:11:31.080,261] [0m<dbg> qos: qos_message_print: Message Buffer length: 69[0m
2023-05-02T13:11:01.005Z DEBUG modem << [00:11:31.080,261] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:11:01.008Z DEBUG modem << [00:11:31.080,291] [0m<dbg> qos: qos_message_print: Message type: 2[0m
2023-05-02T13:11:01.011Z DEBUG modem << [00:11:31.458,038] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:11:07.614Z DEBUG modem << +CSCON: 0
2023-05-02T13:11:07.714Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:11:08.621Z DEBUG modem << [00:11:38.902,435] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:11:16.856Z DEBUG modem << [00:11:47.080,078] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_TIMER_EXPIRED[0m
2023-05-02T13:11:16.859Z DEBUG modem << [00:11:47.080,200] [0m<inf> app_event_manager: CLOUD_EVT_DATA_SEND_QOS[0m
2023-05-02T13:11:16.985Z DEBUG modem << [00:11:47.080,352] [0m<dbg> qos: qos_message_print: Notified count: 3[0m
2023-05-02T13:11:16.989Z DEBUG modem << [00:11:47.080,383] [0m<dbg> qos: qos_message_print: Message heap_allocated: 1[0m
2023-05-02T13:11:16.999Z DEBUG modem << [00:11:47.080,383] [0m<dbg> qos: qos_message_print: Message ID: 15004[0m
2023-05-02T13:11:17.002Z DEBUG modem << [00:11:47.080,413] [0m<dbg> qos: qos_message_print: Message Buffer pointer: 0x2001c328[0m
2023-05-02T13:11:17.005Z DEBUG modem << [00:11:47.080,413] [0m<dbg> qos: qos_message_print: Message Buffer length: 69[0m
2023-05-02T13:11:17.008Z DEBUG modem << [00:11:47.080,444] [0m<dbg> qos: qos_message_print: Message Flags: 2[0m
2023-05-02T13:11:17.011Z DEBUG modem << [00:11:47.080,444] [0m<dbg> qos: qos_message_print: Message type: 2[0m
2023-05-02T13:11:21.715Z DEBUG modem << +CSCON: 1
2023-05-02T13:11:22.723Z DEBUG modem << [00:11:53.004,241] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:11:31.177Z DEBUG modem << [00:12:01.458,129] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:11:32.832Z DEBUG modem << [00:12:03.080,230] [0m<dbg> qos: timeout_handler_work_fn: Notified count for message ID: 15004 exceeds the maximum allowed value, remove message from pending list.[0m
2023-05-02T13:11:32.966Z DEBUG modem << [00:12:03.080,291] [0m<dbg> cloud_module: qos_event_handler: QOS_EVT_MESSAGE_REMOVED_FROM_LIST[0m
2023-05-02T13:11:32.970Z DEBUG modem << [00:12:03.080,291] [0m<dbg> cloud_module: qos_event_handler: Freeing pointer: 0x2001c328[0m
2023-05-02T13:11:32.981Z DEBUG modem << [00:12:03.080,322] [0m<dbg> qos: timeout_handler_work_fn: QoS list is empty, don't reschedule work[0m
2023-05-02T13:11:33.134Z DEBUG modem << +CSCON: 0
2023-05-02T13:11:33.138Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:11:34.077Z DEBUG modem << [00:12:04.359,130] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:11:53.097Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:11:53.104Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:12:01.176Z DEBUG modem << [00:12:31.458,251] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:12:02.982Z DEBUG modem << %CESQ: 73,3,27,3
2023-05-02T13:12:02.991Z DEBUG modem << %CESQ: 73,3,27,3
2023-05-02T13:12:03.505Z DEBUG modem << +CSCON: 1
2023-05-02T13:12:04.007Z DEBUG modem << [00:12:34.269,989] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -67[0m
2023-05-02T13:12:04.134Z DEBUG modem << [00:12:34.271,667] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -67[0m
2023-05-02T13:12:04.138Z DEBUG modem << [00:12:34.795,349] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:12:04.817Z DEBUG modem << %CESQ: 68,3,27,3
2023-05-02T13:12:05.827Z DEBUG modem << [00:12:36.107,299] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -72[0m
2023-05-02T13:12:15.029Z DEBUG modem << +CSCON: 0
2023-05-02T13:12:15.138Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:12:16.037Z DEBUG modem << [00:12:46.320,281] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:12:16.149Z DEBUG modem << %CESQ: 68,3,22,3
2023-05-02T13:12:17.083Z DEBUG modem << [00:12:47.363,311] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -72[0m
2023-05-02T13:12:31.174Z DEBUG modem << [00:13:01.458,374] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:12:35.057Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:12:35.066Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:12:42.741Z DEBUG modem << %CESQ: 73,3,26,3
2023-05-02T13:12:42.751Z DEBUG modem << %CESQ: 73,3,26,3
2023-05-02T13:12:43.265Z DEBUG modem << +CSCON: 1
2023-05-02T13:12:43.767Z DEBUG modem << [00:13:14.031,066] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -67[0m
2023-05-02T13:12:43.885Z DEBUG modem << [00:13:14.032,775] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -67[0m
2023-05-02T13:12:43.888Z DEBUG modem << [00:13:14.556,427] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:12:45.257Z DEBUG modem << %CESQ: 68,3,26,3
2023-05-02T13:12:46.267Z DEBUG modem << [00:13:16.548,400] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -72[0m
2023-05-02T13:12:50.376Z DEBUG modem << %CESQ: 68,3,21,3
2023-05-02T13:12:51.387Z DEBUG modem << [00:13:21.668,395] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -72[0m
2023-05-02T13:12:52.296Z DEBUG modem << %CESQ: 68,3,16,2
2023-05-02T13:12:53.307Z DEBUG modem << [00:13:23.588,439] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -72[0m
2023-05-02T13:12:54.530Z DEBUG modem << +CSCON: 0
2023-05-02T13:12:54.638Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:12:55.537Z DEBUG modem << [00:13:25.822,509] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:13:01.173Z DEBUG modem << [00:13:31.458,496] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:13:14.558Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:13:14.567Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:13:31.173Z DEBUG modem << [00:14:01.458,618] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:14:01.172Z DEBUG modem << [00:14:31.458,740] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:14:08.061Z DEBUG modem << %CESQ: 72,3,25,3
2023-05-02T13:14:08.071Z DEBUG modem << %CESQ: 72,3,25,3
2023-05-02T13:14:08.584Z DEBUG modem << +CSCON: 1
2023-05-02T13:14:09.087Z DEBUG modem << [00:14:39.353,393] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -68[0m
2023-05-02T13:14:09.089Z DEBUG modem << [00:14:39.355,102] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -68[0m
2023-05-02T13:14:09.227Z DEBUG modem << [00:14:39.878,753] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:14:11.432Z DEBUG modem << %CESQ: 72,3,20,2
2023-05-02T13:14:12.443Z DEBUG modem << [00:14:42.726,593] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -68[0m
2023-05-02T13:14:20.045Z DEBUG modem << +CSCON: 0
2023-05-02T13:14:20.152Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:14:21.052Z DEBUG modem << [00:14:51.339,691] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:14:31.171Z DEBUG modem << [00:15:01.458,862] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:14:40.049Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:14:40.056Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:15:01.170Z DEBUG modem << [00:15:31.458,984] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:15:31.169Z DEBUG modem << [00:16:01.459,106] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:16:01.168Z DEBUG modem << [00:16:31.459,228] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:16:31.169Z DEBUG modem << [00:17:01.459,350] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:16:58.702Z DEBUG modem << %CESQ: 74,3,18,2
2023-05-02T13:16:58.712Z DEBUG modem << %CESQ: 74,3,18,2
2023-05-02T13:16:59.225Z DEBUG modem << +CSCON: 1
2023-05-02T13:16:59.728Z DEBUG modem << [00:17:29.997,894] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:16:59.851Z DEBUG modem << [00:17:29.999,603] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:16:59.856Z DEBUG modem << [00:17:30.523,406] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:17:01.168Z DEBUG modem << [00:17:31.459,472] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:17:01.505Z DEBUG modem << %CESQ: 74,3,23,3
2023-05-02T13:17:02.515Z DEBUG modem << [00:17:32.803,222] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:17:10.758Z DEBUG modem << +CSCON: 0
2023-05-02T13:17:10.899Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:17:11.765Z DEBUG modem << [00:17:42.056,274] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:17:14.953Z DEBUG modem << %CESQ: 74,3,17,2
2023-05-02T13:17:15.963Z DEBUG modem << [00:17:46.251,464] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:17:30.785Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:17:30.795Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:17:31.168Z DEBUG modem << [00:18:01.459,594] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:18:01.167Z DEBUG modem << [00:18:31.459,716] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:18:31.166Z DEBUG modem << [00:19:01.459,838] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:19:01.165Z DEBUG modem << [00:19:31.459,960] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:19:31.164Z DEBUG modem << [00:20:01.460,083] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:20:01.164Z DEBUG modem << [00:20:31.460,205] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:20:31.162Z DEBUG modem << [00:21:01.460,327] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:21:01.162Z DEBUG modem << [00:21:31.460,449] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:21:31.161Z DEBUG modem << [00:22:01.460,571] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:22:01.160Z DEBUG modem << [00:22:31.460,693] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:22:11.579Z DEBUG modem << %CESQ: 74,3,27,3
2023-05-02T13:22:11.588Z DEBUG modem << %CESQ: 74,3,27,3
2023-05-02T13:22:12.104Z DEBUG modem << +CSCON: 1
2023-05-02T13:22:12.606Z DEBUG modem << [00:22:42.886,413] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:22:12.732Z DEBUG modem << [00:22:42.888,122] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:22:12.736Z DEBUG modem << [00:22:43.411,926] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Connected[0m
2023-05-02T13:22:12.904Z DEBUG modem << %CESQ: 74,3,22,3
2023-05-02T13:22:13.689Z DEBUG modem << [00:22:43.987,701] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:22:23.532Z DEBUG modem << +CSCON: 0
2023-05-02T13:22:23.682Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:22:24.539Z DEBUG modem << [00:22:54.840,850] [0m<dbg> modem_module: lte_evt_handler: RRC mode: Idle[0m
2023-05-02T13:22:27.911Z DEBUG modem << %CESQ: 74,3,17,2
2023-05-02T13:22:28.922Z DEBUG modem << [00:22:59.220,001] [0m<dbg> modem_module: modem_rsrp_handler: Incoming RSRP status message, RSRP value is -66[0m
2023-05-02T13:22:31.159Z DEBUG modem << [00:23:01.460,815] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:22:43.560Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:22:43.568Z DEBUG modem << %CESQ: 255,0,255,0
2023-05-02T13:23:01.158Z DEBUG modem << [00:23:31.460,937] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:23:31.158Z DEBUG modem << [00:24:01.461,059] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:24:01.156Z DEBUG modem << [00:24:31.461,181] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:24:31.156Z DEBUG modem << [00:25:01.461,303] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
2023-05-02T13:25:01.155Z DEBUG modem << [00:25:31.461,425] [0m<dbg> watchdog: primary_feed_worker: Feeding watchdog[0m
And this is the data from the side panel of the Monitor:
Thank you for any insights you may have on this issue.
