• State Verified Answer
  • Locked Locked
  • Replies 13 replies
  • Subscribers 88 subscribers
  • Views 2159 views
  • Users 0 members are here
Attachments (1) Download All
Nordic Case Info
  • Case ID: 270831
Options
This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts
This discussion has been locked.
You can no longer post new replies to this discussion. If you have a question you can start a new discussion

Asset Tracker V2 - Real-time Configurations

Paul Oberauer

Hello, is there any information on how to change the Real-time Configurations at runtime?

thanks in advance

Parents
  • 0

    Hello, 

    According to the Asset Tracker v2 documentation, this should be possible from the cloud side:

    The device retrieves its real-time configurations from the cloud service in either of the following ways:

    • Upon every established connection to the cloud service, the application will always request its cloud-side device state that contains the latest real-time configurations.

    • When the device exits Power Saving Mode (PSM) to publish data, and if the cloud-side device configuration has been updated while the device was in PSM, the application will request for the newly changed configuration.

    Kind regards,
    Øyvind

  • 0 in reply to Øyvind

    Thank you very much for your answer. Unfortunately I have problems how to set the real time configurations inaws-IoT. Can I just edit the shadow and the configurations will be applied? Or how does that work exactly?

    thanks in advance

  • 0 in reply to Markus Tacker (he/him)

    Unfortunately i don't know where i can find out the version of the asset tracker V2. But I use the version which is included in nRF SDK v1.5.0 Toolchain Manager which I downloaded on 12.04.2021.

  • 0 in reply to Paul Oberauer

    That should be version 1.5.0 as well. 

    There have been quite a few changes since then, and we are about to release version 1.6 of nRF Connect SDK. You could have a look at that: https://github.com/nrfconnect/sdk-nrf/milestone/14

    What would be interesting is too see the device logs from a device which is running in active mode, and where you then switch to passive mode on the cloud.

  • 0 in reply to Markus Tacker (he/him)

    2021-06-17T13:15:19.031Z DEBUG modem << [00:00:00.244,689] [0m<inf> event_manager: APP_EVT_START[0m
    2021-06-17T13:15:19.072Z DEBUG modem << [00:00:00.270,751] [0m<inf> event_manager: DATA_EVT_CONFIG_INITle timer: 120 seconds interval[0m
    2021-06-17T13:15:20.597Z DEBUG modem << [00:00:00.352,905] [0m<inf> event_manager: MODEM_EVT_LTE_CONNEC[00:00:01.803,344] [0m<inf> event_manager: MODEM_EVT_LTE_DISCONT_LTE_CELL_UPDATE[0m
    2021-06-17T13:15:22.430Z DEBUG modem << [00:00:03.613,220] [0m<inf> event_manager: MODEM_EVT_LTE_CONNECTED[0m
    2021-06-17T13:15:22.435Z DEBUG modem << [00:00:03.619,720] [0m<inf> event_manager: MODEM_EVT_L Cloud connection establishment in progress[0m
    2021-06-17T13:15:29.363Z DEBUG modem << [00:00:03.634,3nds if not successful[0m
    2021-06-17T13:15:29.546Z DEBUG modem << [00:00:03.643,676] [0m<inf> event_ma[00:00:10.577,056] [0m<inf> event_manager: CLOUD_EVT_CONNECTED[00:00:10.748,535] [0m<inf> event_manager: DATA_EVT_DATE_TIME_OBTAINED[0m
    2021-06-17T13:15:29.552Z DEBUG modem << [00:00:10.755,493] [0m<inf> event_manager: APP_EVTTAT)[0m
    2021-06-17T13:15:29.553Z DEBUG modem << TAT)[0m
    2021-06-17T13:15:29.566Z DEBUG modem << [00:00:10.773,895] [0m<inf> event_manager: GPS_EVT_ACTIVE[0m
    2021-06-17T13:15:29.577Z DEBUG modem << [00:00:10.789,794] [0m<inf> event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
    2021-06-17T13:15:29.699Z DEBUG modem << [00:00:10.828,186] [0m<inf> event_manager: MODEM_EVT_MODEM_STAT[00:00:10.870,208] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNA[00:00:10.912,231] [0m<inf> event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
    2021-06-17T13:16:33.775Z DEBUG modem << [00:01:14.979,949] [0m<inf> event_manager: GPS_EVT_TIMEOUT[0m
    2021-06-17T13:16:33.781Z DEBUG modem << m
    2021-06-17T13:16:33.832Z DEBUG modem << [00:01:14.991,607] [0m<inf> event_manager: DATA_EVT_DATA_REA[00:01:15.007,019] [0m<inf> event_manager: DATA_EVT_DATA_SEND[[00:01:15.048,919] [0m<inf> event_manager: CLOUD_EVT_DATA_ACK[

    here I have changed the shadow
    2021-06-17T13:17:19.083Z DEBUG modem << [00:02:00.290,740] [0m<inf> event_manager: APP_EVT_DATA_GET_ALL[0m
    2021-06-17T13:17:19.144Z DEBUG modem << [00:02:00.297,119] [0m<inf> event_manager: APP_EVT_DATA_G[00:02:00.363,159] [0m<inf> event_manager: GPS_EVT_ACTIVE[0m
    2021-06-17T13:17:19.199Z DEBUG modem << [00:02:00.373,260] [0m<inf> event_manager: SENSOR_EVT_ENVIRONME[00:02:00.392,944] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNA[00:02:00.415,863] [0m<inf> event_manager: MODEM_EVT_BATTERY_DATA_READY[0m
    2021-06-17T13:18:23.170Z DEBUG modem << [00:03:04.378,784] [0m<inf> event_manager: GPS_EVT_TIMEOUT[0m
    2021-06-17T13:18:23.189Z DEBUG modem << m
    2021-06-17T13:18:23.191Z DEBUG modem << [00:03:04.390,472] [0m<inf> event_manager: DATA_EVT_DATA_REAm
    2021-06-17T13:18:23.223Z DEBUG modem << [00:03:04.390,472] [0m<inf> event_manager: DATA_EVT_DATA_REA[00:03:04.402,221] [0m<inf> event_manager: DATA_EVT_DATA_SEND[[00:03:04.444,061] [0m<inf> event_manager: CLOUD_EVT_DATA_ACK[0m
    2021-06-17T13:19:19.078Z DEBUG modem << [00:04:00.290,740] [0m<inf> event_manager: APP_EVT_DATA_GET_ALLET - Requested data types (MOD_DYN, BAT, ENV, GNSS)[0m
    2021-06-17T13:19:19.140Z DEBUG modem << [00:04:00.363,281] [0m<inf> event_manager: GPS_EVT_ACTIVE[0m

  • 0 in reply to Markus Tacker (he/him)

    Fullscreen log_file.txt Download 
    2021-06-17T16:35:54.280Z INFO Modem port is opened
2021-06-17T16:35:54.285Z DEBUG modem >> AT+CFUN?
2021-06-17T16:35:55.790Z DEBUG modem << [00:00:02.241,088] [0m<dbg> modem_module.modem_rsrp_handler: In434] [0m<inf> event_manager: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.820Z DEBUG modem << [0dem module: Enqueued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.822Z DEBUG modem << [00:00:02.e: Enqueued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.823Z DEBUG modem << [00:00:02.278,656] ued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.824Z DEBUG modem << [00:00:02.289,001] [0m<dbg_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.825Z DEBUG modem << [00:00:02.299,255] [0m<dbg> modules_ISCONNECTED[0m
2021-06-17T16:35:55.827Z DEBUG modem << [00:00:02.309,417] [0m<dbg> modem_module.lte_evt_handler: LTE cell changed: Cell ID: 4036619, Tracking area: 1LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.828Z DEBUG modem << [00:00:02.326,385] [0m<dbg> modules_commonUPDATE[0m
2021-06-17T16:35:55.829Z DEBUG modem << [00:00:02.336,669] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m: cloud module: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.830Z DEBUG modem << [00:00:ule: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.831Z DEBUG modem << [00:00:02.367,279]ued MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.841Z DEBUG modem << [00:00:02.377,563] [0m<dbg> .384,979] [0m<dbg> modem_module.modem_rsrp_handler: Incoming RS<dbg> modules_common.module_get_next_msg: modem module: Dequeueddules_common.module_get_next_msg: modem module: Dequeued MODEM_Emon.module_get_next_msg: data module: Dequeued MODEM_EVT_LTE_DISe_get_next_msg: data module: Dequeued MODEM_EVT_LTE_CELL_UPDATE_msg: cloud module: Dequeued MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:57.602Z DEBUG modem << [00:00:02.446,441] [0m<dbg> modules_common.module_get_next_msg: cl[00:00:04.092,407] [0m<dbg> modem_module.lte_evt_handler: Network registration status: Connected - roaming[0m
2021-06-17T16:35:57.611Z DEBUG modem << [00:00:04.102,2:04.108,489] [0m<dbg> modules_common.module_enqueue_msg: modem ] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqumodules_common.module_enqueue_msg: cloud module: Enqueued: MODEMmon.module_enqueue_msg: app module: Enqueued: MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.613Z DEBUG modem << [00:00:04.148,620] [0m<dbg> modules_common.module_ge0:00:04.158,508] [0m<dbg> modem_module.lte_evt_handler: PSM par6] [0m<inf> event_manager: MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.615Z DEBUG modem << [00:00:04.174,774] [0m<dbg> modules_common.module_enqueue_msg: modem 7] [0m<dbg> modules_common.module_enqueue_msg: data module: Enq> modules_common.module_enqueue_msg: cloud module: Enqueued: MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.617Z DEBUG modem << [00:00:04.205,261] [0m<dbg> modules_SM_UPDATE[0m
2021-06-17T16:35:57.619Z DEBUG modem << [00:00:04.215,301] [0m<dbg> modules_common.modulm
2021-06-17T16:35:57.778Z DEBUG modem << [00:00:04.225,402] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.781Z DEBUG modem << [00:00:04.235,443] NG --> STATE_CONNECTED[0m
2021-06-17T16:35:57.783Z DEBUG modem << [00:00:04.245,147] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued MODEM_EVT_LTdule_get_next_msg: data module: Dequeued MODEM_EVT_LTE_CONNECTEDt_msg: data module: Dequeued MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.787Z DEBUG modem << [00:0d module: Dequeued MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.793Z DEBUG modem << [00:00:04.285,522] [0m<dbg> cloud_module.state_set: State transition STATE_LTE_m<dbg> cloud_module.connect_cloud: Connecting to cloud[0m
2021-06-17T16:35:57.794Z DEBUG modem << [00:00:04.303,161] [1;33m<wrn> cloud_module: Cloud connection estab0m
2021-06-17T16:35:57.795Z DEBUG modem << [00:00:04.320,526] [0m<dbg> modules_common.module_get_next_msg: cloud module: Dequeued MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.796Z DEBUG modem << [00:00: AWS_IOT_EVT_CONNECTING[0m
2021-06-17T16:35:57.797Z DEBUG modem << [00:00:04.339,355] [0m<dbg> cloud_module.cloud_wrap_event_handler: CLOUD_WRAP_EVT_CONNECTING[0m
2021-06-17T16:35:57.798Z DEBUG modem << G[0m
2021-06-17T16:35:57.799Z DEBUG modem << [00:00:04.354,064] [0m<dbg> modules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.800Z DEBUG modem << [00:00:04le: Enqueued: CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.801Z DEBUG modem << [00:00:04.373,565] [0m<CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.809Z DEBUG modem << [00:00:04.383,422] [0m<dbg> modules_common.module_enqueue_msg: modem module: Enqueued: CLOUD_EVT_CONNet_next_msg: app module: Dequeued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.810Z DEBUG modem << [00:00:04.403,045] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.811Z DEBUG modem << [00:00:04.412,872] eued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.812Z DEBUG modem << [00:00:04.422,729] [0m<dbg> modu_CONNECTING[0m
2021-06-17T16:35:57.911Z DEBUG modem << [00:00:04.533,264] [0m<dbg> aws_iot.broker_init: IPv4 Address found 54.221.63.103[0m
2021-06-17T16:36:01.466Z DEBUG modem << [00:00:04.871,002] [0m<dbg> modem_module.modem_rsrp_handler: In[00:00:07.649,749] [0m<dbg> aws_iot.aws_iot_cloud_poll: AWS bro[00:00:07.967,620] [0m<dbg> aws_fota.aws_fota_mqtt_evt_handler: Previous session valid; skipping FOTA subscriptions[0m
2021-06-17T16:36:01.474Z DEBUG modem << [00:00ed notify_next_topic $aws/things/thingy91/jobs/notify-next[0m
2021-06-17T16:36:01.476Z DEBUG modem <<  Created get_topic $aws/things/thingy91/jobs/$next/get/#[0m
2021-06-17T16:36:01.477Z DEBUG modem << [0reviously subscribed to notify-next topic[0m
2021-06-17T16:36:01.482Z DEBUG modem << [00:00:08.010,3751/jobs/$next/get[0m
2021-06-17T16:36:01.483Z DEBUG modem << [00:00:08.019,195] [0m<dbg> aws_jobs.publish: Publish payload {"clientToken": ""}[0m
2021-06-17T16:36:01.493Z DEBUG modem << [00:00:08.028,076]
2021-06-17T16:36:01.494Z DEBUG modem << [00:00:08.035,186] [0m<dbg> aws_iot_integration.aws_iot_event_ aws_iot_integration.aws_iot_event_handler: AWS_IOT_EVT_READY[0m
2021-06-17T16:36:01.495Z DEBUG modem << [00:00:08.051,910] [0m<dbg> cloud_module.cloud_wrap_event_ham<dbg> modules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.496Z DEBUG modem << [00:00:08.075,958] [0m<dbg> modules_coTED[0m
2021-06-17T16:36:01.586Z DEBUG modem << [00:00:08.085,632] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.588Z DEBUG modem << [00:00.095,367] [0m<dbg> modules_common.module_enqueue_msg: modem module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.591Z DEBUG modem << [00:00:08.105,133] [0m<OUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.594Z DEBUG modem << [00:00:08.114,654] [0m<dbg> aws_iot.aws_iot_send: Publishing to topic: $aws/things/thingy91/shadow/get[msg: data module: Dequeued CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.596Z DEBUG modem << [00:00:08.13 UTC...[0m
2021-06-17T16:36:01.598Z DEBUG modem << [00:00:08.141,693] [0m<dbg> date_time.current_time_check: Date time never set[0m
2021-06-17T16:36:01.599Z DEBUG modem << [00:00:08.148,925] [0m<dbg> da.156,341] [0m<dbg> date_time.new_date_time_get: Fallback on NTP State transition STATE_CLOUD_DISCONNECTED --> STATE_CLOUD_CONNECTED[0m
2021-06-17T16:36:01.600Z DEBUG modem << [00:00:08.174,713] [0m<dbg> modules_common.module_get0:08.184,417] [0m<dbg> cloud_module.sub_state_set: Sub state trTED[0m
2021-06-17T16:36:01.601Z DEBUG modem << [00:00:08.196,716] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.603Z DEBUG modem << [00:00evice shadow document requested[0m
2021-06-17T16:36:01.742Z DEBUG modem << [00:00:08.249,694] [0m<dbg> aws_iot.mqtt_evt_handler: MQTT_EVT_s_fota.on_publish_evt: Received topic: $aws/things/thingy91/jobsn_publish_evt: Checking for an available job[0m

here I have changed the shadow!!!

2021-06-17T16:37:06.477Z DEBUG modem << [00:00:08.276,n":"","timestamp":1623947762}[0m[00:00:08.287,048] [0m<dbg> 3,975] [0m<dbg> aws_fota.get_job_execution: No queued jobs for [00:00:08.366,485] [0m<dbg> date_time.time_NTP_server_get: Got nse from NTP server ntp.uio.no[0m[00:00:08.375,915] [0m<dbg> date_time.new_date_time_get: Time from NTP server obtained[0mer: Previously registered handler (nil) de-registered[0m[00:0ED[0m[00:00:08.401,153] [0m<dbg> modules_common.module_enque00:00:08.411,407] [0m<dbg> modules_common.module_enqueue_msg: c8.421,844] [0m<dbg> modules_common.module_enqueue_msg: sensor module: Enqueued: DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.432,nqueued: DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.442,749] [0DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.453,094] [0m<inf> event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, Bes_common.module_enqueue_msg: app module: Enqueued: APP_EVT_DATA0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.488,616] [0m<dbg> modules_common.module_get_next_msg: app m,[0m[00:00:08.501,129] [0m<dbg> nrf9160_gps.enable_gps: GPS .module_[00:00:08.513,946] [0m<dbg> nrf9160_gps.gps_priority_se160_gps.start: GPS operational[0m[00:00:08.527,587] [0m<dbg>EVT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.539,978] [0m<dbg> modules_common.module_enqueue_msg: sensor modulem[00:00:08.552,429] [0m<dbg> modules_common.module_enqueue_mss (MOD_DYN,[0m[00:00:08.564,666] [0m<inf> event_manager: GPSe_set: Sub state transition SUB_STATE_GPS_INACTIVE --> SUB_STATEule_enqueue_msg: data module: Enqueued: GPS_EVT_ACTIVE[0m[00:d module: Enqueued: GPS_EVT_ACTIVE[0m[00:00:08.599,700] [0m<LE --> SUB_STATE_SEARCH[0m[00:00:08.609,924] [0m<dbg> gps_mo7,492] [0m<dbg> nrf9160_gps.gps_thread: A-GPS data update needed[0m[00:00:08.624,603] [0m<dbg> gps_module.gps_event_handlernt_manager: GPS_EVT_AGPS_NEEDED[0m[00:00:08.638,275] [0m<dbgEVT_AGPS_NEEDED[0m[00:00:08.647,979] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: GPS_EVT_AGPS_NEEDED[0met_next_msg: cloud module: Dequeued DATA_EVT_DATE_TIME_OBTt_next_msg: cloud module: Dequeued APP_EVT_DATA_GET - Requested ommon.module_get_next_msg: cloud module: Dequeued GPS_EVT_ACTIVEt_msg: cloud module: Dequeued GPS_EVT_AGPS_NEEDED[0m[00:00:08odule: Dequeued DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.706,054] [0m<dbg> modules_common.module_get_next_msg: sensor module:[00:00:08.718,536] [0m<dbg> modules_common.module_get_next_msg08.729,095] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYNxt_msg: data module: Dequeued GPS_EVT_ACTIVE[0m[00:00:08.750,Dequeued GPS_EVT_AGPS_NEEDED[0m[00:00:08.760,498] [0m<dbg> mT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.774,322] [0m<inf> event_manager: SENSOR_EVT_ENVIRONME.module_enqueue_msg: data module: Enqueued: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m[00:00:08.792,907] [0m<dbg> modules_commonTAL_DATA_READY[0m[00:00:08.803,955] [0m<dbg> modules_common.AL_DATA_READY[0m[00:00:08.815,246] [0m<dbg> modules_common.mAL_DATA_READY[0m[00:00:08.826,232] [0m<dbg> cloud_codec_ringbuffer.cloud_codec_populate_sensor_buffer: Entry: 1 of 9 in sens[00:00:08.894,866] [0m<dbg> modem_module.check_modem_fw_version: Board is running expected modem firmware version: mfw_nrf9160_1.2.3[0m[00:00:08.906,951] [0m<inf> event_manager: MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:08.914,123] [0m<dbg> modulMODEM_STATIC_DATA_READY[0m[00:00:08.925,079] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: MODEM_EVT_MOcommon.module_enqueue_msg: cloud module: Enqueued: MODEM_EVT_MODommon.module_enqueue_msg: app module: Enqueued: MODEM_EVT_MODEM_on.module_get_next_msg: app module: Dequeued MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:08.968,627] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued MODEM_EVT_MODEmmon.module_get_next_msg: cloud module: Dequeued MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:09.088,409] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: modem module: Enqueued: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: data module: Enqueued: MODEM_EVT_MODEM_DYNAModule_enqueue_msg: cloud module: Enqueued: MODEM_EVT_MODEM_DYNAModule_enqueue_msg: app module: Enqueued: MODEM_EVT_MODEM_DYNAMICule_get_next_msg: app module: Dequeued MODEM_EVT_MODEM_DYNAMIC_De_get_next_msg: data module: Dequeued MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.162,139] [0m<dbg> cloud_codec_ringbuffenamic modem buffer filled[0m[00:00:09.174,804] [0m<dbg> modu_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.224,060] [0m<inf> event_manager: MODEM_EVT_BATTERY_DATA_READY[0m[00:00:09.230,804] [0m<dbg> modules_common.moduleDY[0m[00:00:09.241,363] [0m<dbg> modules_common.module_enque[00:00:09.251,770] [0m<dbg> modules_common.module_enqueue_msg:0:09.262,298] [0m<dbg> modules_common.module_enqueue_msg: app m,644] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued MODEM_EVT_BATTERY_DATA_READY[0m[00:00:09.282,989] [0m<dbg> mEVT_MODEM_STATIC_DATA_READY[0m[00:00:09.293,945] [0m<dbg> moVT_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.305,023] [0m<dbg> moVT_BATTERY_DATA_READY[0m[00:00:09.315,582] [0m<dbg> modules_ERY_DATA_READY[0m[00:00:09.326,019] [0m<dbg> cloud_codec_riny buffer filled[0m[00:00:09.337,249] [0m<dbg> modules_commonATA_READY[0m[00:00:09.523,284] [0m<dbg> nrf9160_gps.gps_thread: Waiting fordule.gps_event_handler: GPS_EVT_OPERATION_BLOCKED[0m[00:00:20.760,009] [0m<dbg> modem_module.lte_evt_handler: RRC mode: Idle[0m[00:00:20.767,089] [0m<dbg> nrf9160_gps.gps_thredbg> gps_module.gps_event_handler: GPS_EVT_OPERATION_UNBLOCKED[ts: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:20.791,534] [x 20[0m[00:00:21.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:21.772,552] [0m<d[0m[00:00:22.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:22.772,552] [0m<d[0m[00:00:23.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 23[00:00:24.763,519] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthye_stats: Seconds since last fix 24[0m[00:00:25.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 25[00:00:26.763,885] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 26[00:00:27.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 27[00:00:28.763,702] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:28.772,521] [0m<d[0m[00:00:29.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:29.772,705] [0m<d[0m[00:00:30.341,308] [0m<dbg> watchdog.primary_feed_worker: Feeding watchdog[0m[00:00:30.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:30.772,674] [0m<d[0m[0m[00:00:31.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:31.772,583] [0m<d[0m[00:00:32.763,916] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 32[00:00:33.763,671] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 33[00:00:34.763,916] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:34.772,766] [0m<dbg> nrf9160_gps.p[00:00:35.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:35.772,674] [0m<d[0m[00:00:36.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 36[00:00:37.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 37[0m[00:00:38.763,793] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 38[00:00:39.764,160] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 39[00:00:40.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 40[0m[00:00:41.763,824] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:41.772,644] [0m<d[0m[00:00:42.764,160] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:42.773,010] [0m<d[0m[00:00:43.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:43.773,010] [0m<d[0m[00:00:44.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:44.773,101] [0m<dbg> nrf9160_gps.print[00:00:45.764,007] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:45.772,827] [0m<d[0m[00:00:46.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:46.773,010] [0m<d[0m[00:00:47.764,373] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:47.773,193] [0m<d[0m[00:00:48.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:48.772,918] [0m<d[0m[00:00:49.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 49[00:00:50.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 50[00:00:51.764,251] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 51[00:00:52.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 52[0m[0m[00:00:53.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 53[0m[0m[00:00:54.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:54.773,101] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 54[0m[00:00:55.764,099] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:55.772,918] [0m<d[0m[00:00:56.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:56.773,284] [0m<d[0m[00:00:57.764,312] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:57.773,223] [0m<d[0m[0m[00:00:58.764,129] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 58[00:00:59.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 59[00:01:00.348,327] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:01:00.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 60[00:01:01.764,556] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 61bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 61[00:01:02.764,617] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 62[0m[0m[00:01:03.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:01:03.773,345] [0m<d[0m[0m[00:01:04.764,648] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 64[0m[00:01:05.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 65[00:01:06.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 66[0m[00:01:07.764,556] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:01:07.773,406] [0m<d[0m[00:01:12.781,860] [0m<dbg> gps_module.gps_event_handler: GPS_Estop_gps: Stopping GPS[0m[00:01:12.804,229] [0m<inf> event_manager: GPS_EVT_TIMEOUT[0m[00:01:12.809,844] [0m<dbg> modules_common.module_enqueue_msg:[0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueager: GPS_EVT_INACTIVE[0m[00:01:12.834,350] [0m<dbg> ui_module.sub_state_set: Sub state transition SUB_STATE_GPS_ACTIVE --> _common.module_enqueue_msg: data module: Enqueued: GPS_EVT_INACTeue_msg: cloud module: Enqueued: GPS_EVT_INACTIVE[0m[00:01:12.864,349] [0m<dbg> gps_module.sub_state_set: Sub state transition SUB_STATE_SEARCH --> SUB_STATE_IDLE[0m[00:01:12.874,542] m[00:01:12.882,232] [0m<dbg> modules_common.module_get_next_m] [0m<inf> event_manager: DATA_EVT_DATA_READY[0m[00:01:12.897,583] [0m<dbg> modules_common.module_enqueue_msg: app module: modules_common.module_enqueue_msg: cloud module: Enqueued: DATA_EVT_DATA_READY[0m[00:01:12.916,961] [0m<dbg> modules_common.module_enqueue_msg: sens [0m<dbg> modules_common.module_enqueue_msg: data module: Enquees_common.module_get_next_msg: app module: Dequeued DATA_EVT_DATget_next_msg: data module: Dequeued GPS_EVT_INACTIVE[0m[00:01module: Dequeued DATA_EVT_DATA_READY[0mEncoded message:{"state":{"reported":{"bat":{"v":4203,"ts":1623947762848},"dev":{"v":{"band":3,"nw":"LTE-M","iccid":"8931080219101174933","modV":"mfw_nrf9160_1.2.3","br},
2021-06-17T16:37:06.488Z DEBUG modem << "ts":1623947762531
2021-06-17T16:37:06.488Z DEBUG modem << },
2021-06-17T16:37:06.489Z DEBUG modem << "roam":{
2021-06-17T16:37:06.489Z DEBUG modem << "v":{
2021-06-17T16:37:06.563Z DEBUG modem << "rsrp":56,
2021-06-17T16:37:06.565Z DEBUG modem << "area":14041,
2021-06-17T16:37:06.566Z DEBUG modem << "mccmnc":23203,
2021-06-17T16:37:06.567Z DEBUG modem << 623947762713
2021-06-17T16:37:06.569Z DEBUG modem << },
2021-06-17T16:37:06.570Z DEBUG modem << "env":{
2021-06-17T16:37:06.571Z DEBUG modem << "v":{
2021-06-17T16:37:06.572Z DEBUG modem << "temp":26.53:1623947762399
2021-06-17T16:37:06.572Z DEBUG modem << }
2021-06-17T16:37:06.573Z DEBUG modem << }
2021-06-17T16:37:06.573Z DEBUG modem << }
2021-06-17T16:37:06.574Z DEBUG modem << }
2021-06-17T16:37:06.575Z DEBUG modem << [00:01:13.043,518] [0m<dbg> 050,689] [0m<dbg> data_module.data_list_add_pending: Pending daager: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:01:13.065,307] [0m<dbg> modulA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:01:13.074,798] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:or module: Enqueued: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.577Z DEBUG modem << [00:01:13.094,299] ed: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.578Z DEBUG modem << [00:01:13.104,034] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.579Z DEBUG modem << [00:01:13.11 ringbuffers empty[0m
2021-06-17T16:37:06.579Z DEBUG modem << [00:01:13.122,467] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued DATA_EVT_DATA_SENxt_msg: cloud module: Dequeued GPS_EVT_TIMEOUT[0m
2021-06-17T16:37:06.580Z DEBUG modem << [00:01:13.14e: Dequeued GPS_EVT_INACTIVE[0m
2021-06-17T16:37:06.580Z DEBUG modem << [00:01:13.151,184] [0m<dbg> mVT_DATA_READY[0m
2021-06-17T16:37:06.581Z DEBUG modem << [00:01:13.160,980] [0m<dbg> modules_common.mm
2021-06-17T16:37:06.582Z DEBUG modem << [00:01:13.170,654] [0m<dbg> aws_iot.aws_iot_send: Publishing to topic: $aws/things/thingy91/shadow/update[0m
2021-06-17T16:37:06.583Z DEBUG modem << [00:01:13.180e: Dequeued DATA_EVT_DATA_READY[0m
2021-06-17T16:37:06.670Z DEBUG modem << [00:01:13.190,704] [0m<dbg> modules_common.module_get_next_msg: sensor module: Dequeued DA[00:01:13.215,881] [0m<dbg> cloud_module.data_send: Data sent, data pointer: 0x2001a490[0m
2021-06-17T16:37:06.673Z DEBUG modem << [00:01:13.223,999] [0m<inf> eventodules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVle_enqueue_msg: data module: Enqueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.674Z DEBUG modem << [loud module: Enqueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.676Z DEBUG modem << [00:01:13.258,636ueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.677Z DEBUG modem << [00:01:13.268,432] [0m<dbg> moduATA_ACK[0m
2021-06-17T16:37:06.678Z DEBUG modem << [00:01:13.277,954] [0m<dbg> modules_common.module_ Incoming RSRP status message, RSRP value is 55[0m
2021-06-17T16:37:06.692Z DEBUG modem << _next_msg: ] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.695Z DEBUG modem << [00:01:13.307,403] [0m<dbg> data_module.data_ack: Pending data ACKed: 0x200t_next_msg: modem module: Dequeued CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.999Z DEBUG modem << [00:01:13.621,124] [0m<dbg> modem_module.modem_rsrp_handler: Incoming RSRP status message, RSRP value is 55[0m
2021-06-17T16:37:07.269Z DEBUG modem << [00:01:13.893,310] [0m<dbg> modem_module.lte_evt_handler: RRC mode: Connected[0m
2021-06-17T16:37:54.101Z DEBUG modem << [00:01:14.292,266] [0m<dbg> modem_module.modem_rsrp_handler: In[00:01:25.324,462] [0m<dbg> modem_module.lte_evt_handler: RRC m[00:01:30.355,346] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:02:00.362,365] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:02:00.627,197] [0m<inf> event_manager: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.125Z DEBUG modem << [00:02:00.633,270] [0m<dbg> modules_common.module_enqueue_msg: app module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.126Z DEBUG modem << [00:02:00.642,974] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.652,862] [0m<APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.662,750] [0m<dbg> modules_cGET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.672,698] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.129Z DEBUG modem << [0pp module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.130Z DEBUG modem << [00:02:00.692,352] [0m<inf> event_manager: APP_EVT_DATA_GET - Requested data typeATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.280Z DEBUG modem << [00:02:00.714,630] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqu:02:00.727,142] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.291Z DEBUG modem << [00:02:00.739,715] [0m<dbg> nrf9160_gps.enable_gps: GPS mode is enabled[0m
2021-06-17T16:37:54.293Z DEBUG modem << [00:ud module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.295Z DEBUG modem << [00:02:00.757,110] [0m<dbg> modules_common.module_get_next_msg: cloud module: Deq:02:00.769,866] [0m<dbg> modules_common.module_get_next_msg: mo] [00:02:00.782,073] [0m<dbg> nrf9160_gps.gps_priority_set: GPS priority disabled[0m
2021-06-17T16:37:54.296Z DEBUG modem << [0m<dbg> modules_common.module_get_next0.797,7[00:02:00.799,194] [0m<dbg> nrf9160_gps.start: GPS operanqueue_msg: modem module: Enqueued: APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.298Z DEBUG modem << [00:02:00.817,749] [0m<dbg> modules__GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.299Z DEBUG modem << [00:02:00.830,230] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued00.842,529] [0m<inf> event_manager: GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.300Z DEBUG modem << [00:02:ion SUB_STATE_GPS_INACTIVE --> SUB_STATE_GPS_ACTIVE[0m
2021-06-17T16:37:54.301Z DEBUG modem << [00:02:00.859,069] [0m<dbg> modules_common.module_enqueue_msg: data mo modules_common.module_enqueue_msg: cloud module: Enqueued: GPS_e_set: Sub state transition SUB_STATE_IDLE --> SUB_STATE_SEARCH[0m
2021-06-17T16:37:54.336Z DEBUG modem << [00:02:00.887,939] [0m<dbg> nrf9160_gps.print_satellite_st[0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fta module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.338Z DEBUG modem << [00:02:00.913,757] [0m<dbg> modules_common.module_get_next_msg: data module: Dequ02:00.926,116] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.340Z DEBUG modem << [00:02:00.935,455] [0m<dPP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.341Z DEBUG modem << [00:02:00.dule: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYN,t_msg: cloud module: Dequeued GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.405Z DEBUG modem << [00:02:00.974,334] [0m<inf> event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2021-06-17T16:37:54.407Z DEBUG modem << [00:02:00.981,658] [0m<dbg> modules_commonNTAL_DATA_READY[0m
2021-06-17T16:37:54.408Z DEBUG modem << [00:02:00.992,706] [0m<dbg> modules_commonTAL_DATA_READY[0m
2021-06-17T16:37:54.409Z DEBUG modem << [00:02:01.003,723] [0m<dbg> modules_common.AL_DATA_READY[0m
2021-06-17T16:37:54.425Z DEBUG modem << [00:02:01.015,167] [0m<dbg> modules_common.mAL_DATA_READY[0m
2021-06-17T16:37:54.426Z DEBUG modem << [00:02:01.026,489] [0m<dbg> cloud_codec_ringor buffer filled[0m
2021-06-17T16:37:54.474Z DEBUG modem << [00:02:01.048,583] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: modem module: Enqueued: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.482Z DEBUG modem << [00:02:01.066,864] [0m<dbg> modules_common.IC_DATA_READY[0m
2021-06-17T16:37:54.483Z DEBUG modem << [00:02:01.077,819] [0m<dbg> modules_common.mIC_DATA_READY[0m
2021-06-17T16:37:54.484Z DEBUG modem << [00:02:01.088,867] [0m<dbg> modules_common.m_DATA_READY[0m
2021-06-17T16:37:54.512Z DEBUG modem << [00:02:01.099,792] [0m<dbg> modules_common.modYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.520Z DEBUG modem << [00:02:01.111,358] [0m<dbg> modules_commNAMIC_DATA_READY[0m
2021-06-17T16:37:54.521Z DEBUG modem << [00:02:01.122,253] [0m<dbg> cloud_codec_r 9 in dynamic modem buffer filled[0m
2021-06-17T16:37:54.522Z DEBUG modem << [00:02:01.134,887] [0m<dODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.641Z DEBUG modem << [00:02:01.160,797] [0m<inf> event_manager: MODEM_EVT_BATTERY_DA_enqueue_msg: modem module: Enqueued: MODEM_EVT_BATTERY_DATA_REAue_msg: data module: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.643Z DEBUG modem <<  cloud module: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.655Z DEBUG modem << [00:0odule: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.656Z DEBUG modem << [00:02:01.209Dequeued MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.657Z DEBUG modem << [00:02:01.219,757] [ed MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.658Z DEBUG modem << [00:02:01.230,773] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeu> modules_common.module_get_next_msg: data module: Dequeued MODE_codec_ringbuffer.cloud_codec_populate_bat_buffer: Entry: 2 of 9 in battery buffer filled[0m
2021-06-17T16:37:54.658Z DEBUG modem << [00:02:01.262,969] [0m<dbg> modu_BATTERY_DATA_READY[0m
2021-06-17T16:37:55.188Z DEBUG modem << [00:02:01.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:37:55.200Z DEBUG modem << [00:02:01.813,354] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 121[0m
2021-06-17T16:37:58.188Z DEBUG modem << [00:02:02.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats:  [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last[00:02:03.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:04.804,321] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 124[0m
2021-06-17T16:37:59.188Z DEBUG modem << [00:02:05.804,565] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:37:59.198Z DEBUG modem << [00:02:05.813,385] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 125[0m
2021-06-17T16:38:00.188Z DEBUG modem << [00:02:06.804,656] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:38:00.195Z DEBUG modem << [00:02:06.813,476] [0m<d6[0m
2021-06-17T16:38:01.188Z DEBUG modem << [00:02:07.804,779] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:38:02.188Z DEBUG modem << [00:02:07.813,598] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:08.804,473] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 128[0m
2021-06-17T16:38:04.198Z DEBUG modem << [00:02:09.804,656] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:10.804,901] [0m<dbg> nrf9160_gps.print_satellite_stats: 0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 1 Using: 0 _satellite_stats: Seconds since last fix 130[0m
2021-06-17T16:38:05.194Z DEBUG modem << [00:02:11.805,023] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:05.206Z DEBUG modem << [00:02:11.814,300] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 1 Using: 0 _satellite_stats: Seconds since last fix 131[0m
2021-06-17T16:38:06.197Z DEBUG modem << [00:02:12.804,748] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:06.209Z DEBUG modem << [00:02:12.813,934] [Unhealthy: 0[0m
2021-06-17T16:38:07.198Z DEBUG modem << [00:02:12.822,814] [0m<dbg> nrf9160_gps.print[00:02:13.804,931] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:07.210Z DEBUG modem << [00:02:13.814,086] [Unhealthy: 0[0m
2021-06-17T16:38:11.230Z INFO Modem port is closed

Reply
  • 0 in reply to Markus Tacker (he/him)

    Fullscreen log_file.txt Download 
    2021-06-17T16:35:54.280Z INFO Modem port is opened
2021-06-17T16:35:54.285Z DEBUG modem >> AT+CFUN?
2021-06-17T16:35:55.790Z DEBUG modem << [00:00:02.241,088] [0m<dbg> modem_module.modem_rsrp_handler: In434] [0m<inf> event_manager: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.820Z DEBUG modem << [0dem module: Enqueued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.822Z DEBUG modem << [00:00:02.e: Enqueued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.823Z DEBUG modem << [00:00:02.278,656] ued: MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.824Z DEBUG modem << [00:00:02.289,001] [0m<dbg_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:55.825Z DEBUG modem << [00:00:02.299,255] [0m<dbg> modules_ISCONNECTED[0m
2021-06-17T16:35:55.827Z DEBUG modem << [00:00:02.309,417] [0m<dbg> modem_module.lte_evt_handler: LTE cell changed: Cell ID: 4036619, Tracking area: 1LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.828Z DEBUG modem << [00:00:02.326,385] [0m<dbg> modules_commonUPDATE[0m
2021-06-17T16:35:55.829Z DEBUG modem << [00:00:02.336,669] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m: cloud module: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.830Z DEBUG modem << [00:00:ule: Enqueued: MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.831Z DEBUG modem << [00:00:02.367,279]ued MODEM_EVT_LTE_CELL_UPDATE[0m
2021-06-17T16:35:55.841Z DEBUG modem << [00:00:02.377,563] [0m<dbg> .384,979] [0m<dbg> modem_module.modem_rsrp_handler: Incoming RS<dbg> modules_common.module_get_next_msg: modem module: Dequeueddules_common.module_get_next_msg: modem module: Dequeued MODEM_Emon.module_get_next_msg: data module: Dequeued MODEM_EVT_LTE_DISe_get_next_msg: data module: Dequeued MODEM_EVT_LTE_CELL_UPDATE_msg: cloud module: Dequeued MODEM_EVT_LTE_DISCONNECTED[0m
2021-06-17T16:35:57.602Z DEBUG modem << [00:00:02.446,441] [0m<dbg> modules_common.module_get_next_msg: cl[00:00:04.092,407] [0m<dbg> modem_module.lte_evt_handler: Network registration status: Connected - roaming[0m
2021-06-17T16:35:57.611Z DEBUG modem << [00:00:04.102,2:04.108,489] [0m<dbg> modules_common.module_enqueue_msg: modem ] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqumodules_common.module_enqueue_msg: cloud module: Enqueued: MODEMmon.module_enqueue_msg: app module: Enqueued: MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.613Z DEBUG modem << [00:00:04.148,620] [0m<dbg> modules_common.module_ge0:00:04.158,508] [0m<dbg> modem_module.lte_evt_handler: PSM par6] [0m<inf> event_manager: MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.615Z DEBUG modem << [00:00:04.174,774] [0m<dbg> modules_common.module_enqueue_msg: modem 7] [0m<dbg> modules_common.module_enqueue_msg: data module: Enq> modules_common.module_enqueue_msg: cloud module: Enqueued: MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.617Z DEBUG modem << [00:00:04.205,261] [0m<dbg> modules_SM_UPDATE[0m
2021-06-17T16:35:57.619Z DEBUG modem << [00:00:04.215,301] [0m<dbg> modules_common.modulm
2021-06-17T16:35:57.778Z DEBUG modem << [00:00:04.225,402] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.781Z DEBUG modem << [00:00:04.235,443] NG --> STATE_CONNECTED[0m
2021-06-17T16:35:57.783Z DEBUG modem << [00:00:04.245,147] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued MODEM_EVT_LTdule_get_next_msg: data module: Dequeued MODEM_EVT_LTE_CONNECTEDt_msg: data module: Dequeued MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.787Z DEBUG modem << [00:0d module: Dequeued MODEM_EVT_LTE_CONNECTED[0m
2021-06-17T16:35:57.793Z DEBUG modem << [00:00:04.285,522] [0m<dbg> cloud_module.state_set: State transition STATE_LTE_m<dbg> cloud_module.connect_cloud: Connecting to cloud[0m
2021-06-17T16:35:57.794Z DEBUG modem << [00:00:04.303,161] [1;33m<wrn> cloud_module: Cloud connection estab0m
2021-06-17T16:35:57.795Z DEBUG modem << [00:00:04.320,526] [0m<dbg> modules_common.module_get_next_msg: cloud module: Dequeued MODEM_EVT_LTE_PSM_UPDATE[0m
2021-06-17T16:35:57.796Z DEBUG modem << [00:00: AWS_IOT_EVT_CONNECTING[0m
2021-06-17T16:35:57.797Z DEBUG modem << [00:00:04.339,355] [0m<dbg> cloud_module.cloud_wrap_event_handler: CLOUD_WRAP_EVT_CONNECTING[0m
2021-06-17T16:35:57.798Z DEBUG modem << G[0m
2021-06-17T16:35:57.799Z DEBUG modem << [00:00:04.354,064] [0m<dbg> modules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.800Z DEBUG modem << [00:00:04le: Enqueued: CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.801Z DEBUG modem << [00:00:04.373,565] [0m<CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.809Z DEBUG modem << [00:00:04.383,422] [0m<dbg> modules_common.module_enqueue_msg: modem module: Enqueued: CLOUD_EVT_CONNet_next_msg: app module: Dequeued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.810Z DEBUG modem << [00:00:04.403,045] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.811Z DEBUG modem << [00:00:04.412,872] eued CLOUD_EVT_CONNECTING[0m
2021-06-17T16:35:57.812Z DEBUG modem << [00:00:04.422,729] [0m<dbg> modu_CONNECTING[0m
2021-06-17T16:35:57.911Z DEBUG modem << [00:00:04.533,264] [0m<dbg> aws_iot.broker_init: IPv4 Address found 54.221.63.103[0m
2021-06-17T16:36:01.466Z DEBUG modem << [00:00:04.871,002] [0m<dbg> modem_module.modem_rsrp_handler: In[00:00:07.649,749] [0m<dbg> aws_iot.aws_iot_cloud_poll: AWS bro[00:00:07.967,620] [0m<dbg> aws_fota.aws_fota_mqtt_evt_handler: Previous session valid; skipping FOTA subscriptions[0m
2021-06-17T16:36:01.474Z DEBUG modem << [00:00ed notify_next_topic $aws/things/thingy91/jobs/notify-next[0m
2021-06-17T16:36:01.476Z DEBUG modem <<  Created get_topic $aws/things/thingy91/jobs/$next/get/#[0m
2021-06-17T16:36:01.477Z DEBUG modem << [0reviously subscribed to notify-next topic[0m
2021-06-17T16:36:01.482Z DEBUG modem << [00:00:08.010,3751/jobs/$next/get[0m
2021-06-17T16:36:01.483Z DEBUG modem << [00:00:08.019,195] [0m<dbg> aws_jobs.publish: Publish payload {"clientToken": ""}[0m
2021-06-17T16:36:01.493Z DEBUG modem << [00:00:08.028,076]
2021-06-17T16:36:01.494Z DEBUG modem << [00:00:08.035,186] [0m<dbg> aws_iot_integration.aws_iot_event_ aws_iot_integration.aws_iot_event_handler: AWS_IOT_EVT_READY[0m
2021-06-17T16:36:01.495Z DEBUG modem << [00:00:08.051,910] [0m<dbg> cloud_module.cloud_wrap_event_ham<dbg> modules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.496Z DEBUG modem << [00:00:08.075,958] [0m<dbg> modules_coTED[0m
2021-06-17T16:36:01.586Z DEBUG modem << [00:00:08.085,632] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.588Z DEBUG modem << [00:00.095,367] [0m<dbg> modules_common.module_enqueue_msg: modem module: Enqueued: CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.591Z DEBUG modem << [00:00:08.105,133] [0m<OUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.594Z DEBUG modem << [00:00:08.114,654] [0m<dbg> aws_iot.aws_iot_send: Publishing to topic: $aws/things/thingy91/shadow/get[msg: data module: Dequeued CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.596Z DEBUG modem << [00:00:08.13 UTC...[0m
2021-06-17T16:36:01.598Z DEBUG modem << [00:00:08.141,693] [0m<dbg> date_time.current_time_check: Date time never set[0m
2021-06-17T16:36:01.599Z DEBUG modem << [00:00:08.148,925] [0m<dbg> da.156,341] [0m<dbg> date_time.new_date_time_get: Fallback on NTP State transition STATE_CLOUD_DISCONNECTED --> STATE_CLOUD_CONNECTED[0m
2021-06-17T16:36:01.600Z DEBUG modem << [00:00:08.174,713] [0m<dbg> modules_common.module_get0:08.184,417] [0m<dbg> cloud_module.sub_state_set: Sub state trTED[0m
2021-06-17T16:36:01.601Z DEBUG modem << [00:00:08.196,716] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeued CLOUD_EVT_CONNECTED[0m
2021-06-17T16:36:01.603Z DEBUG modem << [00:00evice shadow document requested[0m
2021-06-17T16:36:01.742Z DEBUG modem << [00:00:08.249,694] [0m<dbg> aws_iot.mqtt_evt_handler: MQTT_EVT_s_fota.on_publish_evt: Received topic: $aws/things/thingy91/jobsn_publish_evt: Checking for an available job[0m

here I have changed the shadow!!!

2021-06-17T16:37:06.477Z DEBUG modem << [00:00:08.276,n":"","timestamp":1623947762}[0m[00:00:08.287,048] [0m<dbg> 3,975] [0m<dbg> aws_fota.get_job_execution: No queued jobs for [00:00:08.366,485] [0m<dbg> date_time.time_NTP_server_get: Got nse from NTP server ntp.uio.no[0m[00:00:08.375,915] [0m<dbg> date_time.new_date_time_get: Time from NTP server obtained[0mer: Previously registered handler (nil) de-registered[0m[00:0ED[0m[00:00:08.401,153] [0m<dbg> modules_common.module_enque00:00:08.411,407] [0m<dbg> modules_common.module_enqueue_msg: c8.421,844] [0m<dbg> modules_common.module_enqueue_msg: sensor module: Enqueued: DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.432,nqueued: DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.442,749] [0DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.453,094] [0m<inf> event_manager: APP_EVT_DATA_GET - Requested data types (MOD_DYN, Bes_common.module_enqueue_msg: app module: Enqueued: APP_EVT_DATA0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.488,616] [0m<dbg> modules_common.module_get_next_msg: app m,[0m[00:00:08.501,129] [0m<dbg> nrf9160_gps.enable_gps: GPS .module_[00:00:08.513,946] [0m<dbg> nrf9160_gps.gps_priority_se160_gps.start: GPS operational[0m[00:00:08.527,587] [0m<dbg>EVT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.539,978] [0m<dbg> modules_common.module_enqueue_msg: sensor modulem[00:00:08.552,429] [0m<dbg> modules_common.module_enqueue_mss (MOD_DYN,[0m[00:00:08.564,666] [0m<inf> event_manager: GPSe_set: Sub state transition SUB_STATE_GPS_INACTIVE --> SUB_STATEule_enqueue_msg: data module: Enqueued: GPS_EVT_ACTIVE[0m[00:d module: Enqueued: GPS_EVT_ACTIVE[0m[00:00:08.599,700] [0m<LE --> SUB_STATE_SEARCH[0m[00:00:08.609,924] [0m<dbg> gps_mo7,492] [0m<dbg> nrf9160_gps.gps_thread: A-GPS data update needed[0m[00:00:08.624,603] [0m<dbg> gps_module.gps_event_handlernt_manager: GPS_EVT_AGPS_NEEDED[0m[00:00:08.638,275] [0m<dbgEVT_AGPS_NEEDED[0m[00:00:08.647,979] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: GPS_EVT_AGPS_NEEDED[0met_next_msg: cloud module: Dequeued DATA_EVT_DATE_TIME_OBTt_next_msg: cloud module: Dequeued APP_EVT_DATA_GET - Requested ommon.module_get_next_msg: cloud module: Dequeued GPS_EVT_ACTIVEt_msg: cloud module: Dequeued GPS_EVT_AGPS_NEEDED[0m[00:00:08odule: Dequeued DATA_EVT_DATE_TIME_OBTAINED[0m[00:00:08.706,054] [0m<dbg> modules_common.module_get_next_msg: sensor module:[00:00:08.718,536] [0m<dbg> modules_common.module_get_next_msg08.729,095] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYNxt_msg: data module: Dequeued GPS_EVT_ACTIVE[0m[00:00:08.750,Dequeued GPS_EVT_AGPS_NEEDED[0m[00:00:08.760,498] [0m<dbg> mT_DATA_GET - Requested data types (MOD_DYN,[0m[00:00:08.774,322] [0m<inf> event_manager: SENSOR_EVT_ENVIRONME.module_enqueue_msg: data module: Enqueued: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m[00:00:08.792,907] [0m<dbg> modules_commonTAL_DATA_READY[0m[00:00:08.803,955] [0m<dbg> modules_common.AL_DATA_READY[0m[00:00:08.815,246] [0m<dbg> modules_common.mAL_DATA_READY[0m[00:00:08.826,232] [0m<dbg> cloud_codec_ringbuffer.cloud_codec_populate_sensor_buffer: Entry: 1 of 9 in sens[00:00:08.894,866] [0m<dbg> modem_module.check_modem_fw_version: Board is running expected modem firmware version: mfw_nrf9160_1.2.3[0m[00:00:08.906,951] [0m<inf> event_manager: MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:08.914,123] [0m<dbg> modulMODEM_STATIC_DATA_READY[0m[00:00:08.925,079] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: MODEM_EVT_MOcommon.module_enqueue_msg: cloud module: Enqueued: MODEM_EVT_MODommon.module_enqueue_msg: app module: Enqueued: MODEM_EVT_MODEM_on.module_get_next_msg: app module: Dequeued MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:08.968,627] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued MODEM_EVT_MODEmmon.module_get_next_msg: cloud module: Dequeued MODEM_EVT_MODEM_STATIC_DATA_READY[0m[00:00:09.088,409] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: modem module: Enqueued: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: data module: Enqueued: MODEM_EVT_MODEM_DYNAModule_enqueue_msg: cloud module: Enqueued: MODEM_EVT_MODEM_DYNAModule_enqueue_msg: app module: Enqueued: MODEM_EVT_MODEM_DYNAMICule_get_next_msg: app module: Dequeued MODEM_EVT_MODEM_DYNAMIC_De_get_next_msg: data module: Dequeued MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.162,139] [0m<dbg> cloud_codec_ringbuffenamic modem buffer filled[0m[00:00:09.174,804] [0m<dbg> modu_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.224,060] [0m<inf> event_manager: MODEM_EVT_BATTERY_DATA_READY[0m[00:00:09.230,804] [0m<dbg> modules_common.moduleDY[0m[00:00:09.241,363] [0m<dbg> modules_common.module_enque[00:00:09.251,770] [0m<dbg> modules_common.module_enqueue_msg:0:09.262,298] [0m<dbg> modules_common.module_enqueue_msg: app m,644] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued MODEM_EVT_BATTERY_DATA_READY[0m[00:00:09.282,989] [0m<dbg> mEVT_MODEM_STATIC_DATA_READY[0m[00:00:09.293,945] [0m<dbg> moVT_MODEM_DYNAMIC_DATA_READY[0m[00:00:09.305,023] [0m<dbg> moVT_BATTERY_DATA_READY[0m[00:00:09.315,582] [0m<dbg> modules_ERY_DATA_READY[0m[00:00:09.326,019] [0m<dbg> cloud_codec_riny buffer filled[0m[00:00:09.337,249] [0m<dbg> modules_commonATA_READY[0m[00:00:09.523,284] [0m<dbg> nrf9160_gps.gps_thread: Waiting fordule.gps_event_handler: GPS_EVT_OPERATION_BLOCKED[0m[00:00:20.760,009] [0m<dbg> modem_module.lte_evt_handler: RRC mode: Idle[0m[00:00:20.767,089] [0m<dbg> nrf9160_gps.gps_thredbg> gps_module.gps_event_handler: GPS_EVT_OPERATION_UNBLOCKED[ts: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:20.791,534] [x 20[0m[00:00:21.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:21.772,552] [0m<d[0m[00:00:22.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:22.772,552] [0m<d[0m[00:00:23.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 23[00:00:24.763,519] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthye_stats: Seconds since last fix 24[0m[00:00:25.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 25[00:00:26.763,885] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 26[00:00:27.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 27[00:00:28.763,702] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:28.772,521] [0m<d[0m[00:00:29.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:29.772,705] [0m<d[0m[00:00:30.341,308] [0m<dbg> watchdog.primary_feed_worker: Feeding watchdog[0m[00:00:30.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:30.772,674] [0m<d[0m[0m[00:00:31.763,763] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:31.772,583] [0m<d[0m[00:00:32.763,916] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 32[00:00:33.763,671] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 33[00:00:34.763,916] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:34.772,766] [0m<dbg> nrf9160_gps.p[00:00:35.763,854] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:35.772,674] [0m<d[0m[00:00:36.763,732] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 36[00:00:37.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 37[0m[00:00:38.763,793] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 38[00:00:39.764,160] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 39[00:00:40.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 40[0m[00:00:41.763,824] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:41.772,644] [0m<d[0m[00:00:42.764,160] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:42.773,010] [0m<d[0m[00:00:43.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:43.773,010] [0m<d[0m[00:00:44.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:44.773,101] [0m<dbg> nrf9160_gps.print[00:00:45.764,007] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:45.772,827] [0m<d[0m[00:00:46.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:46.773,010] [0m<d[0m[00:00:47.764,373] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:47.773,193] [0m<d[0m[00:00:48.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:48.772,918] [0m<d[0m[00:00:49.764,190] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 49[00:00:50.763,977] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 50[00:00:51.764,251] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 51[00:00:52.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 52[0m[0m[00:00:53.764,068] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 53[0m[0m[00:00:54.764,282] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:54.773,101] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 54[0m[00:00:55.764,099] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:55.772,918] [0m<d[0m[00:00:56.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:56.773,284] [0m<d[0m[00:00:57.764,312] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:00:57.773,223] [0m<d[0m[0m[00:00:58.764,129] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 58[00:00:59.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 59[00:01:00.348,327] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:01:00.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 60[00:01:01.764,556] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 61bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 61[00:01:02.764,617] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 62[0m[0m[00:01:03.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:01:03.773,345] [0m<d[0m[0m[00:01:04.764,648] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 64[0m[00:01:05.764,434] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 65[00:01:06.764,465] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 66[0m[00:01:07.764,556] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m[00:01:07.773,406] [0m<d[0m[00:01:12.781,860] [0m<dbg> gps_module.gps_event_handler: GPS_Estop_gps: Stopping GPS[0m[00:01:12.804,229] [0m<inf> event_manager: GPS_EVT_TIMEOUT[0m[00:01:12.809,844] [0m<dbg> modules_common.module_enqueue_msg:[0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueager: GPS_EVT_INACTIVE[0m[00:01:12.834,350] [0m<dbg> ui_module.sub_state_set: Sub state transition SUB_STATE_GPS_ACTIVE --> _common.module_enqueue_msg: data module: Enqueued: GPS_EVT_INACTeue_msg: cloud module: Enqueued: GPS_EVT_INACTIVE[0m[00:01:12.864,349] [0m<dbg> gps_module.sub_state_set: Sub state transition SUB_STATE_SEARCH --> SUB_STATE_IDLE[0m[00:01:12.874,542] m[00:01:12.882,232] [0m<dbg> modules_common.module_get_next_m] [0m<inf> event_manager: DATA_EVT_DATA_READY[0m[00:01:12.897,583] [0m<dbg> modules_common.module_enqueue_msg: app module: modules_common.module_enqueue_msg: cloud module: Enqueued: DATA_EVT_DATA_READY[0m[00:01:12.916,961] [0m<dbg> modules_common.module_enqueue_msg: sens [0m<dbg> modules_common.module_enqueue_msg: data module: Enquees_common.module_get_next_msg: app module: Dequeued DATA_EVT_DATget_next_msg: data module: Dequeued GPS_EVT_INACTIVE[0m[00:01module: Dequeued DATA_EVT_DATA_READY[0mEncoded message:{"state":{"reported":{"bat":{"v":4203,"ts":1623947762848},"dev":{"v":{"band":3,"nw":"LTE-M","iccid":"8931080219101174933","modV":"mfw_nrf9160_1.2.3","br},
2021-06-17T16:37:06.488Z DEBUG modem << "ts":1623947762531
2021-06-17T16:37:06.488Z DEBUG modem << },
2021-06-17T16:37:06.489Z DEBUG modem << "roam":{
2021-06-17T16:37:06.489Z DEBUG modem << "v":{
2021-06-17T16:37:06.563Z DEBUG modem << "rsrp":56,
2021-06-17T16:37:06.565Z DEBUG modem << "area":14041,
2021-06-17T16:37:06.566Z DEBUG modem << "mccmnc":23203,
2021-06-17T16:37:06.567Z DEBUG modem << 623947762713
2021-06-17T16:37:06.569Z DEBUG modem << },
2021-06-17T16:37:06.570Z DEBUG modem << "env":{
2021-06-17T16:37:06.571Z DEBUG modem << "v":{
2021-06-17T16:37:06.572Z DEBUG modem << "temp":26.53:1623947762399
2021-06-17T16:37:06.572Z DEBUG modem << }
2021-06-17T16:37:06.573Z DEBUG modem << }
2021-06-17T16:37:06.573Z DEBUG modem << }
2021-06-17T16:37:06.574Z DEBUG modem << }
2021-06-17T16:37:06.575Z DEBUG modem << [00:01:13.043,518] [0m<dbg> 050,689] [0m<dbg> data_module.data_list_add_pending: Pending daager: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:01:13.065,307] [0m<dbg> modulA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:01:13.074,798] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.576Z DEBUG modem << [00:or module: Enqueued: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.577Z DEBUG modem << [00:01:13.094,299] ed: DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.578Z DEBUG modem << [00:01:13.104,034] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued DATA_EVT_DATA_SEND[0m
2021-06-17T16:37:06.579Z DEBUG modem << [00:01:13.11 ringbuffers empty[0m
2021-06-17T16:37:06.579Z DEBUG modem << [00:01:13.122,467] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued DATA_EVT_DATA_SENxt_msg: cloud module: Dequeued GPS_EVT_TIMEOUT[0m
2021-06-17T16:37:06.580Z DEBUG modem << [00:01:13.14e: Dequeued GPS_EVT_INACTIVE[0m
2021-06-17T16:37:06.580Z DEBUG modem << [00:01:13.151,184] [0m<dbg> mVT_DATA_READY[0m
2021-06-17T16:37:06.581Z DEBUG modem << [00:01:13.160,980] [0m<dbg> modules_common.mm
2021-06-17T16:37:06.582Z DEBUG modem << [00:01:13.170,654] [0m<dbg> aws_iot.aws_iot_send: Publishing to topic: $aws/things/thingy91/shadow/update[0m
2021-06-17T16:37:06.583Z DEBUG modem << [00:01:13.180e: Dequeued DATA_EVT_DATA_READY[0m
2021-06-17T16:37:06.670Z DEBUG modem << [00:01:13.190,704] [0m<dbg> modules_common.module_get_next_msg: sensor module: Dequeued DA[00:01:13.215,881] [0m<dbg> cloud_module.data_send: Data sent, data pointer: 0x2001a490[0m
2021-06-17T16:37:06.673Z DEBUG modem << [00:01:13.223,999] [0m<inf> eventodules_common.module_enqueue_msg: app module: Enqueued: CLOUD_EVle_enqueue_msg: data module: Enqueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.674Z DEBUG modem << [loud module: Enqueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.676Z DEBUG modem << [00:01:13.258,636ueued: CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.677Z DEBUG modem << [00:01:13.268,432] [0m<dbg> moduATA_ACK[0m
2021-06-17T16:37:06.678Z DEBUG modem << [00:01:13.277,954] [0m<dbg> modules_common.module_ Incoming RSRP status message, RSRP value is 55[0m
2021-06-17T16:37:06.692Z DEBUG modem << _next_msg: ] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.695Z DEBUG modem << [00:01:13.307,403] [0m<dbg> data_module.data_ack: Pending data ACKed: 0x200t_next_msg: modem module: Dequeued CLOUD_EVT_DATA_ACK[0m
2021-06-17T16:37:06.999Z DEBUG modem << [00:01:13.621,124] [0m<dbg> modem_module.modem_rsrp_handler: Incoming RSRP status message, RSRP value is 55[0m
2021-06-17T16:37:07.269Z DEBUG modem << [00:01:13.893,310] [0m<dbg> modem_module.lte_evt_handler: RRC mode: Connected[0m
2021-06-17T16:37:54.101Z DEBUG modem << [00:01:14.292,266] [0m<dbg> modem_module.modem_rsrp_handler: In[00:01:25.324,462] [0m<dbg> modem_module.lte_evt_handler: RRC m[00:01:30.355,346] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:02:00.362,365] [0m<dbg> watchdog.primary_feed_worker: Feedi[00:02:00.627,197] [0m<inf> event_manager: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.125Z DEBUG modem << [00:02:00.633,270] [0m<dbg> modules_common.module_enqueue_msg: app module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.126Z DEBUG modem << [00:02:00.642,974] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.652,862] [0m<APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.662,750] [0m<dbg> modules_cGET_ALL[0m
2021-06-17T16:37:54.127Z DEBUG modem << [00:02:00.672,698] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued: APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.129Z DEBUG modem << [0pp module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.130Z DEBUG modem << [00:02:00.692,352] [0m<inf> event_manager: APP_EVT_DATA_GET - Requested data typeATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.280Z DEBUG modem << [00:02:00.714,630] [0m<dbg> modules_common.module_enqueue_msg: cloud module: Enqu:02:00.727,142] [0m<dbg> modules_common.module_get_next_msg: app module: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.291Z DEBUG modem << [00:02:00.739,715] [0m<dbg> nrf9160_gps.enable_gps: GPS mode is enabled[0m
2021-06-17T16:37:54.293Z DEBUG modem << [00:ud module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.295Z DEBUG modem << [00:02:00.757,110] [0m<dbg> modules_common.module_get_next_msg: cloud module: Deq:02:00.769,866] [0m<dbg> modules_common.module_get_next_msg: mo] [00:02:00.782,073] [0m<dbg> nrf9160_gps.gps_priority_set: GPS priority disabled[0m
2021-06-17T16:37:54.296Z DEBUG modem << [0m<dbg> modules_common.module_get_next0.797,7[00:02:00.799,194] [0m<dbg> nrf9160_gps.start: GPS operanqueue_msg: modem module: Enqueued: APP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.298Z DEBUG modem << [00:02:00.817,749] [0m<dbg> modules__GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.299Z DEBUG modem << [00:02:00.830,230] [0m<dbg> modules_common.module_enqueue_msg: data module: Enqueued00.842,529] [0m<inf> event_manager: GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.300Z DEBUG modem << [00:02:ion SUB_STATE_GPS_INACTIVE --> SUB_STATE_GPS_ACTIVE[0m
2021-06-17T16:37:54.301Z DEBUG modem << [00:02:00.859,069] [0m<dbg> modules_common.module_enqueue_msg: data mo modules_common.module_enqueue_msg: cloud module: Enqueued: GPS_e_set: Sub state transition SUB_STATE_IDLE --> SUB_STATE_SEARCH[0m
2021-06-17T16:37:54.336Z DEBUG modem << [00:02:00.887,939] [0m<dbg> nrf9160_gps.print_satellite_st[0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fta module: Dequeued APP_EVT_DATA_GET_ALL[0m
2021-06-17T16:37:54.338Z DEBUG modem << [00:02:00.913,757] [0m<dbg> modules_common.module_get_next_msg: data module: Dequ02:00.926,116] [0m<dbg> modules_common.module_get_next_msg: data module: Dequeued GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.340Z DEBUG modem << [00:02:00.935,455] [0m<dPP_EVT_DATA_GET - Requested data types (MOD_DYN,[0m
2021-06-17T16:37:54.341Z DEBUG modem << [00:02:00.dule: Dequeued APP_EVT_DATA_GET - Requested data types (MOD_DYN,t_msg: cloud module: Dequeued GPS_EVT_ACTIVE[0m
2021-06-17T16:37:54.405Z DEBUG modem << [00:02:00.974,334] [0m<inf> event_manager: SENSOR_EVT_ENVIRONMENTAL_DATA_READY[0m
2021-06-17T16:37:54.407Z DEBUG modem << [00:02:00.981,658] [0m<dbg> modules_commonNTAL_DATA_READY[0m
2021-06-17T16:37:54.408Z DEBUG modem << [00:02:00.992,706] [0m<dbg> modules_commonTAL_DATA_READY[0m
2021-06-17T16:37:54.409Z DEBUG modem << [00:02:01.003,723] [0m<dbg> modules_common.AL_DATA_READY[0m
2021-06-17T16:37:54.425Z DEBUG modem << [00:02:01.015,167] [0m<dbg> modules_common.mAL_DATA_READY[0m
2021-06-17T16:37:54.426Z DEBUG modem << [00:02:01.026,489] [0m<dbg> cloud_codec_ringor buffer filled[0m
2021-06-17T16:37:54.474Z DEBUG modem << [00:02:01.048,583] [0m<inf> event_manager: MODEM_EVT_MODEM_DYNAmodule_enqueue_msg: modem module: Enqueued: MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.482Z DEBUG modem << [00:02:01.066,864] [0m<dbg> modules_common.IC_DATA_READY[0m
2021-06-17T16:37:54.483Z DEBUG modem << [00:02:01.077,819] [0m<dbg> modules_common.mIC_DATA_READY[0m
2021-06-17T16:37:54.484Z DEBUG modem << [00:02:01.088,867] [0m<dbg> modules_common.m_DATA_READY[0m
2021-06-17T16:37:54.512Z DEBUG modem << [00:02:01.099,792] [0m<dbg> modules_common.modYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.520Z DEBUG modem << [00:02:01.111,358] [0m<dbg> modules_commNAMIC_DATA_READY[0m
2021-06-17T16:37:54.521Z DEBUG modem << [00:02:01.122,253] [0m<dbg> cloud_codec_r 9 in dynamic modem buffer filled[0m
2021-06-17T16:37:54.522Z DEBUG modem << [00:02:01.134,887] [0m<dODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.641Z DEBUG modem << [00:02:01.160,797] [0m<inf> event_manager: MODEM_EVT_BATTERY_DA_enqueue_msg: modem module: Enqueued: MODEM_EVT_BATTERY_DATA_REAue_msg: data module: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.643Z DEBUG modem <<  cloud module: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.655Z DEBUG modem << [00:0odule: Enqueued: MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.656Z DEBUG modem << [00:02:01.209Dequeued MODEM_EVT_BATTERY_DATA_READY[0m
2021-06-17T16:37:54.657Z DEBUG modem << [00:02:01.219,757] [ed MODEM_EVT_MODEM_DYNAMIC_DATA_READY[0m
2021-06-17T16:37:54.658Z DEBUG modem << [00:02:01.230,773] [0m<dbg> modules_common.module_get_next_msg: modem module: Dequeu> modules_common.module_get_next_msg: data module: Dequeued MODE_codec_ringbuffer.cloud_codec_populate_bat_buffer: Entry: 2 of 9 in battery buffer filled[0m
2021-06-17T16:37:54.658Z DEBUG modem << [00:02:01.262,969] [0m<dbg> modu_BATTERY_DATA_READY[0m
2021-06-17T16:37:55.188Z DEBUG modem << [00:02:01.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:37:55.200Z DEBUG modem << [00:02:01.813,354] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 121[0m
2021-06-17T16:37:58.188Z DEBUG modem << [00:02:02.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats:  [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last[00:02:03.804,534] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:04.804,321] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 124[0m
2021-06-17T16:37:59.188Z DEBUG modem << [00:02:05.804,565] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:37:59.198Z DEBUG modem << [00:02:05.813,385] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 125[0m
2021-06-17T16:38:00.188Z DEBUG modem << [00:02:06.804,656] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:38:00.195Z DEBUG modem << [00:02:06.813,476] [0m<d6[0m
2021-06-17T16:38:01.188Z DEBUG modem << [00:02:07.804,779] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 0 Using: 0 Unhealthy: 0[0m
2021-06-17T16:38:02.188Z DEBUG modem << [00:02:07.813,598] [0m<dbg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:08.804,473] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 128[0m
2021-06-17T16:38:04.198Z DEBUG modem << [00:02:09.804,656] [0m<dbg> nrf9160_gps.print_satellite_stats: bg> nrf9160_gps.print_satellite_stats: Seconds since last fix 12[00:02:10.804,901] [0m<dbg> nrf9160_gps.print_satellite_stats: 0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 1 Using: 0 _satellite_stats: Seconds since last fix 130[0m
2021-06-17T16:38:05.194Z DEBUG modem << [00:02:11.805,023] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:05.206Z DEBUG modem << [00:02:11.814,300] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking: 1 Using: 0 _satellite_stats: Seconds since last fix 131[0m
2021-06-17T16:38:06.197Z DEBUG modem << [00:02:12.804,748] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:06.209Z DEBUG modem << [00:02:12.813,934] [Unhealthy: 0[0m
2021-06-17T16:38:07.198Z DEBUG modem << [00:02:12.822,814] [0m<dbg> nrf9160_gps.print[00:02:13.804,931] [0m<dbg> nrf9160_gps.print_satellite_stats: Tracking SV  9: not used,     healthy[0m
2021-06-17T16:38:07.210Z DEBUG modem << [00:02:13.814,086] [Unhealthy: 0[0m
2021-06-17T16:38:11.230Z INFO Modem port is closed

Children
Related
Terms of service