TCP connection issues with LTE-M

We are developing a custom device based on the nRF9160 SiP Revision 2 with multiple connections over LTE-M and we are experiencing problems with keeping our only TCP connection connected. The server with which the device connects has TCP keepalive enabled with an interval of 1 minute. Additionally, we have implemented another layer of keepalives on top of the TCP layer with an interval of 10 minutes.

What we noticed is that at seemingly random times the device stops responding to the TCP keepalives, while the other connections are still active & up and the modem stayed registered to the network. Sometimes the connection stays up for multiple hours and at other times the connection is lost after a mere minute.

We have found no way of also enabling TCP keepalive on the device itself, so the device is unaware that the connection has been closed by the server. The devices becomes aware of an issue with the connection is when the 10 minutes keepalive timer expires, then closes its socket and reconnects to the server. When the server closes the connection while the device is still connected, the device is aware that the connection is closed. We are aware of the issue with TCP connections in combination with eDRX and PSM (https://devzone.nordicsemi.com/f/nordic-q-a/55473/fundamental-edrx-design-choices-by-verizon-breaking-functionality) and have therefore disabled these functionalities (and we are not using Verizon.

One of the suggestions made here was to subscribe to the CSCON notifications, but that only would work if there are no other connections using the LTE-M (as they would wake up the modem).

We made a test, with multiple devices, were the device sends 1 byte packets to the server every 59 seconds to circumvent the TCP keepalives and reverse the direction of the traffic. This way the connections stayed up for over a month. This is not the ideal solution as this increases data usage.

Currently, we have enabled socket offloading and are using nRF Connect SDK v1.7.0, and modem firmware 1.3.0. Newer versions of both are available, but would required rewriting the AT command layer as this interface was changed in SDK v1.8.0 and the release notes don't suggest that it would fix our problem.

Are there other suggestion that we might have missed?
Is it possible (in the newer version) to send 0 bytes (TCP keepalive message) via the socket interface? In v1.7.0 sending 0 bytes returns an error.

Parents
  • Hello,

    can you include logs and modem trace from when the connection is dropping?

  • I have a trace where the connection dropped after ~2 hours. Not sure how to enable a modem trace as we can't use UART1.

    [00:00:04.836,425] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 896888 ms remaining
    [00:00:06.828,521] <wrn> lte_modem: AT notification: ("%MDMEV: SEARCH STATUS 2")
    [00:00:07.037,719] <dbg> rms.HandleNetworkingEvent: SOCKET_OPEN
    [00:00:07.038,069] <dbg> rms.SendRegistrationFrame: SendRegistrationFrame start
    [00:00:07.341,186] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:07.492,126] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:07.642,913] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:07.793,914] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:07.944,793] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:08.095,611] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:08.297,210] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:08.448,089] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:08.598,876] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:08.749,786] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:09.403,961] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:09.406,494] <inf> rms: Handling KEEP_ALIVE frame
    [00:00:09.406,646] <inf> rms: Received keepAliveTimeout: 660
    [00:00:21.861,816] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:22.063,476] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:22.215,484] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:22.366,149] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:22.517,486] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:00:39.071,228] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:00:41.016,632] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 58054 ms remaining
    [00:00:57.467,498] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:01:00.847,290] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56620 ms remaining
    [00:01:01.462,677] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:01:27.705,444] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:01:51.209,228] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36496 ms remaining
    [00:02:18.277,069] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:02:41.541,534] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36735 ms remaining
    [00:02:58.216,369] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:03:02.461,181] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55755 ms remaining
    [00:03:23.414,184] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:03:31.922,149] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51492 ms remaining
    [00:03:48.720,977] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:04:07.743,286] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40977 ms remaining
    [00:04:38.968,597] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:05:12.675,384] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26293 ms remaining
    [00:05:33.711,364] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:06:03.057,006] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30654 ms remaining
    [00:06:33.786,285] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:06:53.358,612] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40427 ms remaining
    [00:07:10.019,470] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:07:17.829,406] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52190 ms remaining
    [00:07:38.969,390] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:07:43.680,541] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55288 ms remaining
    [00:08:00.541,076] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:08:23.111,816] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37429 ms remaining
    [00:08:50.688,690] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:09:24.433,471] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26255 ms remaining
    [00:09:44.230,407] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:10:00.394,622] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 43835 ms remaining
    [00:10:00.716,644] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:10:00.718,414] <inf> rms: Handling KEEP_ALIVE frame
    [00:10:00.718,444] <inf> rms: Received keepAliveTimeout: 660
    [00:10:31.293,914] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:11:01.221,710] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30072 ms remaining
    [00:11:22.221,466] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:11:55.238,311] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26983 ms remaining
    [00:12:22.410,491] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:12:45.619,934] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36790 ms remaining
    [00:13:02.411,773] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:13:06.640,594] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55771 ms remaining
    [00:13:27.537,597] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:13:36.101,531] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51436 ms remaining
    [00:13:52.680,389] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:14:11.922,698] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40757 ms remaining
    [00:14:42.895,355] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:14:51.763,977] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51131 ms remaining
    [00:15:08.495,819] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:15:16.571,899] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51923 ms remaining
    [00:15:37.761,749] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:15:42.075,592] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55686 ms remaining
    [00:15:58.897,430] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:16:21.846,862] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37050 ms remaining
    [00:16:49.019,042] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:17:22.728,820] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26290 ms remaining
    [00:17:43.061,798] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:18:13.080,444] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29981 ms remaining
    [00:18:43.233,215] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:19:03.412,078] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39821 ms remaining
    [00:19:20.130,920] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:19:27.452,819] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52678 ms remaining
    [00:19:48.346,008] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:19:51.133,605] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 57212 ms remaining
    [00:19:52.052,642] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:19:52.054,412] <inf> rms: Handling KEEP_ALIVE frame
    [00:19:52.054,443] <inf> rms: Received keepAliveTimeout: 660
    [00:20:10.235,137] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:20:43.955,291] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26279 ms remaining
    [00:21:08.700,408] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:21:34.296,905] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 34403 ms remaining
    [00:21:50.995,758] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:21:52.737,487] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 58258 ms remaining
    [00:22:13.800,689] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:22:24.678,527] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 49122 ms remaining
    [00:22:41.282,379] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:22:58.019,592] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 43262 ms remaining
    [00:23:31.420,318] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:24:03.302,032] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 28118 ms remaining
    [00:24:24.009,674] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:24:55.423,370] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 28586 ms remaining
    [00:25:24.195,953] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:25:45.704,986] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38491 ms remaining
    [00:26:02.321,838] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:26:08.105,712] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54216 ms remaining
    [00:26:29.283,691] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:26:36.046,600] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53237 ms remaining
    [00:26:52.652,435] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:27:13.387,817] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39264 ms remaining
    [00:27:42.845,306] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:28:16.539,825] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26305 ms remaining
    [00:28:34.601,745] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:29:07.091,461] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27510 ms remaining
    [00:29:38.763,793] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:29:41.251,190] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 57512 ms remaining
    [00:29:44.154,235] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:29:44.156,005] <inf> rms: Handling KEEP_ALIVE frame
    [00:29:44.156,066] <inf> rms: Received keepAliveTimeout: 660
    [00:30:00.746,490] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:30:12.413,909] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 48332 ms remaining
    [00:30:29.095,703] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:30:44.594,879] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 44500 ms remaining
    [00:31:19.226,013] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:31:49.876,861] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29349 ms remaining
    [00:32:10.875,671] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:32:43.088,409] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27787 ms remaining
    [00:33:11.017,608] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:33:33.590,026] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37427 ms remaining
    [00:33:50.258,361] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:33:55.321,044] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54937 ms remaining
    [00:34:16.113,769] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:34:23.971,649] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52142 ms remaining
    [00:34:40.623,748] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:35:00.603,149] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40020 ms remaining
    [00:35:30.751,098] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:36:04.475,097] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26276 ms remaining
    [00:36:21.402,709] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:36:54.866,485] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26536 ms remaining
    [00:37:21.578,643] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:37:45.368,469] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36210 ms remaining
    [00:38:01.928,955] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:38:05.569,091] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56359 ms remaining
    [00:38:26.728,851] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:38:35.649,719] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51079 ms remaining
    [00:38:52.286,560] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:39:10.850,860] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 41435 ms remaining
    [00:39:31.684,509] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:39:31.686,279] <inf> rms: Handling KEEP_ALIVE frame
    [00:39:31.686,340] <inf> rms: Received keepAliveTimeout: 660
    [00:39:48.330,718] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:40:16.143,066] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 32187 ms remaining
    [00:40:32.762,847] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:40:35.333,557] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 57429 ms remaining
    [00:40:53.270,111] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:41:06.534,912] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 46735 ms remaining
    [00:41:23.144,409] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:41:37.415,588] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 45728 ms remaining
    [00:42:13.428,039] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:42:42.697,998] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30730 ms remaining
    [00:43:03.551,635] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:43:37.275,299] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26276 ms remaining
    [00:44:09.031,738] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:44:42.641,632] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26390 ms remaining
    [00:45:03.852,508] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:45:32.983,123] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30869 ms remaining
    [00:46:03.917,449] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:46:23.524,749] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40392 ms remaining
    [00:46:40.141,601] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:46:47.825,744] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52315 ms remaining
    [00:47:09.064,880] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:47:13.846,374] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55218 ms remaining
    [00:47:30.478,210] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:47:53.107,635] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37370 ms remaining
    [00:48:20.687,835] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:48:54.399,597] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26288 ms remaining
    [00:49:14.348,693] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:49:22.710,815] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51637 ms remaining
    [00:49:23.379,577] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:49:23.381,347] <inf> rms: Handling KEEP_ALIVE frame
    [00:49:23.381,378] <inf> rms: Received keepAliveTimeout: 660
    [00:49:40.002,380] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:49:44.741,241] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55261 ms remaining
    [00:50:01.462,097] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:50:24.152,496] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37309 ms remaining
    [00:50:51.574,676] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:51:25.294,464] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26280 ms remaining
    [00:51:45.127,410] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:52:15.586,090] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29541 ms remaining
    [00:52:45.294,433] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:53:05.977,691] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39316 ms remaining
    [00:53:22.635,864] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:53:29.758,758] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52877 ms remaining
    [00:53:50.410,430] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:53:56.359,313] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54051 ms remaining
    [00:54:13.011,138] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:54:34.400,543] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38610 ms remaining
    [00:55:03.245,788] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:55:36.952,545] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26293 ms remaining
    [00:55:55.694,458] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:56:27.304,168] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 28390 ms remaining
    [00:56:55.836,395] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:57:17.646,087] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38190 ms remaining
    [00:57:34.234,619] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:57:40.006,500] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54228 ms remaining
    [00:58:00.991,485] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:58:07.928,558] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53062 ms remaining
    [00:58:39.301,971] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:58:45.301,666] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54000 ms remaining
    [00:59:06.100,555] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [00:59:12.929,809] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53170 ms remaining
    [00:59:14.364,746] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [00:59:14.367,095] <inf> rms: Handling KEEP_ALIVE frame
    [00:59:14.367,126] <inf> rms: Received keepAliveTimeout: 660
    [00:59:30.992,370] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:00:03.304,534] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27687 ms remaining
    [01:00:30.969,635] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:00:53.652,709] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37317 ms remaining
    [01:01:10.224,548] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:01:15.053,741] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55170 ms remaining
    [01:01:36.111,724] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:01:43.984,344] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52127 ms remaining
    [01:02:00.693,176] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:02:20.335,510] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40357 ms remaining
    [01:02:50.812,072] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:03:24.537,567] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26274 ms remaining
    [01:03:41.397,430] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:04:14.919,525] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26477 ms remaining
    [01:04:41.551,727] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:05:05.261,322] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36290 ms remaining
    [01:05:21.841,644] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:05:25.941,467] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55900 ms remaining
    [01:05:46.674,438] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:05:55.592,437] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51082 ms remaining
    [01:06:12.285,491] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:06:30.583,557] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 41702 ms remaining
    [01:07:02.445,861] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:07:35.865,631] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26580 ms remaining
    [01:07:56.889,617] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:08:26.407,257] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30482 ms remaining
    [01:08:57.079,559] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:09:03.548,461] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53531 ms remaining
    [01:09:06.482,147] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:09:06.484,680] <inf> rms: Handling KEEP_ALIVE frame
    [01:09:06.484,741] <inf> rms: Received keepAliveTimeout: 660
    [01:09:33.222,717] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:10:06.910,491] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26312 ms remaining
    [01:10:28.051,483] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:10:57.382,415] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30669 ms remaining
    [01:11:28.189,422] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:11:47.773,742] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40415 ms remaining
    [01:12:04.477,569] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:12:12.354,522] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52123 ms remaining
    [01:12:33.323,974] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:12:38.155,364] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55168 ms remaining
    [01:13:09.532,684] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:13:17.636,627] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51896 ms remaining
    [01:13:38.449,005] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:13:43.157,440] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55291 ms remaining
    [01:13:59.969,268] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:14:22.918,731] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37050 ms remaining
    [01:14:50.188,903] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:15:23.920,684] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26268 ms remaining
    [01:15:43.782,684] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:16:14.202,667] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29580 ms remaining
    [01:16:43.894,897] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:17:04.543,914] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39351 ms remaining
    [01:17:21.159,820] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:17:27.885,772] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53274 ms remaining
    [01:17:49.047,637] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:17:54.876,800] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54170 ms remaining
    [01:18:11.753,387] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:18:33.166,748] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38586 ms remaining
    [01:18:53.985,260] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:18:53.987,640] <inf> rms: Handling KEEP_ALIVE frame
    [01:18:53.987,884] <inf> rms: Received keepAliveTimeout: 660
    [01:19:10.541,259] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:19:35.679,138] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 34862 ms remaining
    [01:19:52.259,613] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:19:54.449,371] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 57810 ms remaining
    [01:20:15.501,342] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:20:26.010,375] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 49491 ms remaining
    [01:20:42.629,211] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:20:59.731,475] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 42897 ms remaining
    [01:21:32.875,854] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:22:05.013,580] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27862 ms remaining
    [01:22:25.745,910] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:22:56.705,230] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29040 ms remaining
    [01:23:25.941,467] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:23:47.056,823] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38884 ms remaining
    [01:24:03.757,690] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:24:09.817,565] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53940 ms remaining
    [01:24:31.014,709] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:24:37.438,476] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53576 ms remaining
    [01:24:54.084,503] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:25:15.099,670] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38984 ms remaining
    [01:25:44.204,986] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:26:17.931,793] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26273 ms remaining
    [01:26:36.286,590] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:27:08.483,306] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27803 ms remaining
    [01:27:39.728,637] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:28:13.366,394] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26362 ms remaining
    [01:28:36.639,434] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:28:45.026,428] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51613 ms remaining
    [01:28:45.661,712] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:28:45.663,482] <inf> rms: Handling KEEP_ALIVE frame
    [01:28:45.663,513] <inf> rms: Received keepAliveTimeout: 660
    [01:29:02.265,533] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:29:03.697,357] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 58568 ms remaining
    [01:29:20.320,220] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:29:46.468,383] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 33851 ms remaining
    [01:30:10.480,468] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:30:44.160,583] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26319 ms remaining
    [01:31:07.354,827] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:31:34.642,120] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 32712 ms remaining
    [01:31:51.241,699] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:31:54.472,503] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56769 ms remaining
    [01:32:12.495,391] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:32:24.983,917] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 47511 ms remaining
    [01:32:41.632,324] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:32:56.554,504] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 45077 ms remaining
    [01:33:31.767,242] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:34:01.836,608] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29930 ms remaining
    [01:34:22.729,583] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:34:55.718,322] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27011 ms remaining
    [01:35:22.898,498] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:35:46.269,958] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36628 ms remaining
    [01:36:02.898,803] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:36:07.280,609] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55618 ms remaining
    [01:36:27.994,598] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:36:36.601,562] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51393 ms remaining
    [01:36:53.244,415] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:37:11.922,698] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 41321 ms remaining
    [01:37:43.464,050] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:38:17.144,805] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26319 ms remaining
    [01:38:35.114,440] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:38:35.116,302] <inf> rms: Handling KEEP_ALIVE frame
    [01:38:35.116,363] <inf> rms: Received keepAliveTimeout: 660
    [01:38:51.683,227] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:39:07.466,430] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 44216 ms remaining
    [01:39:24.268,249] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:39:35.927,337] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 48341 ms remaining
    [01:39:56.642,303] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:39:57.979,034] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 58663 ms remaining
    [01:40:14.639,892] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:40:40.569,396] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 34070 ms remaining
    [01:41:04.826,507] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:41:38.481,262] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26345 ms remaining
    [01:42:10.033,599] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:42:43.663,360] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26370 ms remaining
    [01:43:02.063,598] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:43:34.054,992] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 28008 ms remaining
    [01:44:02.238,189] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:44:24.596,618] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37641 ms remaining
    [01:44:41.228,454] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:44:46.337,310] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54891 ms remaining
    [01:45:07.379,760] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:45:14.938,232] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52441 ms remaining
    [01:45:31.640,350] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:45:51.619,415] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40021 ms remaining
    [01:46:21.855,682] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:46:55.541,473] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26314 ms remaining
    [01:47:12.655,303] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:47:45.934,082] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26721 ms remaining
    [01:48:12.865,417] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:48:25.864,349] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 47001 ms remaining
    [01:48:26.090,423] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:48:26.094,543] <inf> rms: Handling KEEP_ALIVE frame
    [01:48:26.094,604] <inf> rms: Received keepAliveTimeout: 660
    [01:48:52.935,546] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:49:26.605,316] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26330 ms remaining
    [01:49:47.648,620] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:50:16.938,262] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30710 ms remaining
    [01:50:47.827,270] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:51:07.339,569] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40487 ms remaining
    [01:51:23.932,403] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:51:32.110,351] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51822 ms remaining
    [01:51:52.885,314] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:51:57.621,185] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55264 ms remaining
    [01:52:14.420,989] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:52:37.393,768] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37027 ms remaining
    [01:53:04.606,628] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:53:38.264,404] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26342 ms remaining
    [01:53:58.189,361] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:54:28.616,027] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 29573 ms remaining
    [01:54:29.027,648] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:54:29.096,038] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 59931 ms remaining
    [01:54:58.369,293] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:55:19.457,641] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38911 ms remaining
    [01:55:36.156,494] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:55:42.358,398] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53798 ms remaining
    [01:56:03.518,371] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:56:09.789,276] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53729 ms remaining
    [01:56:40.248,565] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:56:47.640,472] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52608 ms remaining
    [01:57:08.622,467] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:57:13.891,326] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54731 ms remaining
    [01:57:30.533,172] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:57:52.922,576] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37610 ms remaining
    [01:58:16.276,123] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [01:58:16.277,893] <inf> rms: Handling KEEP_ALIVE frame
    [01:58:16.277,954] <inf> rms: Received keepAliveTimeout: 660
    [01:58:32.857,147] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:58:54.444,885] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 38412 ms remaining
    [01:59:11.110,412] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:59:16.765,594] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 54344 ms remaining
    [01:59:37.823,242] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [01:59:44.786,193] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 53037 ms remaining
    [02:00:01.405,242] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:00:22.047,363] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39358 ms remaining
    [02:00:51.592,651] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:01:25.319,732] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26272 ms remaining
    [02:01:43.068,267] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:02:15.721,038] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 27347 ms remaining
    [02:02:43.223,205] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:03:06.062,652] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 37160 ms remaining
    [02:03:22.675,811] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:03:27.653,320] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 55022 ms remaining
    [02:03:48.371,307] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:03:56.384,643] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51986 ms remaining
    [02:04:13.007,110] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:04:32.295,410] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 40711 ms remaining
    [02:05:03.187,713] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:05:36.877,685] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26310 ms remaining
    [02:05:53.619,354] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:06:27.229,095] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26390 ms remaining
    [02:06:53.831,268] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:07:17.620,727] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36210 ms remaining
    [02:07:34.273,590] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:07:37.901,367] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56372 ms remaining
    [02:07:58.969,360] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:08:07.342,315] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 51627 ms remaining
    [02:08:07.921,203] <dbg> rms.HandleNetworkingEvent: SOCKET_READ
    [02:08:07.922,973] <inf> rms: Handling KEEP_ALIVE frame
    [02:08:07.923,004] <inf> rms: Received keepAliveTimeout: 660
    [02:08:24.486,175] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:08:58.173,950] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26312 ms remaining
    [02:09:24.482,116] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:09:48.515,563] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 35966 ms remaining
    [02:10:05.166,442] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:10:08.946,228] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56220 ms remaining
    [02:10:29.625,213] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:10:38.897,186] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 50728 ms remaining
    [02:11:10.586,700] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:11:13.588,623] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 56998 ms remaining
    [02:11:34.684,295] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:11:44.159,301] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 50525 ms remaining
    [02:12:00.759,124] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:12:18.870,422] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 41888 ms remaining
    [02:12:50.974,029] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:13:24.152,557] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26821 ms remaining
    [02:13:44.973,510] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:14:14.834,136] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 30139 ms remaining
    [02:14:45.091,400] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:15:05.185,760] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 39905 ms remaining
    [02:15:22.407,623] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:15:29.596,862] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 52810 ms remaining
    [02:15:30.187,835] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:15:30.256,530] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 59931 ms remaining
    [02:15:31.547,882] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:15:55.537,689] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 36010 ms remaining
    [02:16:12.169,219] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:16:45.848,999] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26320 ms remaining
    [02:17:02.494,812] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:17:36.200,592] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26294 ms remaining
    [02:17:52.839,447] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:18:26.542,419] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 26297 ms remaining
    [02:18:43.178,070] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:19:07.923,919] <wrn> rms: Keep alive timer expired, resetting connection
    [02:19:07.933,013] <dbg> rms.HandleNetworkingEvent: SOCKET_CLOSE
    [02:19:07.933,044] <wrn> rms: Lost connection
    [02:19:08.024,566] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 35153 ms remaining
    [02:19:08.674,835] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:19:08.743,560] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 59931 ms remaining
    [02:19:33.458,679] <err> lte_modem: +CSCON: 0,7,4. Starting IdleTimer
    [02:19:49.044,860] <err> lte_modem: +CSCON: 1,7,4. IdleTimer: 44413 ms remaining
    [02:19:49.252,777] <dbg> rms.HandleNetworkingEvent: SOCKET_OPEN
    [02:19:49.252,807] <dbg> rms.SendRegistrationFrame: SendRegistrationFrame start

  • esscriber said:
    I have a trace where the connection dropped after ~2 hours. Not sure how to enable a modem trace as we can't use UART1.

    Infocenter says you need to change the source in order to use a different port, so maybe you can change this line.

  • I wasn't able the switch the trace to UART0 because the code keeps giving me errors about UART1 in the devicetree. I was able to set the trace medium to RTT and have a log from that, but my unsure how/if this log needs to be converted to be useful.

Reply Children
Related