[Ovmsdev] OVMS going comatose

Sun Apr 4 20:32:22 HKT 2021

Steve,

that's the problem with this issue, it's totally unclear what causes this.

The signal dropping begins when the queue is full, which happens after 
the task has been blocked for ~as many seconds as the queue is big. So 
there is no logged activity that could cause this, your module basically 
went into this from idling.

Regards,
Michael

Am 04.04.21 um 08:43 schrieb Stephen Casner:
> I've had two more crashes where I had to recover by resetting the
> unit, but these show a different pattern of log messages, as attached
> below.
>
>                                                          -- Steve
>
> 2021-03-27 23:31:29.355 PDT I (25393605) gsm-ppp: StatusCallBack: User Interrupt
> 2021-03-27 23:31:29.355 PDT I (25393605) gsm-ppp: PPP connection has been closed
> 2021-03-27 23:31:32.875 PDT I (25397125) simcom: State timeout, transition to 5
> 2021-03-27 23:31:32.875 PDT I (25397125) simcom: State: Enter NetWait state
> 2021-03-27 23:31:36.875 PDT I (25401125) simcom: State: Enter NetStart state
> 2021-03-27 23:31:37.975 PDT I (25402225) simcom: PPP Connection is ready to start
> 2021-03-27 23:31:38.875 PDT I (25403125) simcom: State: Enter NetMode state
> 2021-03-27 23:31:38.875 PDT I (25403125) gsm-ppp: Initialising...
> 2021-03-27 23:31:41.615 PDT I (25405865) gsm-ppp: StatusCallBack: None
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp: status_cb: Connected
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    our_ipaddr  = 10.170.41.247
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    his_ipaddr  = 10.64.64.64
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    netmask     = 255.255.255.255
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    DNS#0       = 212.9.0.135
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    DNS#1       = 212.9.0.136
> 2021-03-27 23:31:41.625 PDT I (25405875) gsm-ppp:    our6_ipaddr = ::
> 2021-03-27 23:31:41.625 PDT I (25405875) netmanager: MODEM up (with WIFI client up): staying with WIFI client priority
> 2021-03-27 23:33:16.885 PDT I (25501135) housekeeping: 2021-03-27 23:33:16 PDT (RAM: 8b=66932-67484 32b=10036)
> 2021-03-27 23:38:23.805 PDT E (25808125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:24.805 PDT E (25809125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:25.805 PDT E (25810125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:26.805 PDT E (25811125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:26.805 PDT E (25811125) events: SignalEvent: queue overflow, event 'ticker.10' dropped
> 2021-03-27 23:38:27.805 PDT E (25812125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:28.805 PDT E (25813125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:29.805 PDT E (25814125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:30.805 PDT E (25815125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:31.805 PDT E (25816125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:32.805 PDT E (25817125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:33.805 PDT E (25818125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:34.805 PDT E (25819125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:35.805 PDT E (25820125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:36.805 PDT E (25821125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:36.805 PDT E (25821125) events: SignalEvent: queue overflow, event 'ticker.10' dropped
> 2021-03-27 23:38:37.805 PDT E (25822125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:38.805 PDT E (25823125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:39.805 PDT E (25824125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:40.805 PDT E (25825125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:41.805 PDT E (25826125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:42.805 PDT E (25827125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:43.805 PDT E (25828125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:44.805 PDT E (25829125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:45.805 PDT E (25830125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:46.805 PDT E (25831125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:46.805 PDT E (25831125) events: SignalEvent: queue overflow, event 'ticker.10' dropped
> 2021-03-27 23:38:47.805 PDT E (25832125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:48.805 PDT E (25833125) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-27 23:38:48.815 PDT E (25833135) events: SignalEvent: queue overflow, event 'server.web.socket.closed' dropped
> 2021-03-27 23:38:48.815 PDT E (25833135) events: SignalEvent: lost important event => aborting
> 2021-03-31 00:10:52.161 PDT I (8451) command: OpenLogfile: now logging to file '/sd/crash.log'
>
>
> 2021-03-31 01:45:44.761 PDT I (5701001) housekeeping: 2021-03-31 01:45:44 PDT (RAM: 8b=68340-69352 32b=10036)
> 2021-03-31 01:47:12.751 PDT E (5788981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:13.751 PDT E (5789981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:14.751 PDT E (5790981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:14.751 PDT E (5790981) events: SignalEvent: queue overflow, event 'ticker.10' dropped
> 2021-03-31 01:47:15.751 PDT E (5791981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:16.751 PDT E (5792981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:17.751 PDT E (5793981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:18.751 PDT E (5794981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:19.751 PDT E (5795981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:20.751 PDT E (5796981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:21.751 PDT E (5797981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:22.751 PDT E (5798981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:23.751 PDT E (5799981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:24.751 PDT E (5800981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:24.751 PDT E (5800981) events: SignalEvent: queue overflow, event 'ticker.10' dropped
> 2021-03-31 01:47:25.751 PDT E (5801981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:26.751 PDT E (5802981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:27.751 PDT E (5803981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:28.751 PDT E (5804981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:29.751 PDT E (5805981) events: SignalEvent: queue overflow, event 'ticker.1' dropped
> 2021-03-31 01:47:29.761 PDT E (5805991) events: SignalEvent: queue overflow, event 'server.web.socket.closed' dropped
> 2021-03-31 01:47:29.761 PDT E (5805991) events: SignalEvent: lost important event => aborting
> 1969-12-31 16:00:08.620 PST I (8260) command: OpenLogfile: now logging to file '/sd/crash.log'
> _______________________________________________
> OvmsDev mailing list
> OvmsDev at lists.openvehicles.com
> http://lists.openvehicles.com/mailman/listinfo/ovmsdev

-- 
Michael Balzer * Helkenberger Weg 9 * D-58256 Ennepetal
Fon 02333 / 833 5735 * Handy 0176 / 206 989 26

-------------- next part --------------
A non-text attachment was scrubbed...
Name: OpenPGP_signature
Type: application/pgp-signature
Size: 203 bytes
Desc: OpenPGP digital signature
URL: <http://lists.openvehicles.com/pipermail/ovmsdev/attachments/20210404/3d08c490/attachment.sig>