This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts

nRF9160 getting stuck after cell change (ESM cause #26)

NOTE: This is related to the following issue: https://devzone.nordicsemi.com/f/nordic-q-a/63255/nrf9160-getting-stuck-after-cell-change

--------------------------------------------------------------------------------

Hi,

we are running into issues where the nRF9160 (in NB-IoT mode) does not seem to handle cell changes reliably. I am using modem firmware mfw_nrf9160_1.2.0 .

We made a simplified test firmware to debug the issue. The test firmware enables several unsolicited notifications from the modem and prints them to the log. It then sends a UDP packet every 30s to a server which logs them. It also calls AT%XMONITOR and AT%NBRGRSRP in hope to get additional information. The AT commands at startup are as follows:

AT%XSYSTEMMODE=0,1,0,2 // Set modem to NB-IoT mode
AT+CGMR // Query modem firmware
AT%XCBAND=? // Query supported bands
AT+CMEE=1 // Subscribe to mobile termination error
AT+CEREG=5 // Subscribe to network registration status
AT+CGEREP=1 // Subscribe to packet domain events
AT+CNEC=24 // Subscribe to network error codes
AT%CESQ=1 // Subscribe to signal quality
AT+CEINFO=1 // Subscribe to Coverage Enhancement notifications
AT%XBANDLOCK=2,"10000000000000000000" // Run-time lock to band 20

AT+CFUN=1 // Enable modem

// *** after connect ***

AT%XCBAND // Query current band
AT+CIMI // Query IMSI
AT+CGPADDR // Query IP address

After a while, sendto starts to fail with errno=ENETUNREACH. The logs show that this is because there is no longer a packet domain connection. The problem can be provoked by driving the system around in a car (more cell changes), but also happens after a few days if the system is stationary. It does seem to fix itself eventually, but may take many hours to do so. However, if I reset the system, it instantly connects again.

The log file looks as follows:

2020-06-24T05:59:28.473Z DEBUG modem << [07:54:44.538,269] <inf> main: sendto done: seq_num=933, retval=20
2020-06-24T05:59:28.494Z DEBUG modem << [07:54:44.587,677] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",141,6346,44,2
2020-06-24T05:59:28.603Z DEBUG modem << [07:54:44.696,960] <inf> modem: Update: %NBRGRSRP: 141,6346,48,164,6346,44,212,6346,42,401,6346,36,400,
2020-06-24T05:59:28.938Z DEBUG modem << [07:54:45.030,364] <inf> modem: Update: +CEINFO: 1,1,R,8,1,44,25
2020-06-24T05:59:29.317Z DEBUG modem << [07:54:45.407,440] <inf> modem: Update: +CEINFO: 1,1,C,2,1,44,25
2020-06-24T05:59:34.744Z DEBUG modem << [07:54:50.837,341] <inf> modem: Update: +CEINFO: 1,1,I,8,1,44,25
2020-06-24T05:59:58.538Z DEBUG modem << [07:55:14.597,198] <inf> main: sendto done: seq_num=934, retval=20
2020-06-24T05:59:58.560Z DEBUG modem << [07:55:14.650,451] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",141,6346,44,2
2020-06-24T05:59:58.687Z DEBUG modem << [07:55:14.780,731] <inf> modem: Update: %NBRGRSRP: 141,6346,48,164,6346,45,212,6346,43,290,6346,37,400,
2020-06-24T05:59:58.797Z DEBUG modem << [07:55:14.891,418] <inf> modem: Update: +CEINFO: 1,1,R,8,1,44,25
2020-06-24T05:59:59.028Z DEBUG modem << [07:55:15.119,842] <inf> modem: Update: +CEINFO: 1,1,C,2,1,44,25
2020-06-24T06:00:04.342Z DEBUG modem << [07:55:20.437,744] <inf> modem: Update: +CEINFO: 1,1,I,8,1,44,28
2020-06-24T06:13:03.384Z DEBUG modem << [08:08:19.413,879] <inf> modem: Update: +CEINFO: 1,1,C,4,1,37,20
2020-06-24T06:13:11.361Z DEBUG modem << [08:08:27.413,604] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,20
2020-06-24T06:13:11.362Z DEBUG modem << +CEREG: 5,"AFAD","009FF867",9
2020-06-24T06:13:11.451Z DEBUG modem >> AT+COPS=3,2
2020-06-24T06:13:11.466Z DEBUG modem << [08:08:27.519,531] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"11100000","11100000"
2020-06-24T06:13:11.468Z DEBUG modem << OK
2020-06-24T06:13:11.575Z DEBUG modem << [08:08:27.627,960] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,20
2020-06-24T06:13:12.021Z DEBUG modem << [08:08:28.071,899] <inf> modem: Update: +CEINFO: 1,1,C,2,1,37,20
2020-06-24T06:13:12.270Z DEBUG modem << [08:08:28.207,458] <inf> modem: Update: +CGEV: ME PDN DEACT 0
2020-06-24T06:13:12.275Z DEBUG modem << +CGEV: ME PDN DEACT 0
2020-06-24T06:13:12.293Z DEBUG modem << +CNEC_EMM: 10
2020-06-24T06:13:12.296Z DEBUG modem << +CEREG: 2,"AFAD","009FF867",9
2020-06-24T06:13:12.300Z DEBUG modem << +CIND: "service",0
2020-06-24T06:13:12.310Z DEBUG modem << +CIND: "roam",0
2020-06-24T06:13:12.314Z DEBUG modem << +CGEV: NW DETACH
2020-06-24T06:13:12.386Z DEBUG modem << [08:08:28.444,946] <inf> modem: Update: +CNEC_EMM: 10
2020-06-24T06:13:12.454Z DEBUG modem >> AT+COPS?
2020-06-24T06:13:12.475Z DEBUG modem << +COPS: 0
2020-06-24T06:13:12.477Z DEBUG modem << OK
2020-06-24T06:13:12.498Z DEBUG modem << [08:08:28.551,055] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
2020-06-24T06:13:12.606Z DEBUG modem << [08:08:28.670,196] <inf> modem: Update: +CGEV: NW DETACH
2020-06-24T06:13:13.244Z DEBUG modem >> AT+CGDCONT?
2020-06-24T06:13:14.084Z DEBUG modem << OK
2020-06-24T06:13:14.089Z DEBUG modem >> AT+CGDCONT?
2020-06-24T06:13:14.134Z DEBUG modem << OK
2020-06-24T06:13:14.139Z DEBUG modem >> AT%XCBAND
2020-06-24T06:13:14.171Z DEBUG modem << %XCBAND: 20
2020-06-24T06:13:14.186Z DEBUG modem << OK
2020-06-24T06:13:14.260Z DEBUG modem >> AT+CGACT?
2020-06-24T06:13:14.394Z DEBUG modem << [08:08:30.467,437] <inf> modem: Update: %CESQ: 42,2,14,2
2020-06-24T06:13:14.402Z DEBUG modem << %CESQ: 42,2,14,2
2020-06-24T06:13:14.404Z DEBUG modem << +CEREG: 2,"AFA1","00A21867",9
2020-06-24T06:13:14.406Z DEBUG modem << +CGACT: 0,0
2020-06-24T06:13:14.419Z DEBUG modem << OK
2020-06-24T06:13:14.441Z DEBUG modem >> AT+CGACT?
2020-06-24T06:13:14.481Z DEBUG modem << +CGACT: 0,0
2020-06-24T06:13:14.485Z DEBUG modem << OK
2020-06-24T06:13:14.512Z DEBUG modem >> AT+CGDCONT?
2020-06-24T06:13:14.514Z DEBUG modem << [08:08:30.572,662] <inf> modem: Update: +CEINFO: 1,1,I,8,1,42,23
2020-06-24T06:13:14.529Z DEBUG modem << +CGDCONT: 0,"IP","","",0,0
2020-06-24T06:13:14.533Z DEBUG modem << OK
2020-06-24T06:13:14.557Z DEBUG modem >> AT+CGACT?
2020-06-24T06:13:14.592Z DEBUG modem << +CGACT: 0,0
2020-06-24T06:13:14.595Z DEBUG modem << OK
2020-06-24T06:13:14.625Z DEBUG modem << [08:08:30.680,969] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,10,"11100000","11100000"
2020-06-24T06:13:14.735Z DEBUG modem << [08:08:30.793,304] <inf> modem: Update: +CEINFO: 1,1,R,8,1,42,23
2020-06-24T06:13:14.848Z DEBUG modem << [08:08:30.899,230] <inf> modem: Update: +CEINFO: 1,1,C,2,1,42,23
2020-06-24T06:13:21.096Z DEBUG modem << [08:08:37.163,635] <inf> modem: Update: +CEINFO: 1,1,R,8,1,42,23
2020-06-24T06:13:21.248Z DEBUG modem << [08:08:37.312,957] <inf> modem: Update: +CEINFO: 1,1,C,2,1,42,23
2020-06-24T06:13:30.093Z DEBUG modem << [08:08:46.177,490] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:13:30.131Z DEBUG modem << [08:08:46.187,255] <err> main: sendto error: seq_num=961, retval=-1, errno=51
2020-06-24T06:13:30.210Z DEBUG modem << [08:08:46.287,322] <inf> modem: Update: OK
2020-06-24T06:14:00.103Z DEBUG modem << [08:09:16.195,800] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:14:00.134Z DEBUG modem << [08:09:16.205,566] <err> main: sendto error: seq_num=962, retval=-1, errno=51
2020-06-24T06:14:00.220Z DEBUG modem << [08:09:16.305,633] <inf> modem: Update: OK
2020-06-24T06:14:26.827Z DEBUG modem >> AT+CFUN?
2020-06-24T06:14:26.865Z DEBUG modem << +CFUN: 1
2020-06-24T06:14:26.879Z DEBUG modem << OK
2020-06-24T06:14:26.906Z DEBUG modem >> AT+CGSN=1
2020-06-24T06:14:26.947Z DEBUG modem << +CGSN: "352656100338527"
2020-06-24T06:14:26.949Z DEBUG modem << OK
2020-06-24T06:14:26.951Z DEBUG modem >> AT+CGMI
2020-06-24T06:14:26.981Z DEBUG modem << Nordic Semiconductor ASA
2020-06-24T06:14:26.983Z DEBUG modem << OK
2020-06-24T06:14:26.985Z DEBUG modem >> AT+CGMM
2020-06-24T06:14:27.013Z DEBUG modem << nRF9160-SICA
2020-06-24T06:14:27.015Z DEBUG modem << OK
2020-06-24T06:14:27.018Z DEBUG modem >> AT+CGMR
2020-06-24T06:14:27.047Z DEBUG modem << mfw_nrf9160_1.2.0
2020-06-24T06:14:27.048Z DEBUG modem << OK
2020-06-24T06:14:27.049Z INFO Nordic Semiconductor ASA nRF9160-SICA [mfw_nrf9160_1.2.0] SerNr: 352656100338527
2020-06-24T06:14:27.051Z DEBUG modem >> AT+CEMODE?
2020-06-24T06:14:27.079Z DEBUG modem << +CEMODE: 0
2020-06-24T06:14:27.081Z DEBUG modem << OK
2020-06-24T06:14:27.108Z DEBUG modem >> AT%XCBAND=?
2020-06-24T06:14:27.134Z DEBUG modem << %XCBAND: (20)
2020-06-24T06:14:27.135Z DEBUG modem << OK
2020-06-24T06:14:27.162Z DEBUG modem >> AT+CMEE?
2020-06-24T06:14:27.188Z DEBUG modem << +CMEE: 1
2020-06-24T06:14:27.189Z DEBUG modem << OK
2020-06-24T06:14:27.215Z DEBUG modem >> AT+CNEC?
2020-06-24T06:14:27.246Z DEBUG modem << +CNEC: 24
2020-06-24T06:14:27.248Z DEBUG modem << OK
2020-06-24T06:14:27.250Z DEBUG modem >> AT+CGEREP?
2020-06-24T06:14:27.280Z DEBUG modem << +CGEREP: 1,0
2020-06-24T06:14:27.282Z DEBUG modem << OK
2020-06-24T06:14:27.284Z DEBUG modem >> AT+CIND=1,1,1
2020-06-24T06:14:27.312Z DEBUG modem << OK
2020-06-24T06:14:27.315Z DEBUG modem >> AT+CEREG=2
2020-06-24T06:14:27.345Z DEBUG modem << OK
2020-06-24T06:14:27.348Z DEBUG modem >> AT+CEREG?
2020-06-24T06:14:27.380Z DEBUG modem << +CEREG: 2,2,"AFA1","00A21867",9
2020-06-24T06:14:27.382Z DEBUG modem << OK
2020-06-24T06:14:27.411Z DEBUG modem >> AT%CESQ=1
2020-06-24T06:14:27.437Z DEBUG modem << OK
2020-06-24T06:14:27.463Z DEBUG modem >> AT+CESQ
2020-06-24T06:14:27.491Z DEBUG modem << +CESQ: 99,99,255,255,14,42
2020-06-24T06:14:27.492Z DEBUG modem << OK
2020-06-24T06:14:27.505Z DEBUG modem >> AT%XSIM=1
2020-06-24T06:14:27.532Z DEBUG modem << OK
2020-06-24T06:14:27.535Z DEBUG modem >> AT%XSIM?
2020-06-24T06:14:27.563Z DEBUG modem << %XSIM: 1
2020-06-24T06:14:27.565Z DEBUG modem << OK
2020-06-24T06:14:27.592Z DEBUG modem >> AT+CPIN?
2020-06-24T06:14:27.619Z DEBUG modem << +CPIN: READY
2020-06-24T06:14:27.620Z DEBUG modem << OK
2020-06-24T06:14:27.649Z DEBUG modem >> AT+CPINR="SIM PIN"
2020-06-24T06:14:27.677Z DEBUG modem << +CPINR: "SIM PIN",3
2020-06-24T06:14:27.678Z DEBUG modem << OK
2020-06-24T06:14:27.712Z DEBUG modem >> AT+CIMI
2020-06-24T06:14:27.739Z DEBUG modem << 901288001059920
2020-06-24T06:14:27.741Z DEBUG modem << OK
2020-06-24T06:14:27.742Z INFO IMSIdentity: 901288001059920
2020-06-24T06:14:30.122Z DEBUG modem << [08:09:46.214,202] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:14:30.167Z DEBUG modem << [08:09:46.224,395] <err> main: sendto error: seq_num=963, retval=-1, errno=51
2020-06-24T06:14:30.238Z DEBUG modem << [08:09:46.324,493] <inf> modem: Update: OK
2020-06-24T06:15:00.139Z DEBUG modem << [08:10:16.233,459] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:15:00.171Z DEBUG modem << [08:10:16.243,621] <err> main: sendto error: seq_num=964, retval=-1, errno=51
2020-06-24T06:15:00.255Z DEBUG modem << [08:10:16.343,688] <inf> modem: Update: OK
2020-06-24T06:15:03.982Z DEBUG modem << [08:10:20.066,528] <inf> modem: Update: %CESQ: 37,1,14,2
2020-06-24T06:15:03.984Z DEBUG modem << %CESQ: 37,1,14,2
2020-06-24T06:15:03.999Z DEBUG modem << +CEREG: 2,"AFAD","009FF867",9
2020-06-24T06:15:04.086Z DEBUG modem << [08:10:20.171,752] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,23
2020-06-24T06:15:04.196Z DEBUG modem << [08:10:20.279,418] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
2020-06-24T06:15:04.307Z DEBUG modem << [08:10:20.391,723] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,23
2020-06-24T06:15:04.419Z DEBUG modem << [08:10:20.501,403] <inf> modem: Update: +CEINFO: 1,1,C,2,1,37,23
2020-06-24T06:15:16.019Z DEBUG modem << [08:10:32.066,680] <inf> modem: Update: %CESQ: 37,1,8,1
2020-06-24T06:15:16.054Z DEBUG modem << %CESQ: 37,1,8,1
2020-06-24T06:15:16.140Z DEBUG modem << [08:10:32.224,609] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,23
2020-06-24T06:15:25.911Z DEBUG modem << [08:10:41.998,291] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,20
2020-06-24T06:15:28.550Z DEBUG modem << [08:10:44.632,781] <inf> modem: Update: +CEINFO: 1,1,C,32,1,37,20
2020-06-24T06:15:28.836Z DEBUG modem << [08:10:44.901,672] <inf> modem: Update: +CNEC_ESM: 26,0
2020-06-24T06:15:28.868Z DEBUG modem << +CNEC_ESM: 26,0
2020-06-24T06:15:28.882Z DEBUG modem << +CNEC_EMM: 19
2020-06-24T06:15:28.979Z DEBUG modem << [08:10:45.068,725] <inf> modem: Update: +CNEC_EMM: 19
2020-06-24T06:15:29.091Z DEBUG modem << [08:10:45.177,215] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,19,"11100000","11100000"
2020-06-24T06:15:30.175Z DEBUG modem << [08:10:46.260,925] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:15:30.218Z DEBUG modem << [08:10:46.272,399] <err> main: sendto error: seq_num=965, retval=-1, errno=51
2020-06-24T06:15:30.273Z DEBUG modem << [08:10:46.372,467] <inf> modem: Update: OK
2020-06-24T06:15:32.632Z DEBUG modem << [08:10:48.723,815] <inf> modem: Update: %CESQ: 29,1,8,1
2020-06-24T06:15:32.636Z DEBUG modem << %CESQ: 29,1,8,1
2020-06-24T06:15:32.668Z DEBUG modem << %CESQ: 34,1,8,1
2020-06-24T06:15:32.681Z DEBUG modem << +CEREG: 2,"AFA1","00A21867",9
2020-06-24T06:15:32.744Z DEBUG modem << [08:10:48.837,158] <inf> modem: Update: %CESQ: 34,1,8,1
2020-06-24T06:15:32.865Z DEBUG modem << [08:10:48.950,439] <inf> modem: Update: +CEINFO: 1,1,I,8,1,34,23
2020-06-24T06:15:32.977Z DEBUG modem << [08:10:49.062,255] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,19,"11100000","11100000"
2020-06-24T06:15:36.539Z DEBUG modem << [08:10:52.640,747] <inf> modem: Update: %CESQ: 29,1,3,0
2020-06-24T06:15:36.579Z DEBUG modem << %CESQ: 29,1,3,0
2020-06-24T06:15:39.114Z DEBUG modem << [08:10:55.200,775] <inf> modem: Update: %CESQ: 29,1,11,1
2020-06-24T06:15:39.117Z DEBUG modem << %CESQ: 29,1,11,1
2020-06-24T06:15:46.780Z DEBUG modem << [08:11:02.880,859] <inf> modem: Update: %CESQ: 29,1,5,0
2020-06-24T06:15:46.823Z DEBUG modem << %CESQ: 29,1,5,0
2020-06-24T06:15:47.450Z DEBUG modem << [08:11:03.552,185] <inf> modem: Update: +CGEV: RESTR 2,2
2020-06-24T06:15:47.493Z DEBUG modem << +CGEV: RESTR 2,2
2020-06-24T06:15:47.530Z DEBUG modem >> AT+CGDCONT?
2020-06-24T06:15:47.568Z DEBUG modem << +CGDCONT: 0,"IP","","",0,0
2020-06-24T06:15:47.570Z DEBUG modem << OK
2020-06-24T06:15:47.600Z DEBUG modem >> AT+CGACT?
2020-06-24T06:15:47.632Z DEBUG modem << +CGACT: 0,0
2020-06-24T06:15:47.634Z DEBUG modem << OK
2020-06-24T06:15:49.353Z DEBUG modem << [08:11:05.440,917] <inf> modem: Update: %CESQ: 34,1,10,1
2020-06-24T06:15:49.356Z DEBUG modem << %CESQ: 34,1,10,1
2020-06-24T06:15:57.019Z DEBUG modem << [08:11:13.121,002] <inf> modem: Update: %CESQ: 34,1,4,0
2020-06-24T06:15:57.066Z DEBUG modem << %CESQ: 34,1,4,0
2020-06-24T06:15:59.593Z DEBUG modem << [08:11:15.677,978] <inf> modem: Update: %CESQ: 14,0,22,3
2020-06-24T06:15:59.595Z DEBUG modem << %CESQ: 14,0,22,3
2020-06-24T06:15:59.701Z DEBUG modem << [08:11:15.787,384] <inf> modem: Update: +CEINFO: 1,1,I,512,32,14,16
2020-06-24T06:16:00.210Z DEBUG modem << [08:11:16.296,356] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:16:00.247Z DEBUG modem << [08:11:16.308,593] <err> main: sendto error: seq_num=966, retval=-1, errno=51\x0D
2020-06-24T06:16:00.322Z DEBUG modem << [08:11:16.408,691] <inf> modem: Update: %NBRGRSRP: 141,6346,27,86,6346,40,290,6346,32,400,6346,31,401,6
2020-06-24T06:16:02.140Z DEBUG modem << [08:11:18.238,006] <inf> modem: Update: %CESQ: 33,1,13,1
2020-06-24T06:16:02.180Z DEBUG modem << %CESQ: 33,1,13,1
2020-06-24T06:16:02.260Z DEBUG modem << [08:11:18.347,076] <inf> modem: Update: +CEINFO: 1,1,I,8,1,33,22
2020-06-24T06:16:20.059Z DEBUG modem << [08:11:36.161,346] <inf> modem: Update: %CESQ: 38,1,13,1
2020-06-24T06:16:20.102Z DEBUG modem << %CESQ: 38,1,13,1
2020-06-24T06:16:30.231Z DEBUG modem << [08:11:46.324,249] <err> main: sendto error: seq_num=967, retval=-1, errno=51
2020-06-24T06:16:30.274Z DEBUG modem << [08:11:46.324,340] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:16:30.356Z DEBUG modem << [08:11:46.441,589] <inf> modem: Update: %NBRGRSRP: 141,6346,40,86,6346,36,290,6346,35,400,6346,31,164,6
2020-06-24T06:17:00.261Z DEBUG modem << [08:12:16.350,921] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:17:00.302Z DEBUG modem << [08:12:16.363,616] <err> main: sendto error: seq_num=968, retval=-1, errno=51
2020-06-24T06:17:00.375Z DEBUG modem << [08:12:16.463,714] <inf> modem: Update: %NBRGRSRP: 141,6346,40,86,6346,40,290,6346,36,164,6346,35,400,6
2020-06-24T06:17:30.297Z DEBUG modem << [08:12:46.388,214] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:17:30.340Z DEBUG modem << [08:12:46.400,451] <err> main: sendto error: seq_num=969, retval=-1, errno=51
2020-06-24T06:17:30.411Z DEBUG modem << [08:12:46.500,549] <inf> modem: Update: %NBRGRSRP: 141,6346,40,86,6346,38,290,6346,36,164,6346,36,400,6
2020-06-24T06:18:00.332Z DEBUG modem << [08:13:16.424,407] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:18:00.374Z DEBUG modem << [08:13:16.436,676] <err> main: sendto error: seq_num=970, retval=-1, errno=51
2020-06-24T06:18:00.446Z DEBUG modem << [08:13:16.536,773] <inf> modem: Update: %NBRGRSRP: 141,6346,38,86,6346,39,440,6346,34,164,6346,33,290,6
2020-06-24T06:18:30.351Z DEBUG modem << [08:13:46.452,301] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:18:30.384Z DEBUG modem << [08:13:46.462,951] <err> main: sendto error: seq_num=971, retval=-1, errno=51
2020-06-24T06:18:30.473Z DEBUG modem << [08:13:46.563,049] <inf> modem: Update: %NBRGRSRP: 141,6346,36,86,6346,39,290,6346,33,164,6346,33,438,6
2020-06-24T06:18:45.980Z DEBUG modem << [08:14:02.083,282] <inf> modem: Update: %CESQ: 38,1,18,2
2020-06-24T06:18:45.995Z DEBUG modem << %CESQ: 38,1,18,2
2020-06-24T06:19:00.390Z DEBUG modem << [08:14:16.479,949] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:19:00.413Z DEBUG modem << [08:14:16.492,187] <err> main: sendto error: seq_num=972, retval=-1, errno=51
2020-06-24T06:19:00.505Z DEBUG modem << [08:14:16.592,315] <inf> modem: Update: %NBRGRSRP: 141,6346,39,86,6346,38,164,6346,34,401,6346,32,400,6
2020-06-24T06:20:00.466Z DEBUG modem << [08:15:16.552,429] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:20:00.512Z DEBUG modem << [08:15:16.564,636] <err> main: sendto error: seq_num=974, retval=-1, errno=51
2020-06-24T06:20:00.584Z DEBUG modem << [08:15:16.664,733] <inf> modem: Update: %NBRGRSRP: 141,6346,49,212,6346,46,86,6346,43,328,6346,43,290,6
2020-06-24T06:20:05.348Z DEBUG modem << [08:15:21.444,366] <inf> modem: Update: %CESQ: 48,2,23,3
2020-06-24T06:20:05.363Z DEBUG modem << %CESQ: 48,2,23,3
2020-06-24T06:20:30.504Z DEBUG modem << [08:15:46.588,684] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:20:30.540Z DEBUG modem << [08:15:46.600,006] <err> main: sendto error: seq_num=975, retval=-1, errno=51
2020-06-24T06:20:30.619Z DEBUG modem << [08:15:46.700,103] <inf> modem: Update: %NBRGRSRP: 141,6346,53,212,6346,48,86,6346,45,459,6346,44,328,6
2020-06-24T06:21:00.540Z DEBUG modem << [08:16:16.623,962] <inf> modem: Update: %XMONITOR: 2  OK
2020-06-24T06:21:00.583Z DEBUG modem << [08:16:16.636,260] <err> main: sendto error: seq_num=976, retval=-1, errno=51
2020-06-24T06:21:00.654Z DEBUG modem << [08:16:16.736,358] <inf> modem: Update: %NBRGRSRP: 141,6346,48,212,6346,41,328,6346,40,86,6346,38,459,6
2020-06-24T06:21:09.347Z DEBUG modem << [08:16:25.445,220] <inf> modem: Update: %CESQ: 48,2,16,2
2020-06-24T06:21:09.384Z DEBUG modem << %CESQ: 48,2,16,2
2020-06-24T06:21:17.040Z DEBUG modem << [08:16:33.125,305] <inf> modem: Update: %CESQ: 43,2,16,2
2020-06-24T06:21:17.041Z DEBUG modem << %CESQ: 43,2,16,2
2020-06-24T06:21:19.588Z DEBUG modem << [08:16:35.685,363] <inf> modem: Update: %CESQ: 43,2,10,1
2020-06-24T06:21:19.629Z DEBUG modem << %CESQ: 43,2,10,1
2020-06-24T06:21:22.162Z DEBUG modem << [08:16:38.242,309] <inf> modem: Update: %CESQ: 19,0,25,3
2020-06-24T06:21:22.165Z DEBUG modem << %CESQ: 19,0,25,3
2020-06-24T06:21:22.269Z DEBUG modem << [08:16:38.351,715] <inf> modem: Update: +CEINFO: 1,1,I,512,32,19,22
2020-06-24T06:21:24.708Z DEBUG modem << [08:16:40.802,337] <inf> modem: Update: %CESQ: 38,1,7,1
2020-06-24T06:21:24.745Z DEBUG modem << %CESQ: 38,1,7,1
2020-06-24T06:21:24.830Z DEBUG modem << [08:16:40.911,285] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,19
2020-06-24T06:21:30.565Z DEBUG modem << [08:16:46.593,017] <inf> modem: Update: +CEREG: 2,"AFA1","009DF767",9,0,19,"11100000","11100000"
2020-06-24T06:21:30.601Z DEBUG modem << +CEREG: 2,"AFA1","009DF767",9
2020-06-24T06:21:30.615Z DEBUG modem << +CGEV: RESTR 2,2
2020-06-24T06:21:30.618Z DEBUG modem << [08:16:46.673,797] <err> main: sendto error: seq_num=977, retval=-1, errno=51
2020-06-24T06:21:30.651Z DEBUG modem >> AT+CGDCONT?
2020-06-24T06:21:30.700Z DEBUG modem << [08:16:46.766,693] <inf> modem: Update: +CGEV: RESTR 2,2
2020-06-24T06:21:30.703Z DEBUG modem << +CGDCONT: 0,"IP","","",0,0
2020-06-24T06:21:30.704Z DEBUG modem << OK
2020-06-24T06:21:30.738Z DEBUG modem >> AT+CGACT?
2020-06-24T06:21:30.780Z DEBUG modem << +CGACT: 0,0
2020-06-24T06:21:30.782Z DEBUG modem << OK

In this case, we observe the following Error messages:

  • +CNEC_ESM: 26,0 (Session Management Error: Insufficient resources)

  • +CNEC_EMM: 19 (Mobility Management Error: ESM failure)

  • +CGEV: RESTR 2,2

    • Requested procedure restricted:

    • 2 – Throttling. Procedure restricted by 3GPP or operator-specific throttling.

    • 2 – Temporary restriction. Enabling requires e.g. back-off timer expiry.

According to the following site, this is related to the back-off timer T3396: https://itectec.com/spec/6-5-ue-requested-esm-procedures/ 

(see chapter 6.5.1.4.2 Handling of network rejection due to ESM cause #26)

What would be the appropriate action to prevent this error ?

Does Nordic use this timer, and can it be modified ?

Here is the complete logfile:

https://devzone.nordicsemi.com/cfs-file/__key/support-attachments/beef5d1b77644c448dabff31668f3a47-4fe3d670a3c74b3190355cbb48601128/2020_2D00_06_2D00_23-ESM-failure-_2300_26-_2D00_-T22_5F00_25_5F00_26.188Z_2D00_log.txt

  • I have attached a trace with Trace Collector.

    AT command logfile:

    2020-08-13T20:44:36.407Z INFO Application data folder: /Users/owierichs/Library/Application Support/nrfconnect/pc-nrfconnect-linkmonitor
    2020-08-13T20:44:36.505Z DEBUG App pc-nrfconnect-linkmonitor v1.1.4 official
    2020-08-13T20:44:36.506Z DEBUG App path: /Users/owierichs/.nrfconnect-apps/node_modules/pc-nrfconnect-linkmonitor
    2020-08-13T20:44:36.506Z DEBUG nRFConnect 3.4.2 is supported by the app (^3.2.0)
    2020-08-13T20:44:36.506Z DEBUG nRFConnect path: /Applications/nRF Connect.app/Contents/Resources/app.asar
    2020-08-13T20:44:36.506Z DEBUG HomeDir: /Users/owierichs
    2020-08-13T20:44:36.506Z DEBUG TmpDir: /var/folders/d1/f1j8j__x7bx7dtwb3bcgwscm0000gn/T/
    2020-08-13T20:44:36.509Z VERBOSE Could not fetch serial number for serial port at /dev/tty.Bluetooth-Incoming-Port
    2020-08-13T20:44:54.558Z INFO Modem port is opened
    2020-08-13T20:44:54.563Z DEBUG modem >> AT+CFUN?
    2020-08-13T20:44:55.144Z DEBUG modem << NRF52840 board control statically configured. DK Uptime is 30 seconds
    2020-08-13T20:44:58.045Z INFO Modem port is closed
    2020-08-13T20:44:58.052Z INFO Modem port is opened
    2020-08-13T20:44:58.056Z DEBUG modem >> AT+CFUN?
    2020-08-13T20:44:59.437Z DEBUG modem << 
    2020-08-13T20:44:59.494Z DEBUG modem << ˆ&T‹(ÉKHŽˆë
    2020-08-13T20:44:59.495Z DEBUG modem << ˆˆ6Vÿ‡¡þ6HÜ6‰Œã¹p€D¬ 
    2020-08-13T20:44:59.496Z DEBUG modem << D@6HT\‹­j¹
    2020-08-13T20:44:59.497Z DEBUG modem << 8@§‹
    2020-08-13T20:44:59.558Z DEBUG modem << @K6"(ÿ@HHê k©Â&"L@$(­$Ê
    2020-08-13T20:44:59.590Z DEBUG modem << ¨$)€ÿbâx·X´
    2020-08-13T20:45:04.576Z DEBUG modem << "j‰ˆƒà6ˆˆ&@ ˆˆ-ÀXxÿBÉ°/¶i-‰ƒ‚DÌ@ˆDPT-‰ˆ`Á6›ÿC¸é$g‹KCa©ˆ¹#­@ˆ@H‡­ J49‹KKƁïîK…¨Ø˜‰­¬Xü HBrj+J’FhB™6Ȁ( ,‡«ˆÈ6™ÿ­|H¶þ6‘ÿ‡¼êÂJø­@P$Ê66Xÿ¥5¹@ §@!@ HÂ6Z™ƒ`(€Ð‡=˜’@J’‰$*6å=@Œ­‚å¥-§¨Õ¡$€‹¤!˜­É¨É)¡¯€@úH@ÃJ'#PX$™ÿȘ§ˆ¼gŠXƒ¡6@ˆ€Z,ëˆ6€Ì‰˜'Š oˆˆ˜ZÚÍ@€ˆÏÎÁ$ŠÀ’øOAB͐’0‹'Š(þ:ÉHé ˆÂ(6˜˜Ë@«›+ˆ –Œ€$ˆ6-(É((,"é;ƒ,™6X˜6œ‰-î¤
    2020-08-13T20:45:04.678Z DEBUG modem << ™¡'"‹ *¶&Ä"6FÌ7¬ $(§ ‹ $$$hHÿh ƒHè &..$« 6!ï@H˜˜ˆ‚$­
    2020-08-13T20:45:04.819Z DEBUG modem << H$$$6°‰"0Š·¨8â&,$˜hÁ6",¥@í
    2020-08-13T20:45:04.831Z DEBUG modem << &.,‡(
    2020-08-13T20:45:04.859Z DEBUG modem << &48È
    2020-08-13T20:45:04.866Z DEBUG modem << (x‹t’*K…ØFxT
    2020-08-13T20:45:04.867Z DEBUG modem << .ъP@[ 
    2020-08-13T20:45:04.868Z DEBUG modem << &H°.)8ƒ,$
    2020-08-13T20:45:04.869Z DEBUG modem << KQ€J
    2020-08-13T20:45:04.871Z DEBUG modem << x‰h8€
    2020-08-13T20:45:04.872Z DEBUG modem << €
    2020-08-13T20:45:04.873Z DEBUG modem << W*I$Æ­2,
    2020-08-13T20:45:04.881Z DEBUG modem << ˆä0
    2020-08-13T20:45:04.882Z DEBUG modem << $‘`r
    2020-08-13T20:45:04.882Z DEBUG modem << (&$ÀÚ$
    2020-08-13T20:45:05.087Z DEBUG modem << " Q‘r&.ÉÚ(,,,xêièšfÁ*rxêOA˜râ€äCã@Hézš)F[hZIZ‰"¡d0j)hh( àÁ8§®8o&*$« *`Ê6.*ë( 6ˆ ï@Ë@ˆ(‡&‹
    2020-08-13T20:45:05.222Z DEBUG modem << &¢xÈ$.À
    2020-08-13T20:45:05.517Z DEBUG modem << HØïko $ÀF@¬‚$$6 (¯@¯( ('*   "´b̼ó¨´bá'O™!4‘ÿ-ãÎH*XÕõ€ ‰cK ‘¡‰ð0p "¡02ø"(¡ýû€ê‹È±ØúEØÚH˪H£"A4èYy;*ab‚‚BMÁïødÉNš(‡
    2020-08-13T20:45:05.530Z DEBUG modem << ‚¸«¬žˆˆ€ŒË(ë
    2020-08-13T20:45:05.689Z DEBUG modem << ¤6‰Bϧ€™‰€í
    2020-08-13T20:45:05.692Z DEBUG modem << 6ˆ¬
    2020-08-13T20:45:05.702Z DEBUG modem << ‚¶
    2020-08-13T20:45:05.709Z DEBUG modem << ýÿ·± j€Š§Œï@ 6Y@6^ÿ¥ÑÎL‡H@Hˆ6
    2020-08-13T20:45:05.783Z DEBUG modem << P\P‹Ü`Dá'·Ì@X\‘HE ™È‰‰Ï
    2020-08-13T20:45:05.811Z DEBUG modem << ­€‰‰-l€L ™è‡ì§á§á-ʒÄ,D-ùŠàXkÉQ‹B¹P§@@
    2020-08-13T20:45:05.821Z DEBUG modem << @Hˆ Z
    2020-08-13T20:45:05.975Z DEBUG modem <<  ˆY™( ÉÁÍÙa@0¨RÊÂLP@@L…‚ §€@Ä6Pˆ-PcÚH@@§\@FˆŒ"Rƒ7\k+LH@' ‰È6!Ê6ÿké7JB‹ˆ™ÁˆÑ™iÉK‰4I ý‚C $QÊH)$X < DÀ@C0±Ù@áPáLX@JHX"X
    2020-08-13T20:45:05.989Z DEBUG modem << jí½Ë› P*‹\D±Ôh«PñIP$PAÛ¡±
    2020-08-13T20:45:05.990Z DEBUG modem << Á.‰TãC[먈HL™T±‹›)Yˆ¡)¡‘PJ©
    2020-08-13T20:45:05.992Z DEBUG modem << D(KPŠ
    2020-08-13T20:45:05.993Z DEBUG modem << @@ D
    2020-08-13T20:45:06.002Z DEBUG modem <<  PHAYûƒB‚ÊB(H'OÞÈ
    2020-08-13T20:45:06.225Z DEBUG modem << €Hø¬ @‰ A6ÊÛ¢'(¢þ'È9þ6H6ÿL¡‹á,µÐBÂ$ˆ¡,¡‘‰)X°ƒ±¹¡Ê¡§ É@(‰6@™P#þ§˜‰&Éɋ‡A@½6IHþ4‹ÿ+ŠÁÑё‹·kÅ6ÕÕ4‹-h#)6&ä4҉­|
    2020-08-13T20:45:08.465Z DEBUG modem << ê¶*@6ü‚'Rkä&&ü$þ‹‚`#"Öðˆ¶¨ø()¾ƒ§rkä6,þ6ڋ'Š,©6Á¤ƒ‚Èʋ'ˆ¨ÈˆÈ·Š¼È6 $ˆÀ'ˆpʶ¤4ˆÀ·¬’6€²´ŠÀ¬ˆx©6H6‰‰Ãâʂ̧@¤ kÿ5gø6Æÿ§Š ¹6È4ŠÀ'ˆ ‰6þ$ˆÈ‚ ‚È!È6€Ì7ˆ¬Hþ’’´‰‰­ˆp‚6Ê4ɋˆ¸È6ʈÌÉÔ¨È6H‰‰‚,µŠÊEȈ̭ˆ¬Pþ6Xý4ˆÀ,ˆx`È6‚Ì‚(6È*‰!à6È4ˆÀƒkŠÊȊÌ7Š¸Ê6ÈH‹§Š¼Ê6þH‹'k™6Ѥ‚§jˆ6`¶*ÿ,ðü¶‘4ÿ7Hù& 4™ÿ'Ì6¹¶˜‰·µþƒƒ4Œ‹‡+`&Q™™ˆtk„6@Ђ§µ­ °8‹,´ ø6™™ÿƒ&¤6ý‘ÿ-&‰6 ü4.ÿ­´hþ6!ù6›ÿ'µÜ‘b$ы‡k‹6ûXÿ7µþ6È4™ÿ§xhþ6Ù6™‰,+ÉÑсƒ§…kŶ œ‹-h#`ü6,þ6ú‰§tk ü&"´Þ‰'p¨î6&Ö$™ÿ­x ù6(Þ$.ÿ~+¤&ò(‹‚rkÆ$Öàƒ7Š¬xú6™6´‰·
    2020-08-13T20:45:08.585Z DEBUG modem << ¸Ê¶ $ˆÈˆ¨ÊÂÿ­ˆŒŠÊ6xü$ˆÀ-ˆ0ŠÊ6
    2020-08-13T20:45:08.625Z DEBUG modem << ™‘ÿƒˆ ŠÞþ6
    2020-08-13T20:45:08.746Z DEBUG modem << ’ÿ¥ù6@‰ ‹ÃŠÈ6ÊÃÿ¬{ïþ
    2020-08-13T20:45:08.816Z DEBUG modem << ° ‚,Šxñ‰6™ÿ§Š¬žé'
    2020-08-13T20:45:08.826Z DEBUG modem << ï' hÊ64‰‰‡ È6
    2020-08-13T20:45:08.841Z DEBUG modem << b1ÿ'Š¨š
    2020-08-13T20:45:08.883Z DEBUG modem << ‡¯¯ 6‹-‚¤žÊ…ʶŠÀ§Š<ž
    2020-08-13T20:45:08.896Z DEBUG modem << (ì@
    2020-08-13T20:45:08.908Z DEBUG modem << ˆ4ŠÀ‚õ˜6
    2020-08-13T20:45:08.985Z DEBUG modem << Ê3ˆµqH§!@HS& 6ŠÈ7ˆ œ‘“š¶É‹­Š,xú6
    2020-08-13T20:45:09.026Z DEBUG modem << pû6€È-ˆ¨È6
    2020-08-13T20:45:09.067Z DEBUG modem << p4ŠÀ·ˆ¬™&
    2020-08-13T20:45:09.225Z DEBUG modem << ™$ɋ'ˆ¸È6Ê0™ÿ§¨’Ê6þÃÿˆ¸‚Ê6#±ÿ­ˆ
    2020-08-13T20:45:09.268Z DEBUG modem << ŠÊ&Ì4ˆÈ'ˆ ü&
    2020-08-13T20:45:09.305Z DEBUG modem << xü$ˆÀ­Š Ê
    2020-08-13T20:45:09.585Z DEBUG modem << È´ˆÀ7Š¨ÿ6È$ŠÀ·Š¬þ6Èh‹7P¬©6A™$¤‹·X¸ˆ6hè4RÈBxHüJê6䉇ڨ(6èBÈ ‚| 
    2020-08-13T20:45:09.945Z DEBUG modem << Ìj¹PHÿ§t¨þ6‚¢4Œ‹Ü¨é6A™™ˆ¬F,ŠÄ6@´‰§T¬¬¶¤€VÈ'V,©†`Zƒ§R¬Ä6LP¶X‰7¸Ì¶$‹­T¨Hþ6nî$0‹'ܨ
    2020-08-13T20:45:10.385Z DEBUG modem << À6NŠ™‹§T¬æ6îVÌ7T¬äì$TÀ‡Ü¬©66™ˆ7kÁ&ÑPÿÌ$ü§kXþ&Õ$„‹7R,K¶H¢@‹‚¨‚â6jê6PÈ7P¬$â6Hê$PÀ‡Ø¼àJèPÈ%R0à6Jè$PÀ§P¸à6
    2020-08-13T20:45:10.506Z DEBUG modem << þRÈج©6Ù6¤ƒ­P¬ŠæH(6@ÈR8â&L
    2020-08-13T20:45:10.546Z DEBUG modem << ü$RÈ'R¨X&
    2020-08-13T20:45:10.585Z DEBUG modem << èPÀ'R¨ü&
    2020-08-13T20:45:11.041Z DEBUG modem << êPÀ‡Ü¬ä6j€6TÈܨä™6™‚‡ÜˆŠäì6VÈ'T(ä&„ì4VÈ'V¬ù6Ùɋ­Txý&‰$VÀ7V¨æ66VÌ­V¨@þ6nî4TȧT¨‘’²$ً­Æ¬š6L2´TȧTx½d¬É@‹ 6™”ì^ˆFqi'FÉ
    2020-08-13T20:45:11.056Z DEBUG modem << É  6™‰‹'V$æÂb‚P¬¡¡‰‰¡X‹
    2020-08-13T20:45:11.074Z DEBUG modem << ‰1N©RPBZVÊBLDNÑDîŽ^HáˆFFË@ë 
    2020-08-13T20:45:11.077Z DEBUG modem << ™¹7‰ %yÍII IiÝÙ]‰q™)Ù\€ÁLDdF
    2020-08-13T20:45:15.208Z DEBUG modem << ±D 1è"±\lÀ¡ÄŠ@N$LP¡N ØTZFL,ª™Ö3\PN,LQ$YáÁ¡¡©‰ ©‰©©©¡±ñ±ù±™±©‰©+ÉeKFío(PH„Á\ƒ@JÀKn‘DfL†fŠFÂBFëDϬÉ$DµHT@$ى£¬Ž‚FF4j@ dFllD™™9º£@£ šQPJRDFF-ÊT{C±.RbÛJÞH@aLqDL”™LbN(H&P/RJZP!N‰Z鈃DH€H@&™™ï@†€Á§FÏJJFÂÈ­B,ÞPüJ‰´rÈ,@ˆ„à6àÀÈ­@(„Â6€6PÌ7R¬Œà6hê4RÀ·P,ŽŠè6PÌÚ,„6PþPÀ­RxŽâ6h‰ÂÈ-P8Žà6è6PÈZ¸Œâ6H 4PȇP Œà6hèRÈ%RpŽâ&@ý6PÈ·r(Œâ6HêX‹'P,Œâ6H ´RȇÚ8Œâ6Jê6PÈ-P(„@H肋·p(Œ¹6Y‰‰‹§R$Œâê4™‰Ø8Œ¹6QRÈ­B,„à6Pþ4‰'R8Žâ&JêPÈ­PxŽà6à$RÀ¨„6Y‰6™ƒ­R0Ž©6Hê´RÌ7p(Ž¹6‰Ñ‹·R(Žà6jê™ÿ¬B(„â6ü$RÈ'P(Œà6hèRÀ§R¤Œâ&JBÈ'r(Žâ6ê6rÈ‡Ø „FNâJ‰nNL)¢±+tVÂ^„‘NÌZD4ù+ƒ‡tN‰NlT@ËzBÜbFJÒ¨DHNê€LŽFFñD‘N‘LaJNé#XDÜbaÆJÎKFö^ÄJNÑD@!\ZLÂLg6ü|à€Ñˆˆ\VD$LTDfFNlԄChL4B¥0WHéPˆÏhð&BJë(Bn¯@x f#FFRȭҘ6hè4RÀƒR !§F ‚F6JH@ȯr0$D§x@0d6JD6RÈZPÀ·R4TD‰‘™BJŽ@BRBL5Jp‚ 2pR$PÀBAˆ§P4@¡€Z6 ‰©BK%@«L$RÈBˆ§F gB@@‰™DH†@DR¥NLB6FÈVƒˆ'V<oDDps`әD‹@‹DDt‰d(pL6TÈí¨3 €Hïé´íFnVÈ­r,ÿJ¡ˆ0H+‚FZXx(DpÁ©ŠÄx9©í@ ‰©Œ…ÏÈ6ˆÈ,¤6Ø6‹§Ü¤ˆ'£Ï@Ï(‡6§ÏÈÏè'§­@Í ƒ6ƒ‹£6¯È†³H˜Ï ‚†+­€µ…¥h­ƒ«@4ïȇ8Œ«¬‡‡…«‚……&“ƒ£(녧ȁ"˜‹(Š‚¯¤oj
    2020-08-13T20:45:15.236Z DEBUG modem << @
    2020-08-13T20:45:15.237Z DEBUG modem << ­
    2020-08-13T20:45:15.585Z DEBUG modem << kˆ˜î@í˜c§‚í‡P§4íÈLƒ8ˤgTƒ©J`6˜˜‰@©ˆaƒ,…«
    2020-08-13T20:45:15.674Z DEBUG modem << H\X$H‰0K)“
    2020-08-13T20:45:15.711Z DEBUG modem << ‰XO‹$¨˜È‹-¬ÿX@(hp‰¬ŒˆL­
    2020-08-13T20:45:17.369Z DEBUG modem << 6—¥(­ cƒxƒ­
    2020-08-13T20:45:17.393Z DEBUG modem << ¡x™ÿxþú#‚‰P
    2020-08-13T20:45:17.466Z DEBUG modem << ¥§,§­@H£@‚6–#‰È‹°’¢§`Œ'£H§8Š6‡ƒ$Ïȶ…‚ø'ؤ‚‡ƒƒÈh&H«
    2020-08-13T20:45:17.482Z DEBUG modem << P„-Š‰
    2020-08-13T20:45:17.511Z DEBUG modem << @'H(ÿø§ô¤
    2020-08-13T20:45:17.535Z DEBUG modem << ƒ‡ƒ…X
    2020-08-13T20:45:17.780Z DEBUG modem << ¡X¤áj‰‰¡á ¡‡¡ˆ**HŠ6ýȅÉø'ï¸gƒƒŒ
    2020-08-13T20:45:17.875Z DEBUG modem << ‰(68B@@ˆ‰
    2020-08-13T20:45:17.891Z DEBUG modem << ¡‡
    2020-08-13T20:45:20.038Z DEBUG modem << "L4P‰…ƒø¯¯$o*P$ˆJ‚ˆHŒñáI@¢å‡­¡‹¢ÕÕ¡‹ÕKà@‘¯ï¼…ˆ1Ë(ÿº(ÿ‡ ء࿓ƒÍxˆ6ˆˆë@‰ˆ­€¥ ‹·þ6–éíȬ­ ¡`í«ˆ@" ¶Ø$‹%Í S§&j@¢ˆ˜*4|‹»H‡‹´L@P«‚‚&•¥¥( ¡'ë
    2020-08-13T20:45:20.071Z DEBUG modem << … £‰‹
    2020-08-13T20:45:20.073Z DEBUG modem << x-¯(
    2020-08-13T20:45:20.086Z DEBUG modem << èˆ(„‘©
    2020-08-13T20:45:20.842Z DEBUG modem << ‚XL(("……‡s-‡¯˜íÀƒ‡¸Ï¬g’ƒƒ0¯‚€…•…¥(¢‚ƒ…('ƒë‚ؘ‹Ã¸8oƒ…… („2€6·É¢ˆƒ‡§ƒ­€‡pʧ´xÈ­¨§ »‚žŽ0¸þ̧ɤÿƒ(Š"†¸ƒx¯
    2020-08-13T20:45:22.490Z DEBUG modem << ‚…ø‰@¢…š–…Z†ª
    2020-08-13T20:45:22.508Z DEBUG modem << !$‹·þ¤24<‚§ø$
    2020-08-13T20:45:22.512Z DEBUG modem << (4§§)@"¡ˆ’4ÍÌ·°…%£­¯‰@"¢ƒ6…‹§4Øȗ
    2020-08-13T20:45:22.524Z DEBUG modem << ƒ¡‡0“‡‡P É
    2020-08-13T20:45:22.598Z DEBUG modem << …&)(@¢™……§‹
    2020-08-13T20:45:22.888Z DEBUG modem << "¥íȃHŽ­­°Š“ƒ‡Ë€…&"(¢…………'…‚¥6©È‡
    2020-08-13T20:45:22.906Z DEBUG modem << ãŒï¨g‡‡‡’
    2020-08-13T20:45:22.994Z DEBUG modem << €…6ƒ£(
    2020-08-13T20:45:23.007Z DEBUG modem << …‚'‡‹
    2020-08-13T20:45:23.155Z DEBUG modem << …¯È…Á¡'¯ o§j6
    2020-08-13T20:45:23.354Z DEBUG modem << (Xz6›‡§(ƒ ƒƒƒ… [S£$ýÌïKË⿓ïï$…
    2020-08-13T20:45:23.391Z DEBUG modem << ï«È§É(ÿΧ¢»‚ƒƒƒ#
    2020-08-13T20:45:25.036Z DEBUG modem << ˆ¹
    2020-08-13T20:45:25.039Z DEBUG modem << ˆ±¡É
    2020-08-13T20:45:25.053Z DEBUG modem << €‡(8
    2020-08-13T20:45:25.055Z DEBUG modem << £4‹7ËÄ6ï­È/¨ 
    2020-08-13T20:45:25.059Z DEBUG modem << …¤¥'¦É@
    2020-08-13T20:45:25.072Z DEBUG modem << ¡@ƒ6™6ØÌ­ˆ¤›Ú‘'£Ë
    2020-08-13T20:45:25.073Z DEBUG modem << €§ˆ…$ËÀ·Y
    2020-08-13T20:45:25.089Z DEBUG modem << ଋ0‚™™+
    2020-08-13T20:45:25.145Z DEBUG modem << …C6…­ˆ
    2020-08-13T20:45:25.161Z DEBUG modem << ˆ…‡í
    2020-08-13T20:45:25.191Z DEBUG modem << ˆ‰4Y‹I‹à­­0
    2020-08-13T20:45:25.310Z DEBUG modem << 鉉’‡í‚ˆƒ‡^‰.ï@ˆƒ‰§‰­
    2020-08-13T20:45:25.939Z DEBUG modem << ˆ"£6‰‹Ihƒ§«ˆoù™™©‚ˆ ,‹@-@<,,H$« ŸHÿDÁà7Ð$g@XX\¯XH68ÂÍ@€B-­˜™ÿ‹K«hPÚ~‹,͹‰"‹-‰(üI
    2020-08-13T20:45:27.609Z DEBUG modem <<  ™Xyႁ‰™éˆ@@œÄ›;AÃáñ@Œ•ÐNс­¥«
    2020-08-13T20:45:27.628Z DEBUG modem << #…‹,…þ6…Õ6…‰- 
    2020-08-13T20:45:27.629Z DEBUG modem << …À£'§«
    2020-08-13T20:45:27.630Z DEBUG modem << ˆå
    2020-08-13T20:45:27.631Z DEBUG modem << ƒ6ы%‰‹'ˆh…
    2020-08-13T20:45:27.658Z DEBUG modem << -á‰@ˆá ƒ6ÕÕ§6…ƒ¸›Ñ' ‘¥CŠ
    2020-08-13T20:45:27.718Z DEBUG modem << ˆÁñ&PH­H LX,…
    2020-08-13T20:45:27.763Z DEBUG modem << ˆRC6ŒÌ—£‘7­$Š¡
    2020-08-13T20:45:28.127Z DEBUG modem << ‡(—¥(ˆƒˆƒ‡ §€Œƒ‰…´éÀ™‹À·ù¤g‘’…ˈ¡0€¶“±­ ™¡¡ŽO‰
    2020-08-13T20:45:28.523Z INFO Modem port is closed
    2020-08-13T20:45:28.541Z INFO Modem port is opened
    2020-08-13T20:45:28.543Z DEBUG modem >> AT+CFUN?
    2020-08-13T20:45:34.967Z DEBUG modem << [00:01:09.687,072] <inf> main: sendto done: seq_num=3, retval=20
    2020-08-13T20:45:34.984Z DEBUG modem << [00:01:09.743,927] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,37,2
    2020-08-13T20:45:35.109Z DEBUG modem << [00:01:09.875,274] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,36,86,6346,36,115,6346,35,333,6
    2020-08-13T20:45:35.215Z DEBUG modem << [00:01:09.986,114] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,26
    2020-08-13T20:45:35.394Z DEBUG modem << [00:01:10.162,139] <inf> modem: Update: +CEINFO: 1,1,C,2,1,37,26
    2020-08-13T20:45:40.691Z DEBUG modem << [00:01:15.462,829] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,26
    2020-08-13T20:46:05.026Z DEBUG modem << [00:01:39.753,448] <inf> main: sendto done: seq_num=4, retval=20
    2020-08-13T20:46:05.042Z DEBUG modem << [00:01:39.804,840] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,37,2
    2020-08-13T20:46:05.188Z DEBUG modem << [00:01:39.956,115] <inf> modem: Update: %NBRGRSRP: 226,6346,38,86,6346,37,116,6346,33,333,6346,33,115,6
    2020-08-13T20:46:05.294Z DEBUG modem << [00:01:40.066,894] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,26
    2020-08-13T20:46:06.513Z DEBUG modem << [00:01:41.283,020] <inf> modem: Update: +CEINFO: 1,1,C,2,1,37,26
    2020-08-13T20:46:11.890Z DEBUG modem << [00:01:46.663,726] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,26
    2020-08-13T20:46:35.124Z DEBUG modem << [00:02:09.806,030] <inf> main: sendto done: seq_num=5, retval=20
    2020-08-13T20:46:35.138Z DEBUG modem << [00:02:09.904,327] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,37,2
    2020-08-13T20:46:35.244Z DEBUG modem << [00:02:10.014,434] <inf> modem: Update: %NBRGRSRP: 226,6346,39,86,6346,37,116,6346,36,333,6346,34,115,6
    2020-08-13T20:46:35.350Z DEBUG modem << [00:02:10.124,542] <inf> modem: Update: +CEINFO: 1,1,R,8,1,37,26
    2020-08-13T20:46:35.553Z DEBUG modem << [00:02:10.323,852] <inf> modem: Update: +CEINFO: 1,1,C,2,1,37,26
    2020-08-13T20:46:43.471Z DEBUG modem << [00:02:18.200,012] <inf> modem: Update: %CESQ: 37,1,10,1
    2020-08-13T20:46:43.577Z DEBUG modem << [00:02:18.351,776] <inf> modem: Update: +CEINFO: 1,1,I,8,1,37,21
    2020-08-13T20:46:43.685Z DEBUG modem << [00:02:18.457,763] <inf> modem: Update: +CEREG: 5,"AFA1","00A28366",9,,,"00100001","10010100"
    2020-08-13T20:46:52.718Z DEBUG modem << [00:02:27.493,713] <inf> modem: Update: %CESQ: 32,1,5,0
    2020-08-13T20:47:05.180Z DEBUG modem << [00:02:39.913,848] <inf> main: sendto done: seq_num=6, retval=20
    2020-08-13T20:47:05.189Z DEBUG modem << [00:02:39.961,486] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A28366",116,6346,32,2
    2020-08-13T20:47:05.300Z DEBUG modem << [00:02:40.070,892] <inf> modem: Update: %NBRGRSRP: 116,6346,36,226,6346,38,86,6346,37,115,6346,33,333,6
    2020-08-13T20:47:05.603Z DEBUG modem << [00:02:40.377,197] <inf> modem: Update: +CEINFO: 1,1,R,8,1,32,21
    2020-08-13T20:47:11.881Z DEBUG modem << [00:02:46.654,693] <inf> modem: Update: +CEINFO: 1,1,C,2,1,32,21
    2020-08-13T20:47:35.192Z DEBUG modem << [00:03:09.962,554] <inf> main: sendto done: seq_num=7, retval=20
    2020-08-13T20:47:35.202Z DEBUG modem << [00:03:09.975,646] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A28366",116,6346,32,2
    2020-08-13T20:47:35.306Z DEBUG modem << [00:03:10.085,205] <inf> modem: Update: OK
    2020-08-13T20:48:05.204Z DEBUG modem << [00:03:39.976,684] <inf> main: sendto done: seq_num=8, retval=20
    2020-08-13T20:48:05.216Z DEBUG modem << [00:03:39.989,105] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A28366",116,6346,32,2
    2020-08-13T20:48:05.321Z DEBUG modem << [00:03:40.100,830] <inf> modem: Update: OK
    2020-08-13T20:48:35.216Z DEBUG modem << [00:04:09.990,142] <inf> main: sendto done: seq_num=9, retval=20
    2020-08-13T20:48:35.226Z DEBUG modem << [00:04:09.990,447] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A28366",116,6346,32,2
    2020-08-13T20:48:35.330Z DEBUG modem << [00:04:10.112,335] <inf> modem: Update: OK
    2020-08-13T20:49:04.463Z DEBUG modem << [00:04:39.245,361] <inf> modem: Update: %CESQ: 32,1,10,1
    2020-08-13T20:49:04.569Z DEBUG modem << [00:04:39.350,616] <inf> modem: Update: +CEINFO: 1,1,I,8,1,32,21
    2020-08-13T20:49:04.722Z DEBUG modem << [00:04:39.498,199] <inf> modem: Update: +CEREG: 5,"AFA1","00A21867",9,,,"00100001","10010100"
    2020-08-13T20:49:04.828Z DEBUG modem << [00:04:39.610,382] <inf> modem: Update: +CEINFO: 1,1,R,8,1,32,21
    2020-08-13T20:49:04.934Z DEBUG modem << [00:04:39.716,339] <inf> modem: Update: +CEINFO: 1,1,C,2,1,32,21
    2020-08-13T20:49:05.237Z DEBUG modem << [00:04:40.013,366] <inf> main: sendto done: seq_num=10, retval=20
    2020-08-13T20:49:05.246Z DEBUG modem << [00:04:40.024,841] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,32,2
    2020-08-13T20:49:05.350Z DEBUG modem << [00:04:40.134,216] <inf> modem: Update: OK
    2020-08-13T20:49:13.335Z DEBUG modem << [00:04:48.117,401] <inf> modem: Update: +CEINFO: 1,1,I,8,1,32,21
    2020-08-13T20:49:13.444Z DEBUG modem << [00:04:48.223,388] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"00100001","10010100"
    2020-08-13T20:49:13.550Z DEBUG modem << [00:04:48.331,878] <inf> modem: Update: +CEINFO: 1,1,R,8,1,32,21
    2020-08-13T20:49:14.556Z DEBUG modem << [00:04:49.335,021] <inf> modem: Update: +CEINFO: 1,1,C,2,1,32,21
    2020-08-13T20:49:14.895Z DEBUG modem << [00:04:49.520,111] <inf> modem: Update: +CGEV: ME PDN DEACT 0
    2020-08-13T20:49:15.001Z DEBUG modem << [00:04:49.783,081] <inf> modem: Update: +CNEC_EMM: 10
    2020-08-13T20:49:15.110Z DEBUG modem << [00:04:49.889,709] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
    2020-08-13T20:49:15.217Z DEBUG modem << [00:04:49.999,176] <inf> modem: Update: +CGEV: NW DETACH
    2020-08-13T20:49:19.834Z DEBUG modem << [00:04:54.617,218] <inf> modem: Update: +CEINFO: 1,1,I,8,1,32,25
    2020-08-13T20:49:19.944Z DEBUG modem << [00:04:54.723,205] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,10,"11100000","11100000"
    2020-08-13T20:49:20.077Z DEBUG modem << [00:04:54.858,001] <inf> modem: Update: +CEINFO: 1,1,R,8,1,32,25
    2020-08-13T20:49:20.184Z DEBUG modem << [00:04:54.965,850] <inf> modem: Update: +CEINFO: 1,1,C,2,1,32,25
    2020-08-13T20:49:20.698Z DEBUG modem << [00:04:55.452,392] <inf> modem: Update: +CGEV: ME PDN ACT 0
    2020-08-13T20:49:20.807Z DEBUG modem << [00:04:55.586,944] <inf> modem: Update: +CEREG: 5,"AFA1","00A21867",9,,,"00100001","10010100"
    2020-08-13T20:49:31.086Z DEBUG modem << [00:05:05.817,993] <inf> modem: Update: %CESQ: 38,1,15,2
    2020-08-13T20:49:31.192Z DEBUG modem << [00:05:05.975,006] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:49:35.302Z DEBUG modem << [00:05:10.034,423] <inf> main: sendto done: seq_num=11, retval=20
    2020-08-13T20:49:35.311Z DEBUG modem << [00:05:10.091,644] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T20:49:35.423Z DEBUG modem << [00:05:10.201,782] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,39,116,6346,37,115,6346,32,266,6
    2020-08-13T20:49:35.529Z DEBUG modem << [00:05:10.312,591] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:49:35.868Z DEBUG modem << [00:05:10.648,834] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T20:49:41.164Z DEBUG modem << [00:05:15.947,692] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:50:05.362Z DEBUG modem << [00:05:40.101,165] <inf> main: sendto done: seq_num=12, retval=20
    2020-08-13T20:50:05.375Z DEBUG modem << [00:05:40.154,754] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T20:50:05.501Z DEBUG modem << [00:05:40.281,555] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,39,115,6346,36,116,6346,35,333,6
    2020-08-13T20:50:05.607Z DEBUG modem << [00:05:40.392,364] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T20:50:05.798Z DEBUG modem << [00:05:40.579,650] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T20:50:11.085Z DEBUG modem << [00:05:45.870,178] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T20:50:35.410Z DEBUG modem << [00:06:10.155,975] <inf> main: sendto done: seq_num=13, retval=20
    2020-08-13T20:50:35.419Z DEBUG modem << [00:06:10.202,178] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T20:50:35.529Z DEBUG modem << [00:06:10.311,553] <inf> modem: Update: %NBRGRSRP: 226,6346,40,116,6346,39,86,6346,38,115,6346,33,333,6
    2020-08-13T20:50:35.759Z DEBUG modem << [00:06:10.544,189] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T20:50:36.187Z DEBUG modem << [00:06:10.970,550] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T20:50:45.492Z DEBUG modem << [00:06:20.279,510] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:50:45.601Z DEBUG modem << [00:06:20.385,498] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"00100001","10010100"
    2020-08-13T20:50:45.707Z DEBUG modem << [00:06:20.493,988] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:50:46.178Z DEBUG modem << [00:06:20.961,578] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T20:50:46.446Z DEBUG modem << [00:06:21.097,045] <inf> modem: Update: +CGEV: ME PDN DEACT 0
    2020-08-13T20:50:46.553Z DEBUG modem << [00:06:21.339,447] <inf> modem: Update: +CNEC_EMM: 10
    2020-08-13T20:50:46.664Z DEBUG modem << [00:06:21.445,892] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
    2020-08-13T20:50:46.771Z DEBUG modem << [00:06:21.556,915] <inf> modem: Update: +CGEV: NW DETACH
    2020-08-13T20:50:46.916Z DEBUG modem << [00:06:21.703,186] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:50:47.023Z DEBUG modem << [00:06:21.809,143] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:50:47.307Z DEBUG modem << [00:06:22.091,644] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T20:50:53.615Z DEBUG modem << [00:06:28.402,832] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:50:53.788Z DEBUG modem << [00:06:28.571,929] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T20:50:54.035Z DEBUG modem << [00:06:28.822,784] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:51:02.234Z DEBUG modem << [00:06:37.022,277] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:51:02.344Z DEBUG modem << [00:06:37.128,295] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,10,"11100000","11100000"
    2020-08-13T20:51:02.454Z DEBUG modem << [00:06:37.237,884] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T20:51:02.652Z DEBUG modem << [00:06:37.440,368] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T20:51:02.759Z DEBUG modem << [00:06:37.546,356] <inf> modem: Update: +CNEC_ESM: 26,0
    2020-08-13T20:51:02.865Z DEBUG modem << [00:06:37.653,198] <inf> modem: Update: +CNEC_EMM: 19
    2020-08-13T20:51:02.974Z DEBUG modem << [00:06:37.759,368] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,19,"11100000","11100000"
    2020-08-13T20:51:03.081Z DEBUG modem << [00:06:37.868,804] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T20:51:05.428Z DEBUG modem << [00:06:40.211,639] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:51:05.436Z DEBUG modem << [00:06:40.221,893] <err> main: sendto error: seq_num=14, retval=-1, errno=51
    2020-08-13T20:51:05.540Z DEBUG modem << [00:06:40.321,990] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,39,115,6346,35,266,6346,35,116,6
    2020-08-13T20:51:11.513Z DEBUG modem << [00:06:46.302,062] <inf> modem: Update: %CESQ: 38,1,20,2
    2020-08-13T20:51:35.454Z DEBUG modem << [00:07:10.239,440] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:51:35.462Z DEBUG modem << [00:07:10.249,633] <err> main: sendto error: seq_num=15, retval=-1, errno=51
    2020-08-13T20:51:35.564Z DEBUG modem << [00:07:10.349,731] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,38,116,6346,35,115,6346,35,162,6
    2020-08-13T20:52:05.480Z DEBUG modem << [00:07:40.267,120] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:52:05.489Z DEBUG modem << [00:07:40.277,313] <err> main: sendto error: seq_num=16, retval=-1, errno=51
    2020-08-13T20:52:05.590Z DEBUG modem << [00:07:40.377,410] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,40,86,6346,39,115,6346,32,227,6
    2020-08-13T20:52:12.952Z DEBUG modem << [00:07:47.743,743] <inf> modem: Update: %CESQ: 38,1,15,2
    2020-08-13T20:52:35.500Z DEBUG modem << [00:08:10.286,437] <err> main: sendto error: seq_num=17, retval=-1, errno=51
    2020-08-13T20:52:35.506Z DEBUG modem << [00:08:10.298,858] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:52:35.616Z DEBUG modem << [00:08:10.404,174] <inf> modem: Update: %NBRGRSRP: 226,6346,39,86,6346,39,116,6346,37,115,6346,35,227,6
    2020-08-13T20:53:05.518Z DEBUG modem << [00:08:40.308,288] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:53:05.527Z DEBUG modem << [00:08:40.318,450] <err> main: sendto error: seq_num=18, retval=-1, errno=51
    2020-08-13T20:53:05.629Z DEBUG modem << [00:08:40.418,548] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,37,86,6346,37,115,6346,37,227,6
    2020-08-13T20:53:35.545Z DEBUG modem << [00:09:10.336,029] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:53:35.553Z DEBUG modem << [00:09:10.346,679] <err> main: sendto error: seq_num=19, retval=-1, errno=51
    2020-08-13T20:53:35.655Z DEBUG modem << [00:09:10.446,777] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,37,115,6346,36,116,6346,35,227,6
    2020-08-13T20:54:05.562Z DEBUG modem << [00:09:40.355,865] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:54:05.570Z DEBUG modem << [00:09:40.365,356] <err> main: sendto error: seq_num=20, retval=-1, errno=51
    2020-08-13T20:54:05.672Z DEBUG modem << [00:09:40.465,484] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,38,116,6346,36,336,6346,36,115,6
    2020-08-13T20:54:35.580Z DEBUG modem << [00:10:10.373,687] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:54:35.588Z DEBUG modem << [00:10:10.384,460] <err> main: sendto error: seq_num=21, retval=-1, errno=51
    2020-08-13T20:54:35.691Z DEBUG modem << [00:10:10.484,588] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,38,116,6346,36,115,6346,36,336,6
    2020-08-13T20:55:05.608Z DEBUG modem << [00:10:40.401,885] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:55:05.616Z DEBUG modem << [00:10:40.413,757] <err> main: sendto error: seq_num=22, retval=-1, errno=51
    2020-08-13T20:55:05.718Z DEBUG modem << [00:10:40.513,885] <inf> modem: Update: %NBRGRSRP: 226,6346,39,86,6346,39,116,6346,38,336,6346,37,115,6
    2020-08-13T20:55:35.635Z DEBUG modem << [00:11:10.431,304] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:55:35.643Z DEBUG modem << [00:11:10.442,504] <err> main: sendto error: seq_num=23, retval=-1, errno=51
    2020-08-13T20:55:35.745Z DEBUG modem << [00:11:10.542,633] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,38,336,6346,38,86,6346,36,115,6
    2020-08-13T20:56:05.653Z DEBUG modem << [00:11:40.451,690] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:56:05.660Z DEBUG modem << [00:11:40.461,639] <err> main: sendto error: seq_num=24, retval=-1, errno=51
    2020-08-13T20:56:05.763Z DEBUG modem << [00:11:40.561,737] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,38,86,6346,37,336,6346,36,115,6
    2020-08-13T20:56:35.680Z DEBUG modem << [00:12:10.478,424] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:56:35.688Z DEBUG modem << [00:12:10.490,051] <err> main: sendto error: seq_num=25, retval=-1, errno=51
    2020-08-13T20:56:35.792Z DEBUG modem << [00:12:10.590,148] <inf> modem: Update: %NBRGRSRP: 226,6346,37,116,6346,37,115,6346,36,86,6346,35,336,6
    2020-08-13T20:57:05.707Z DEBUG modem << [00:12:40.507,598] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:57:05.715Z DEBUG modem << [00:12:40.518,798] <err> main: sendto error: seq_num=26, retval=-1, errno=51
    2020-08-13T20:57:05.817Z DEBUG modem << [00:12:40.618,896] <inf> modem: Update: %NBRGRSRP: 226,6346,37,86,6346,37,336,6346,37,116,6346,35,115,6
    2020-08-13T20:57:35.735Z DEBUG modem << [00:13:10.536,315] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:57:35.743Z DEBUG modem << [00:13:10.548,187] <err> main: sendto error: seq_num=27, retval=-1, errno=51
    2020-08-13T20:57:35.845Z DEBUG modem << [00:13:10.648,284] <inf> modem: Update: %NBRGRSRP: 226,6346,38,336,6346,37,86,6346,36,116,6346,36,115,6
    2020-08-13T20:58:05.753Z DEBUG modem << [00:13:40.557,434] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:58:05.761Z DEBUG modem << [00:13:40.568,237] <err> main: sendto error: seq_num=28, retval=-1, errno=51
    2020-08-13T20:58:05.864Z DEBUG modem << [00:13:40.668,365] <inf> modem: Update: %NBRGRSRP: 226,6346,37,86,6346,39,115,6346,36,116,6346,35,336,6
    2020-08-13T20:58:35.781Z DEBUG modem << [00:14:10.586,486] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:58:35.789Z DEBUG modem << [00:14:10.597,686] <err> main: sendto error: seq_num=29, retval=-1, errno=51
    2020-08-13T20:58:35.891Z DEBUG modem << [00:14:10.697,784] <inf> modem: Update: %NBRGRSRP: 226,6346,37,116,6346,38,86,6346,36,115,6346,34,336,6
    2020-08-13T20:59:05.808Z DEBUG modem << [00:14:40.615,264] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:59:05.817Z DEBUG modem << [00:14:40.626,464] <err> main: sendto error: seq_num=30, retval=-1, errno=51
    2020-08-13T20:59:05.919Z DEBUG modem << [00:14:40.726,562] <inf> modem: Update: %NBRGRSRP: 226,6346,36,116,6346,37,86,6346,36,336,6346,36,115,6
    2020-08-13T20:59:35.826Z DEBUG modem << [00:15:10.636,169] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T20:59:35.833Z DEBUG modem << [00:15:10.645,660] <err> main: sendto error: seq_num=31, retval=-1, errno=51
    2020-08-13T20:59:35.936Z DEBUG modem << [00:15:10.745,758] <inf> modem: Update: %NBRGRSRP: 226,6346,36,116,6346,37,86,6346,36,336,6346,36,115,6
    2020-08-13T21:00:05.852Z DEBUG modem << [00:15:40.662,445] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:00:05.860Z DEBUG modem << [00:15:40.672,729] <err> main: sendto error: seq_num=32, retval=-1, errno=51
    2020-08-13T21:00:05.961Z DEBUG modem << [00:15:40.772,827] <inf> modem: Update: %NBRGRSRP: 226,6346,39,336,6346,37,116,6346,35,115,6346,35,86,6
    2020-08-13T21:00:35.879Z DEBUG modem << [00:16:10.690,277] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:00:35.887Z DEBUG modem << [00:16:10.701,477] <err> main: sendto error: seq_num=33, retval=-1, errno=51
    2020-08-13T21:00:35.989Z DEBUG modem << [00:16:10.801,574] <inf> modem: Update: %NBRGRSRP: 226,6346,37,336,6346,37,86,6346,37,116,6346,36,115,6
    2020-08-13T21:01:05.908Z DEBUG modem << [00:16:40.718,994] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:01:05.932Z DEBUG modem << [00:16:40.730,621] <err> main: sendto error: seq_num=34, retval=-1, errno=51
    2020-08-13T21:01:06.017Z DEBUG modem << [00:16:40.830,749] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,37,86,6346,36,337,6346,36,336,6
    2020-08-13T21:01:35.925Z DEBUG modem << [00:17:10.739,807] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:01:35.946Z DEBUG modem << [00:17:10.750,549] <err> main: sendto error: seq_num=35, retval=-1, errno=51
    2020-08-13T21:01:36.036Z DEBUG modem << [00:17:10.850,646] <inf> modem: Update: %NBRGRSRP: 226,6346,41,116,6346,37,86,6346,36,336,6346,35,115,6
    2020-08-13T21:02:05.953Z DEBUG modem << [00:17:40.768,768] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:02:05.975Z DEBUG modem << [00:17:40.779,968] <err> main: sendto error: seq_num=36, retval=-1, errno=51
    2020-08-13T21:02:06.063Z DEBUG modem << [00:17:40.880,096] <inf> modem: Update: %NBRGRSRP: 226,6346,37,116,6346,38,336,6346,37,86,6346,36,115,6
    2020-08-13T21:02:35.980Z DEBUG modem << [00:18:10.797,515] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:02:36.003Z DEBUG modem << [00:18:10.808,685] <err> main: sendto error: seq_num=37, retval=-1, errno=51
    2020-08-13T21:02:36.090Z DEBUG modem << [00:18:10.908,813] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,38,116,6346,37,336,6346,37,115,6
    2020-08-13T21:02:50.377Z DEBUG modem << [00:18:25.201,416] <inf> modem: Update: %CESQ: 38,1,20,2
    2020-08-13T21:03:02.531Z DEBUG modem << [00:18:37.355,682] <inf> modem: Update: +CGEV: RESTR 2,2
    2020-08-13T21:03:06.008Z DEBUG modem << [00:18:40.826,263] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:03:06.029Z DEBUG modem << [00:18:40.837,463] <err> main: sendto error: seq_num=38, retval=-1, errno=51
    2020-08-13T21:03:06.118Z DEBUG modem << [00:18:40.937,561] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,38,336,6346,36,116,6346,35,162,6
    2020-08-13T21:03:36.035Z DEBUG modem << [00:19:10.854,980] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:03:36.058Z DEBUG modem << [00:19:10.866,149] <err> main: sendto error: seq_num=39, retval=-1, errno=51
    2020-08-13T21:03:36.144Z DEBUG modem << [00:19:10.966,278] <inf> modem: Update: %NBRGRSRP: 226,6346,41,116,6346,40,336,6346,39,86,6346,38,162,6
    2020-08-13T21:04:06.063Z DEBUG modem << [00:19:40.883,666] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:04:06.086Z DEBUG modem << [00:19:40.895,538] <err> main: sendto error: seq_num=40, retval=-1, errno=51
    2020-08-13T21:04:06.173Z DEBUG modem << [00:19:40.995,666] <inf> modem: Update: %NBRGRSRP: 226,6346,39,86,6346,38,116,6346,35,115,6346,35,337,6
    2020-08-13T21:04:36.090Z DEBUG modem << [00:20:10.913,085] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:04:36.114Z DEBUG modem << [00:20:10.924,285] <err> main: sendto error: seq_num=41, retval=-1, errno=51
    2020-08-13T21:04:36.200Z DEBUG modem << [00:20:11.024,383] <inf> modem: Update: %NBRGRSRP: 226,6346,39,116,6346,38,86,6346,37,336,6346,37,337,6
    2020-08-13T21:04:58.375Z DEBUG modem << [00:20:33.204,956] <inf> modem: Update: %CESQ: 38,1,15,2
    2020-08-13T21:05:06.116Z DEBUG modem << [00:20:40.941,864] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:05:06.140Z DEBUG modem << [00:20:40.952,087] <err> main: sendto error: seq_num=42, retval=-1, errno=51
    2020-08-13T21:05:06.226Z DEBUG modem << [00:20:41.052,215] <inf> modem: Update: %NBRGRSRP: 226,6346,40,86,6346,39,116,6346,37,336,6346,34,115,6
    2020-08-13T21:05:26.534Z DEBUG modem << [00:21:01.365,722] <inf> modem: Update: %CESQ: 38,1,20,2
    2020-08-13T21:05:36.144Z DEBUG modem << [00:21:10.969,604] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:05:36.169Z DEBUG modem << [00:21:10.981,567] <err> main: sendto error: seq_num=43, retval=-1, errno=51
    2020-08-13T21:05:36.254Z DEBUG modem << [00:21:11.081,665] <inf> modem: Update: %NBRGRSRP: 226,6346,43,116,6346,40,86,6346,36,336,6346,35,115,6
    2020-08-13T21:06:06.172Z DEBUG modem << [00:21:40.999,298] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:06:06.196Z DEBUG modem << [00:21:41.010,528] <err> main: sendto error: seq_num=44, retval=-1, errno=51
    2020-08-13T21:06:06.282Z DEBUG modem << [00:21:41.110,626] <inf> modem: Update: %NBRGRSRP: 226,6346,43,116,6346,38,86,6346,36,115,6346,35,336,6
    2020-08-13T21:06:36.199Z DEBUG modem << [00:22:11.028,015] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:06:36.224Z DEBUG modem << [00:22:11.039,062] <err> main: sendto error: seq_num=45, retval=-1, errno=51
    2020-08-13T21:06:36.309Z DEBUG modem << [00:22:11.139,190] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,37,86,6346,36,115,6346,32,227,6
    2020-08-13T21:07:06.227Z DEBUG modem << [00:22:41.056,640] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:07:06.250Z DEBUG modem << [00:22:41.068,145] <err> main: sendto error: seq_num=46, retval=-1, errno=51
    2020-08-13T21:07:06.336Z DEBUG modem << [00:22:41.168,243] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,40,116,6346,36,115,6346,33,227,6
    2020-08-13T21:07:36.247Z DEBUG modem << [00:23:11.077,362] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:07:36.270Z DEBUG modem << [00:23:11.090,606] <err> main: sendto error: seq_num=47, retval=-1, errno=51
    2020-08-13T21:07:36.357Z DEBUG modem << [00:23:11.190,704] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,39,86,6346,34,115,6346,30,227,6
    2020-08-13T21:08:06.276Z DEBUG modem << [00:23:41.108,795] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:08:06.301Z DEBUG modem << [00:23:41.120,056] <err> main: sendto error: seq_num=48, retval=-1, errno=51
    2020-08-13T21:08:06.386Z DEBUG modem << [00:23:41.220,184] <inf> modem: Update: %NBRGRSRP: 226,6346,43,116,6346,38,86,6346,38,115,6346,35,333,6
    2020-08-13T21:08:36.303Z DEBUG modem << [00:24:11.137,573] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:08:36.328Z DEBUG modem << [00:24:11.148,773] <err> main: sendto error: seq_num=49, retval=-1, errno=51
    2020-08-13T21:08:36.413Z DEBUG modem << [00:24:11.248,870] <inf> modem: Update: %NBRGRSRP: 226,6346,43,116,6346,38,86,6346,36,333,6346,34,115,6
    2020-08-13T21:09:06.332Z DEBUG modem << [00:24:41.166,290] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:09:06.358Z DEBUG modem << [00:24:41.179,260] <err> main: sendto error: seq_num=50, retval=-1, errno=51
    2020-08-13T21:09:06.441Z DEBUG modem << [00:24:41.279,357] <inf> modem: Update: %NBRGRSRP: 226,6346,44,116,6346,38,86,6346,38,115,6346,35,333,6
    2020-08-13T21:09:36.361Z DEBUG modem << [00:25:11.198,455] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:09:36.386Z DEBUG modem << [00:25:11.210,296] <err> main: sendto error: seq_num=51, retval=-1, errno=51
    2020-08-13T21:09:36.472Z DEBUG modem << [00:25:11.310,394] <inf> modem: Update: %NBRGRSRP: 226,6346,41,116,6346,40,86,6346,37,333,6346,35,227,6
    2020-08-13T21:10:06.389Z DEBUG modem << [00:25:41.227,874] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:10:06.415Z DEBUG modem << [00:25:41.238,952] <err> main: sendto error: seq_num=52, retval=-1, errno=51
    2020-08-13T21:10:06.499Z DEBUG modem << [00:25:41.339,050] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,39,116,6346,39,333,6346,35,227,6
    2020-08-13T21:10:36.416Z DEBUG modem << [00:26:11.256,530] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:10:36.440Z DEBUG modem << [00:26:11.267,700] <err> main: sendto error: seq_num=53, retval=-1, errno=51
    2020-08-13T21:10:36.526Z DEBUG modem << [00:26:11.367,828] <inf> modem: Update: %NBRGRSRP: 226,6346,43,116,6346,40,86,6346,38,333,6346,34,227,6
    2020-08-13T21:11:06.433Z DEBUG modem << [00:26:41.276,885] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:11:06.458Z DEBUG modem << [00:26:41.286,407] <err> main: sendto error: seq_num=54, retval=-1, errno=51
    2020-08-13T21:11:06.543Z DEBUG modem << [00:26:41.386,627] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,41,86,6346,37,333,6346,35,227,6
    2020-08-13T21:11:36.460Z DEBUG modem << [00:27:11.303,161] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:11:36.485Z DEBUG modem << [00:27:11.314,880] <err> main: sendto error: seq_num=55, retval=-1, errno=51
    2020-08-13T21:11:36.571Z DEBUG modem << [00:27:11.414,978] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,39,116,6346,39,333,6346,32,274,6
    2020-08-13T21:12:06.488Z DEBUG modem << [00:27:41.332,458] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:12:06.512Z DEBUG modem << [00:27:41.343,963] <err> main: sendto error: seq_num=56, retval=-1, errno=51
    2020-08-13T21:12:06.598Z DEBUG modem << [00:27:41.444,091] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,41,116,6346,39,333,6346,35,227,6
    2020-08-13T21:12:36.512Z DEBUG modem << [00:28:11.353,820] <err> main: sendto error: seq_num=57, retval=-1, errno=51
    2020-08-13T21:12:36.536Z DEBUG modem << [00:28:11.369,201] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:12:36.628Z DEBUG modem << [00:28:11.474,487] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,39,116,6346,37,227,6346,33,333,6
    2020-08-13T21:13:06.531Z DEBUG modem << [00:28:41.378,631] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:13:06.558Z DEBUG modem << [00:28:41.389,678] <err> main: sendto error: seq_num=58, retval=-1, errno=51
    2020-08-13T21:13:06.641Z DEBUG modem << [00:28:41.489,776] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,41,116,6346,36,333,6346,34,227,6
    2020-08-13T21:13:36.558Z DEBUG modem << [00:29:11.407,257] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:13:36.584Z DEBUG modem << [00:29:11.418,304] <err> main: sendto error: seq_num=59, retval=-1, errno=51
    2020-08-13T21:13:36.668Z DEBUG modem << [00:29:11.518,432] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,40,116,6346,38,333,6346,30,227,6
    2020-08-13T21:14:06.586Z DEBUG modem << [00:29:41.435,821] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:14:06.611Z DEBUG modem << [00:29:41.447,692] <err> main: sendto error: seq_num=60, retval=-1, errno=51
    2020-08-13T21:14:06.696Z DEBUG modem << [00:29:41.547,821] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,41,86,6346,39,333,6346,34,478,6
    2020-08-13T21:14:36.603Z DEBUG modem << [00:30:11.456,817] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:14:36.627Z DEBUG modem << [00:30:11.466,339] <err> main: sendto error: seq_num=61, retval=-1, errno=51
    2020-08-13T21:14:36.714Z DEBUG modem << [00:30:11.567,413] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,39,116,6346,39,333,6346,35,478,6
    2020-08-13T21:15:06.629Z DEBUG modem << [00:30:41.483,123] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:15:06.655Z DEBUG modem << [00:30:41.494,323] <err> main: sendto error: seq_num=62, retval=-1, errno=51
    2020-08-13T21:15:06.740Z DEBUG modem << [00:30:41.594,421] <inf> modem: Update: %NBRGRSRP: 226,6346,44,116,6346,41,86,6346,36,333,6346,33,227,6
    2020-08-13T21:15:36.657Z DEBUG modem << [00:31:11.511,901] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:15:36.684Z DEBUG modem << [00:31:11.523,101] <err> main: sendto error: seq_num=63, retval=-1, errno=51
    2020-08-13T21:15:36.767Z DEBUG modem << [00:31:11.623,199] <inf> modem: Update: %NBRGRSRP: 226,6346,44,86,6346,41,116,6346,38,333,6346,34,478,6
    2020-08-13T21:16:06.685Z DEBUG modem << [00:31:41.540,679] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:16:06.711Z DEBUG modem << [00:31:41.552,337] <err> main: sendto error: seq_num=64, retval=-1, errno=51
    2020-08-13T21:16:06.795Z DEBUG modem << [00:31:41.652,435] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,40,116,6346,38,333,6346,35,399,6
    2020-08-13T21:16:36.704Z DEBUG modem << [00:32:11.561,370] <err> main: sendto error: seq_num=65, retval=-1, errno=51
    2020-08-13T21:16:36.731Z DEBUG modem << [00:32:11.573,547] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:16:36.820Z DEBUG modem << [00:32:11.678,833] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,40,86,6346,37,227,6346,32,333,6
    2020-08-13T21:17:06.724Z DEBUG modem << [00:32:41.582,977] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:17:06.751Z DEBUG modem << [00:32:41.594,177] <err> main: sendto error: seq_num=66, retval=-1, errno=51
    2020-08-13T21:17:06.834Z DEBUG modem << [00:32:41.694,274] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,41,116,6346,37,478,6346,34,333,6
    2020-08-13T21:17:36.751Z DEBUG modem << [00:33:11.611,755] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:17:36.778Z DEBUG modem << [00:33:11.622,955] <err> main: sendto error: seq_num=67, retval=-1, errno=51
    2020-08-13T21:17:36.861Z DEBUG modem << [00:33:11.723,052] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,42,116,6346,36,333,6346,35,478,6
    2020-08-13T21:18:06.771Z DEBUG modem << [00:33:41.632,110] <err> main: sendto error: seq_num=68, retval=-1, errno=51
    2020-08-13T21:18:06.797Z DEBUG modem << [00:33:41.645,019] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:18:06.887Z DEBUG modem << [00:33:41.750,335] <inf> modem: Update: %NBRGRSRP: 226,6346,42,116,6346,40,86,6346,39,333,6346,34,227,6
    2020-08-13T21:18:36.792Z DEBUG modem << [00:34:11.654,479] <inf> modem: Update: %XMONITOR: 2  OK
    2020-08-13T21:18:36.818Z DEBUG modem << [00:34:11.667,053] <err> main: sendto error: seq_num=69, retval=-1, errno=51
    2020-08-13T21:18:36.902Z DEBUG modem << [00:34:11.767,181] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,41,116,6346,38,333,6346,34,227,6
    2020-08-13T21:19:03.244Z DEBUG modem << [00:34:38.112,701] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:19:03.670Z DEBUG modem << [00:34:38.537,597] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:19:04.278Z DEBUG modem << [00:34:39.148,529] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:19:04.725Z DEBUG modem << [00:34:39.591,918] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:19:05.271Z DEBUG modem << [00:34:40.111,694] <inf> modem: Update: +CGEV: ME PDN ACT 0
    2020-08-13T21:19:05.380Z DEBUG modem << [00:34:40.247,467] <inf> modem: Update: +CEREG: 5,"AFA1","00A21867",9,,,"00100001","10010100"
    2020-08-13T21:19:06.830Z DEBUG modem << [00:34:41.678,192] <inf> main: sendto done: seq_num=70, retval=20
    2020-08-13T21:19:06.855Z DEBUG modem << [00:34:41.706,298] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:19:06.945Z DEBUG modem << [00:34:41.815,673] <inf> modem: Update: OK
    2020-08-13T21:19:07.054Z DEBUG modem << [00:34:41.924,224] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:19:07.299Z DEBUG modem << [00:34:42.152,679] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:19:17.607Z DEBUG modem << [00:34:52.478,332] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T21:19:36.889Z DEBUG modem << [00:35:11.715,850] <inf> main: sendto done: seq_num=71, retval=20
    2020-08-13T21:19:36.916Z DEBUG modem << [00:35:11.765,533] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:19:37.045Z DEBUG modem << [00:35:11.910,461] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,41,116,6346,38,115,6346,31  OK
    2020-08-13T21:19:37.158Z DEBUG modem << [00:35:12.026,947] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:19:37.283Z DEBUG modem << [00:35:12.148,529] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:19:42.581Z DEBUG modem << [00:35:17.439,086] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T21:20:06.971Z DEBUG modem << [00:35:41.766,754] <inf> main: sendto done: seq_num=72, retval=20
    2020-08-13T21:20:06.997Z DEBUG modem << [00:35:41.813,293] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:20:07.092Z DEBUG modem << [00:35:41.923,980] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,40,116,6346,38,115,6346,33  OK
    2020-08-13T21:20:07.278Z DEBUG modem << [00:35:42.112,976] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:20:07.762Z DEBUG modem << [00:35:42.595,367] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:20:13.165Z DEBUG modem << [00:35:48.000,061] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T21:20:37.030Z DEBUG modem << [00:36:11.822,814] <inf> main: sendto done: seq_num=73, retval=20
    2020-08-13T21:20:37.057Z DEBUG modem << [00:36:11.869,232] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:20:37.199Z DEBUG modem << [00:36:11.979,248] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,41,116,6346,39  OK
    2020-08-13T21:20:37.305Z DEBUG modem << [00:36:12.138,214] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:20:37.480Z DEBUG modem << [00:36:12.310,180] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:20:42.768Z DEBUG modem << [00:36:17.600,738] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T21:21:07.088Z DEBUG modem << [00:36:41.878,753] <inf> main: sendto done: seq_num=74, retval=20
    2020-08-13T21:21:07.116Z DEBUG modem << [00:36:41.927,734] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:21:07.242Z DEBUG modem << [00:36:42.072,357] <inf> modem: Update: %NBRGRSRP: 226,6346,42,86,6346,39,116,6346,37  OK
    2020-08-13T21:21:07.350Z DEBUG modem << [00:36:42.182,006] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:21:07.711Z DEBUG modem << [00:36:42.540,985] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:21:13.336Z DEBUG modem << [00:36:48.170,928] <inf> modem: Update: %CESQ: 38,1,15,2
    2020-08-13T21:21:13.443Z DEBUG modem << [00:36:48.276,214] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,28
    2020-08-13T21:21:13.555Z DEBUG modem << [00:36:48.382,232] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"00100001","10010100"
    2020-08-13T21:21:13.662Z DEBUG modem << [00:36:48.494,476] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,28
    2020-08-13T21:21:13.768Z DEBUG modem << [00:36:48.601,318] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,28
    2020-08-13T21:21:13.873Z DEBUG modem << [00:36:48.707,305] <inf> modem: Update: +CGEV: ME PDN DEACT 0
    2020-08-13T21:21:14.010Z DEBUG modem << [00:36:48.843,261] <inf> modem: Update: +CNEC_EMM: 10
    2020-08-13T21:21:14.121Z DEBUG modem << [00:36:48.949,371] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
    2020-08-13T21:21:14.228Z DEBUG modem << [00:36:49.061,004] <inf> modem: Update: +CGEV: NW DETACH
    2020-08-13T21:21:14.449Z DEBUG modem << [00:36:49.282,714] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:21:14.556Z DEBUG modem << [00:36:49.388,671] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:21:15.757Z DEBUG modem << [00:36:50.588,012] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:21:16.530Z DEBUG modem << [00:36:51.336,029] <inf> modem: Update: +CGEV: ME PDN ACT 0
    2020-08-13T21:21:16.639Z DEBUG modem << [00:36:51.470,184] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"00100001","10010100"
    2020-08-13T21:21:30.066Z DEBUG modem << [00:37:04.900,115] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:21:30.174Z DEBUG modem << [00:37:05.006,103] <inf> modem: Update: +CEREG: 5,"AFA1","00A21867",9,,,"00100001","10010100"
    2020-08-13T21:21:30.284Z DEBUG modem << [00:37:05.114,593] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:21:30.390Z DEBUG modem << [00:37:05.224,548] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:21:30.768Z DEBUG modem << [00:37:05.602,081] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:21:37.149Z DEBUG modem << [00:37:11.937,316] <inf> main: sendto done: seq_num=75, retval=20
    2020-08-13T21:21:37.177Z DEBUG modem << [00:37:11.989,685] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:21:37.305Z DEBUG modem << [00:37:12.135,101] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,41,116,6346,38,115,6346,32,333,6
    2020-08-13T21:21:37.411Z DEBUG modem << [00:37:12.245,849] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:21:37.640Z DEBUG modem << [00:37:12.471,801] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:21:42.928Z DEBUG modem << [00:37:17.763,031] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:22:07.199Z DEBUG modem << [00:37:41.991,699] <inf> main: sendto done: seq_num=76, retval=20
    2020-08-13T21:22:07.226Z DEBUG modem << [00:37:42.040,557] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:22:07.319Z DEBUG modem << [00:37:42.149,963] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,41,116,6346,38,115,6346,34,371,6
    2020-08-13T21:22:07.603Z DEBUG modem << [00:37:42.436,950] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:22:08.030Z DEBUG modem << [00:37:42.862,640] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:22:13.328Z DEBUG modem << [00:37:48.163,726] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:22:37.261Z DEBUG modem << [00:38:12.050,109] <inf> main: sendto done: seq_num=77, retval=20
    2020-08-13T21:22:37.274Z DEBUG modem << [00:38:12.103,912] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:22:37.404Z DEBUG modem << [00:38:12.236,755] <inf> modem: Update: %NBRGRSRP: 226,6346,41,86,6346,41,116,6346,39,115,6346,34,227,6
    2020-08-13T21:22:37.510Z DEBUG modem << [00:38:12.347,473] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:22:37.800Z DEBUG modem << [00:38:12.633,453] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:22:43.087Z DEBUG modem << [00:38:17.924,011] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:23:03.836Z DEBUG modem << [00:38:38.674,743] <inf> modem: Update: %CESQ: 38,1,20,2
    2020-08-13T21:23:07.322Z DEBUG modem << [00:38:42.113,433] <inf> main: sendto done: seq_num=78, retval=20
    2020-08-13T21:23:07.335Z DEBUG modem << [00:38:42.166,473] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:23:07.465Z DEBUG modem << [00:38:42.298,309] <inf> modem: Update: %NBRGRSRP: 226,6346,43,86,6346,41,116,6346,38,115,6346,34,227,6
    2020-08-13T21:23:07.571Z DEBUG modem << [00:38:42.409,057] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,25
    2020-08-13T21:23:08.029Z DEBUG modem << [00:38:42.864,288] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,25
    2020-08-13T21:23:13.324Z DEBUG modem << [00:38:48.163,146] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,25
    2020-08-13T21:23:37.385Z DEBUG modem << [00:39:12.176,025] <inf> main: sendto done: seq_num=79, retval=20
    2020-08-13T21:23:37.415Z DEBUG modem << [00:39:12.230,804] <inf> modem: Update: %XMONITOR: 5,"","","26202","AFA1",9,20,"00A21867",226,6346,38,2
    2020-08-13T21:23:37.523Z DEBUG modem << [00:39:12.358,367] <inf> modem: Update: %NBRGRSRP: 226,6346,39,86,6346,40,116,6346,37,115,6346,34,333,6
    2020-08-13T21:23:37.630Z DEBUG modem << [00:39:12.469,146] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,24
    2020-08-13T21:23:37.959Z DEBUG modem << [00:39:12.795,104] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,24
    2020-08-13T21:23:46.935Z DEBUG modem << [00:39:21.775,695] <inf> modem: Update: %CESQ: 38,1,15,2
    2020-08-13T21:23:47.041Z DEBUG modem << [00:39:21.881,011] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,24
    2020-08-13T21:23:47.150Z DEBUG modem << [00:39:21.987,030] <inf> modem: Update: +CEREG: 5,"AFAD","009FF867",9,,,"00100001","10010100"
    2020-08-13T21:23:47.256Z DEBUG modem << [00:39:22.095,489] <inf> modem: Update: +CEINFO: 1,1,R,8,1,38,24
    2020-08-13T21:23:47.619Z DEBUG modem << [00:39:22.456,146] <inf> modem: Update: +CEINFO: 1,1,C,2,1,38,24
    2020-08-13T21:23:47.888Z DEBUG modem << [00:39:22.591,644] <inf> modem: Update: +CGEV: ME PDN DEACT 0
    2020-08-13T21:23:47.993Z DEBUG modem << [00:39:22.833,862] <inf> modem: Update: +CNEC_EMM: 10
    2020-08-13T21:23:48.105Z DEBUG modem << [00:39:22.939,544] <inf> modem: Update: +CEREG: 2,"AFAD","009FF867",9,0,10,"11100000","11100000"
    2020-08-13T21:23:48.210Z DEBUG modem << [00:39:23.050,628] <inf> modem: Update: +CGEV: NW DETACH
    2020-08-13T21:23:48.357Z DEBUG modem << [00:39:23.193,817] <inf> modem: Update: +CEINFO: 1,1,I,8,1,38,24
    2020-08-13T21:23:48.468Z DEBUG modem << [00:39:23.303,161] <inf> modem: Update: +CEREG: 2,"AFA1","00A21867",9,0,10,"11100000","11100000"
    2020-08-13T21:23:48.573Z INFO Modem port is closed
    

    Trace Collector log:

    trace-2020-08-13T20-45-50.080Z.bin

  • Thanks, I'll have the modem team look at the file.

Related