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@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@lists.teslaclub.hk
http://lists.teslaclub.hk/mailman/listinfo/ovmsdev