<html>
<head>
<meta http-equiv="content-type" content="text/html; charset=UTF-8">
</head>
<body text="#000000" bgcolor="#FFFFFF">
Hi folks,<br>
<br>
I left last night's build running all night and had other
distractions today, so just got around to looking at how it held
up. While it's still alive, the clock seems to have gotten stuck.
m.monotonic stands at 30389 Sec and holding, which was some time
early this morning. Oddly, the time command shows the correct UTC
time.<br>
<br>
Here's the last set of log messages. Perhaps of interest is the
last one (frame overflow), and the authentication failure before
that. <br>
<br>
Any debugging to do before I reset it with today's bits? None of
the module commands work (complains about needing heap tracking and
an updated esp-idf, both of which I thought I had done).<br>
<br>
Greg<br>
<br>
<br>
<div dir="ltr">W (29694436) simcom: 3 minutes since last MUX rx
frame - assume MUX has failed<br>
I (29694436) gsm-ppp: Shutting down (soft)...<br>
I (29694436) time: Stopping SNTP client<br>
I (29694436) ovms-server-v2: Network is down, so disconnect
network connection<br>
E (29694436) ovms-server-v2: Status: Error: Disconnected from OVMS
Server V2<br>
I (29694446) gsm-nmea: Shutdown (direct)<br>
I (29694446) gsm-mux: Stop MUX<br>
I (29694446) simcom: Power Cycle<br>
I (29694496) webserver: Stopping Web Server<br>
I (29695446) simcom: State: Enter PoweringOn state<br>
I (29695446) simcom: Power Cycle<br>
I (29703436) simcom: State timeout, transition to 2<br>
I (29703436) simcom: State: Enter PoweringOn state<br>
I (29703436) simcom: Power Cycle<br>
I (29705966) gsm-ppp: StatusCallBack: User Interrupt<br>
I (29705966) gsm-ppp: PPP connection has been closed<br>
I (29709566) simcom: State: Enter PoweredOn state<br>
I (29729436) simcom: State: Enter MuxStart state<br>
I (29729436) gsm-mux: Start MUX<br>
I (29729446) gsm-mux: Channel #0 is open<br>
I (29729446) gsm-mux: Channel #1 is open<br>
I (29729456) gsm-mux: Channel #2 is open<br>
I (29729456) gsm-mux: Channel #3 is open<br>
I (29729466) gsm-mux: Channel #4 is open<br>
I (29730436) simcom: State: Enter NetWait state<br>
I (29734436) simcom: State: Enter NetStart state<br>
I (29735556) simcom: PPP Connection is ready to start<br>
I (29736436) simcom: State: Enter NetMode state<br>
I (29736436) gsm-ppp: Initialising...<br>
I (29739486) gsm-ppp: StatusCallBack: None<br>
I (29739486) gsm-ppp: status_cb: Connected<br>
I (29739486) gsm-ppp: our_ipaddr = 10.170.146.142<br>
I (29739486) gsm-ppp: his_ipaddr = 10.64.64.64<br>
I (29739486) gsm-ppp: netmask = 255.255.255.255<br>
I (29739486) gsm-ppp: our6_ipaddr = ::<br>
I (29739486) netmanager: Set DNS#0 9.9.9.9<br>
I (29739486) netmanager: Set DNS#1 8.8.8.8<br>
I (29739496) netmanager: Interface priority is pp3 (<a
href="http://10.170.146.142/255.255.255.255">10.170.146.142/255.255.255.255</a>
gateway 10.64.64.64)<br>
I (29739496) time: Starting SNTP client<br>
I (29739516) webserver: Launching Web Server<br>
I (29739556) ovms-server-v2: Network is up, so attempt network
connection<br>
I (29739566) ovms-server-v2: Connection is <a
href="http://tmc.openvehicles.com:6867">tmc.openvehicles.com:6867</a>
ROADSTER_834/Gdbkt2017server<br>
I (29739566) ovms-server-v2: Status: Connecting...<br>
I (29740786) ovms-server-v2: Connection successful<br>
I (29740786) ovms-server-v2: Status: Logging in...<br>
I (29740786) ovms-server-v2: Sending server login: MP-C 0
hYmLdxeZxWCwkNgpup0zeB jl/Ifu5Hg8lq+S/PTc4uOQ== ROADSTER_834<br>
I (29741496) ovms-server-v2: Got server response: MP-S 0
LKP5Qi2E4PlFzPJ7mc4sWd +S88vnrZARs61sAzkivLTg==<br>
I (29741506) ovms-server-v2: Server token is
LKP5Qi2E4PlFzPJ7mc4sWd and digest is +S88vnrZARs61sAzkivLTg==<br>
I (29741516) ovms-server-v2: Status: Server auth ok. Now priming
crypto.<br>
I (29741516) ovms-server-v2: Shared secret key is
LKP5Qi2E4PlFzPJ7mc4sWdhYmLdxeZxWCwkNgpup0zeB (44 bytes)<br>
I (29741516) ovms-server-v2: Status: OVMS V2 login successful, and
crypto channel established<br>
I (29741526) ovms-server-v2: Incoming Msg: MP-0 Z0<br>
W (29922436) simcom: 3 minutes since last MUX rx frame - assume
MUX has failed<br>
I (29922436) gsm-ppp: Shutting down (soft)...<br>
I (29922436) time: Stopping SNTP client<br>
I (29922436) ovms-server-v2: Network is down, so disconnect
network connection<br>
E (29922436) ovms-server-v2: Status: Error: Disconnected from OVMS
Server V2<br>
I (29922446) gsm-nmea: Shutdown (direct)<br>
I (29922446) gsm-mux: Stop MUX<br>
I (29922446) simcom: Power Cycle<br>
I (29922526) webserver: Stopping Web Server<br>
I (29923446) simcom: State: Enter PoweringOn state<br>
I (29923446) simcom: Power Cycle<br>
I (29931436) simcom: State timeout, transition to 2<br>
I (29931436) simcom: State: Enter PoweringOn state<br>
I (29931436) simcom: Power Cycle<br>
I (29933966) gsm-ppp: StatusCallBack: User Interrupt<br>
I (29933966) gsm-ppp: PPP connection has been closed<br>
I (29937576) simcom: State: Enter PoweredOn state<br>
I (29957456) simcom: State: Enter MuxStart state<br>
I (29957456) gsm-mux: Start MUX<br>
I (29957466) gsm-mux: Channel #0 is open<br>
I (29957476) gsm-mux: Channel #1 is open<br>
I (29957486) gsm-mux: Channel #2 is open<br>
I (29957486) gsm-mux: Channel #3 is open<br>
I (29957496) gsm-mux: Channel #4 is open<br>
I (29958436) simcom: State: Enter NetWait state<br>
I (29962436) simcom: State: Enter NetStart state<br>
I (29963596) simcom: PPP Connection is ready to start<br>
I (29964436) simcom: State: Enter NetMode state<br>
I (29964436) gsm-ppp: Initialising...<br>
I (29967466) gsm-ppp: StatusCallBack: None<br>
I (29967466) gsm-ppp: status_cb: Connected<br>
I (29967466) gsm-ppp: our_ipaddr = 10.170.146.142<br>
I (29967466) gsm-ppp: his_ipaddr = 10.64.64.64<br>
I (29967466) gsm-ppp: netmask = 255.255.255.255<br>
I (29967466) gsm-ppp: our6_ipaddr = ::<br>
I (29967466) netmanager: Set DNS#0 9.9.9.9<br>
I (29967466) netmanager: Set DNS#1 8.8.8.8<br>
I (29967466) netmanager: Interface priority is pp3 (<a
href="http://10.170.146.142/255.255.255.255">10.170.146.142/255.255.255.255</a>
gateway 10.64.64.64)<br>
I (29967466) time: Starting SNTP client<br>
I (29967486) webserver: Launching Web Server<br>
I (29967516) ovms-server-v2: Network is up, so attempt network
connection<br>
I (29967516) ovms-server-v2: Connection is <a
href="http://tmc.openvehicles.com:6867">tmc.openvehicles.com:6867</a>
ROADSTER_834/Gdbkt2017server<br>
I (29967516) ovms-server-v2: Status: Connecting...<br>
I (29968586) ovms-server-v2: Connection successful<br>
I (29968596) ovms-server-v2: Status: Logging in...<br>
I (29968596) ovms-server-v2: Sending server login: MP-C 0
7xW8GUvco/C+bw2wbq8wMm MD0wjvyEyLxp/H+efl4NXg== ROADSTER_834<br>
I (29969286) ovms-server-v2: Got server response: MP-S 0
AkbsS/NHbhRCN9+tCeUsu5 K9o43t18dAbTMbHRWGwnJg==<br>
I (29969286) ovms-server-v2: Server token is
AkbsS/NHbhRCN9+tCeUsu5 and digest is K9o43t18dAbTMbHRWGwnJg==<br>
I (29969296) ovms-server-v2: Status: Server auth ok. Now priming
crypto.<br>
I (29969296) ovms-server-v2: Shared secret key is
AkbsS/NHbhRCN9+tCeUsu57xW8GUvco/C+bw2wbq8wMm (44 bytes)<br>
I (29969296) ovms-server-v2: Status: OVMS V2 login successful, and
crypto channel established<br>
I (29969316) ovms-server-v2: Incoming Msg: MP-0 Z0<br>
I (29970436) ovms-server-v2: Send MP-0
S45.0,K,0,0,stopped,standard,0,0,0,0,0,0,0,21,0,0,0,0,0.00,0,0,0,0,-1,0,0,0,0,0,0,0,0.00,0.00,0<br>
I (29970436) ovms-server-v2: Send MP-0
D0,0,5,0,0,0,0,0,0,29970,0,0,0,0,0.236264,0,0,0,0,0<br>
I (29970436) ovms-server-v2: Send MP-0
F3.0.991-91-gffbc545/factory/main build (idf
v3.1-dev-429-g7f6161cd) Mar 18 2018 22:02:28,,10,1,TR,<br>
W (30175436) simcom: 3 minutes since last MUX rx frame - assume
MUX has failed<br>
I (30175436) gsm-ppp: Shutting down (soft)...<br>
I (30175436) time: Stopping SNTP client<br>
I (30175436) ovms-server-v2: Network is down, so disconnect
network connection<br>
E (30175436) ovms-server-v2: Status: Error: Disconnected from OVMS
Server V2<br>
I (30175446) gsm-nmea: Shutdown (direct)<br>
I (30175446) gsm-mux: Stop MUX<br>
I (30175446) simcom: Power Cycle<br>
I (30175576) webserver: Stopping Web Server<br>
I (30176446) simcom: State: Enter PoweringOn state<br>
I (30176446) simcom: Power Cycle<br>
I (30184436) simcom: State timeout, transition to 2<br>
I (30184436) simcom: State: Enter PoweringOn state<br>
I (30184436) simcom: Power Cycle<br>
I (30186966) gsm-ppp: StatusCallBack: User Interrupt<br>
I (30186966) gsm-ppp: PPP connection has been closed<br>
I (30190536) simcom: State: Enter PoweredOn state<br>
I (30210436) simcom: State: Enter MuxStart state<br>
I (30210436) gsm-mux: Start MUX<br>
I (30210446) gsm-mux: Channel #0 is open<br>
I (30210446) gsm-mux: Channel #1 is open<br>
I (30210456) gsm-mux: Channel #2 is open<br>
I (30210456) gsm-mux: Channel #3 is open<br>
I (30210466) gsm-mux: Channel #4 is open<br>
I (30211436) simcom: State: Enter NetWait state<br>
I (30215436) simcom: State: Enter NetStart state<br>
I (30216476) simcom: PPP Connection is ready to start<br>
I (30217436) simcom: State: Enter NetMode state<br>
I (30217436) gsm-ppp: Initialising...<br>
I (30289396) gsm-ppp: StatusCallBack: Authentication Failed<br>
E (30289396) gsm-ppp: status_cb: Failed authentication challenge<br>
I (30289396) gsm-ppp: Shutdown (via status callback)<br>
I (30289396) gsm-ppp: Attempting PPP reconnecting in 30 seconds...<br>
W (30398436) simcom: 3 minutes since last MUX rx frame - assume
MUX has failed<br>
I (30398436) gsm-ppp: Shutting down (soft)...<br>
W (32631576) gsm-mux: Frame overflow (2048 bytes)<br>
OVMS> metric list v.b.soc<br>
v.b.soc 45%<br>
OVMS> metric set v.b.soc 23<br>
Metric set<br>
OVMS> <br>
OVMS> network<br>
Interface#3: pp3 (ifup=1 linkup=0)<br>
IPv4: <a href="http://0.0.0.0/255.255.255.255">0.0.0.0/255.255.255.255</a>
gateway 0.0.0.0<br>
<br>
Interface#2: ap2 (ifup=1 linkup=1)<br>
IPv4: <a href="http://192.168.4.1/255.255.255.0">192.168.4.1/255.255.255.0</a>
gateway 192.168.4.1<br>
<br>
Interface#1: st1 (ifup=0 linkup=1)<br>
IPv4: <a href="http://0.0.0.0/0.0.0.0">0.0.0.0/0.0.0.0</a>
gateway 0.0.0.0<br>
<br>
Interface#0: lo0 (ifup=1 linkup=1)<br>
IPv4: <a href="http://127.0.0.1/255.0.0.0">127.0.0.1/255.0.0.0</a>
gateway 127.0.0.1<br>
<br>
DNS: 9.9.9.9 8.8.8.8<br>
<br>
Default Interface: ap2 (<a href="http://192.168.4.1/255.255.255.0">192.168.4.1/255.255.255.0</a>
gateway 192.168.4.1)<br>
OVMS> simcom<br>
SIMCOM<br>
Network Registration: RegisteredRoaming<br>
State: NetMode<br>
Ticker: 181<br>
User Data: 0<br>
<br>
Mux<br>
Status: up<br>
Open Channels: 4<br>
Framing Errors: 1533<br>
Last RX frame: 181 sec(s) ago<br>
RX frames: 9<br>
TX frames: 27<br>
<br>
PPP<br>
Not Connected<br>
Last Error: Authentication Failed<br>
<br>
GPS<br>
Status: disabled<br>
Time: disabled<br>
NMEA: GPS/GLONASS Not Connected<br>
OVMS> <br>
</div>
<br>
</body>
</html>