[Ovmsdev] Modem link-drop crash

Wed Dec 27 10:11:48 HKT 2017

Weird. Looks like the MUX has failed…

D (58042826) SIMCOM tx: f9 0d ff 3b 41 54 2b 43 52 45 47 3f 3b 2b 43 43 ...;AT+CREG?;+CC
D (58042826) SIMCOM tx: 4c 4b 3f 3b 2b 43 53 51 3b 2b 43 4f 50 53 3f 0d LK?;+CSQ;+COPS?.
D (58042826) SIMCOM tx: 0a cf f9                                        ...             
D (58042836) SIMCOM rx: 41 54 2b 43 52 45 47 3f 3b 2b 43 43 4c 4b 3f 3b AT+CREG?;+CCLK?;
D (58042846) SIMCOM rx: 2b 43 53 51 3b 2b 43 4f 50 53 3f 0d 0d 0a 2b 43 +CSQ;+COPS?...+C
D (58042846) SIMCOM rx: 52 45 47 3a 20 30 2c 35 0d 0a 0d 0a 2b 43 43 4c REG: 0,5....+CCL
D (58042846) SIMCOM rx: 4b 3a 20 22 31 37 2f 31 32 2f 32 37 2c 30 36 3a K: "17/12/27,06:
D (58042846) SIMCOM rx: 34 39 3a 30 39 2b 35 32 22 0d 0a 0d 0a 2b 43 53 49:09+52"....+CS
D (58042846) SIMCOM rx: 51 3a 20 39 2c 39 39 0d 0a 0d 0a 2b 43 4f 50 53 Q: 9,99....+COPS
D (58042846) SIMCOM rx: 3a 20 30 2c 30 2c 22 56 6f 64 61 66 6f 6e 65 4e : 0,0,"VodafoneN
D (58042846) SIMCOM rx: 5a 20 48 6f 6c 6f 67 72 61 6d 22 2c 32 0d 0a 0d Z Hologram",2...
D (58042846) SIMCOM rx: 0a 4f 4b 0d 0a                                  .OK..           
OVMS > simcom status
SIMCOM
  Network Registration: Searching
  State: NetWait
  Ticker: 57947
  User Data: 0
  Mux Open Channels: 4
  PPP Not Connected
  PPP Last Error: User Interrupt
  GPS: disabled
  GPS time: disabled
  NMEA (GPS/GLONASS) Not Connected

The tx f9 0d ff 3b … cf f9 is a mux transmission. The rx shows that being echoed back along with the CREG 0,5 (which is a roaming connected) but no ‘line’ decode output, and the ‘simcom status’ showing CREG ‘Searching’.

Most likely the modem reset itself at some point (without the ESP32 system resetting).

Could be a faulty modem, or power issue. Whichever; we should catch the problem and respond appropriately. I’ll add some framing error counters to the mux code, and check those counters in the main simcom state1 handler to reset things if they exceed a threshold.

Regards, Mark.

> On 27 Dec 2017, at 2:04 AM, Tom Parker <tom at carrott.org> wrote:
> 
> On 27/12/17 01:34, Mark Webb-Johnson wrote:
>> Log doesn’t show much. Modem has a network connection to VodafoneNZ, and signal strength seems ok.
> 
> There is nothing else in the log, I'm running with level debug and it's just that on repeat.
> 
>> The following output will help:
>> 
>> simcom status
> 
> OVMS > simcom status
> SIMCOM
>   Network Registration: Searching
>   State: NetWait
>   Ticker: 57960
>   User Data: 0
>   Mux Open Channels: 4
>   PPP Not Connected
>   PPP Last Error: User Interrupt
>   GPS: disabled
>   GPS time: disabled
>   NMEA (GPS/GLONASS) Not Connected
> 
>> simcom setstate NetLoss
> 
> OVMS > simcom setstate NetLoss
> OVMS > 
> OVMS > 
> OVMS > I (58142726) simcom: State: Enter NetLoss state
> D (58142726) SIMCOM tx: f9 0d ff 19 41 54 2b 43 47 41 54 54 3d 30 0d 0a ....AT+CGATT=0..
> D (58142726) SIMCOM tx: 14 f9                                           ..              
> I (58142726) gsm-ppp: Shutting down (hard)...
> I (58142736) gsm-ppp: StatusCallBack: User Interrupt
> I (58142736) gsm-ppp: PPP connection has been closed
> D (58142736) SIMCOM rx: 41 54 2b 43 47 41 54 54 3d 30 0d                AT+CGATT=0.     
> OVMS > D (58143956) SIMCOM rx: 0d 0a 4f 4b 0d 0a                               ..OK..          
> OVMS > I (58151826) simcom: State timeout, transition to 5
> I (58151826) simcom: State: Enter NetWait state
> D (58151826) gsm-nmea: GPS disabled
> OVMS > D (58161826) SIMCOM tx: f9 0d ff 3b 41 54 2b 43 52 45 47 3f 3b 2b 43 43 ...;AT+CREG?;+CC
> D (58161826) SIMCOM tx: 4c 4b 3f 3b 2b 43 53 51 3b 2b 43 4f 50 53 3f 0d LK?;+CSQ;+COPS?.
> D (58161826) SIMCOM tx: 0a cf f9                                        ...             
> D (58161846) SIMCOM rx: 41 54 2b 43 52 45 47 3f 3b 2b 43 43 4c 4b 3f 3b AT+CREG?;+CCLK?;
> D (58161846) SIMCOM rx: 2b 43 53 51 3b 2b 43 4f 50 53 3f 0d             +CSQ;+COPS?.    
> D (58161896) SIMCOM rx: 0d 0a 2b 43 52 45 47 3a 20 30 2c 35 0d 0a 0d 0a ..+CREG: 0,5....
> D (58161896) SIMCOM rx: 2b 43 43 4c 4b 3a 20 22 31 37 2f 31 32 2f 32 37 +CCLK: "17/12/27
> D (58161896) SIMCOM rx: 2c 30 36 3a 35 31 3a 30 38 2b 35 32 22 0d 0a 0d ,06:51:08+52"...
> D (58161906) SIMCOM rx: 0a 2b 43 53 51 3a 20 39 2c 39 39 0d 0a 0d 0a 2b .+CSQ: 9,99....+
> D (58161906) SIMCOM rx: 43 4f 50 53 3a 20 30 2c 30 2c 22 56 6f 64 61 66 COPS: 0,0,"Vodaf
> D (58161906) SIMCOM rx: 6f 6e 65 4e 5a 20 48 6f 6c 6f 67 72 61 6d 22 2c oneNZ Hologram",
> D (58161906) SIMCOM rx: 32 0d 0a 0d 0a 4f 4b 0d 0a                      2....OK..       
> 
> The AT+CREG?; status things then continue in a loop and I did another simcom status which looks pretty similar to before:
> 
> OVMS > simcom status
> SIMCOM
>   Network Registration: Searching
>   State: NetWait
>   Ticker: 155
>   User Data: 0
>   Mux Open Channels: 4
>   PPP Not Connected
>   PPP Last Error: User Interrupt
>   GPS: disabled
>   GPS time: disabled
>   NMEA (GPS/GLONASS) Not Connected
> 
>> And show output at level debug for another minute or so.
> 
> A full transcript of my session is attached. The ovms is still in this state so I can collect more information or perform more experiments.
> 
> <2017-12-27-1-modem-not-working.txt.gz>_______________________________________________
> OvmsDev mailing list
> OvmsDev at lists.teslaclub.hk
> http://lists.teslaclub.hk/mailman/listinfo/ovmsdev

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openvehicles.com/pipermail/ovmsdev/attachments/20171227/f190fde0/attachment.htm>