[Ovmsdev] Not processing canbus frames anymore

Sun Apr 24 16:35:22 HKT 2022

Craig,

your log excerpt shows perfectly normal CAN behaviour for the bus being 
turned off by the vehicle.

The transceiver does 128 retransmission attempts before entering 
bus-passive state. Example from the UpMiiGo:

2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368047 rxpkt=209218 txpkt=215216 errflags=0x8000d9 rxerr=0 txerr=8 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368052 rxpkt=209218 txpkt=215216 errflags=0x8000d9 rxerr=0 txerr=48 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368055 rxpkt=209218 txpkt=215216 errflags=0x8000d9 rxerr=0 txerr=72 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368057 rxpkt=209218 txpkt=215216 errflags=0x8000d9 rxerr=0 txerr=88 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368059 rxpkt=209218 txpkt=215216 errflags=0x8040d9 rxerr=0 txerr=104 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368061 rxpkt=209218 txpkt=215216 errflags=0x8040d9 rxerr=0 txerr=120 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:39.157 CEST E (338630327) can: can1: intr=1083368064 rxpkt=209218 txpkt=215216 errflags=0x204800 rxerr=0 txerr=128 rxinval=0 rxovr=0 txovr=9266 txdelay=16024 txfail=18767 wdgreset=0 errreset=0
2022-04-23 13:38:40.157 CEST D (338631327) v-vweup: PollerStateTicker: [offline] LVPwrState=0 HVChgMode=0 SOC=27.0% LVAutoChg=1 12V=12.1 DCDC_U=12.3 DCDC_I=0.0 ChgEff=0.0 BatI=-0.0 BatIAge=12 => PollState 1->0
2022-04-23 13:38:40.157 CEST I (338631327) v-vweup: PollerStateTicker: Setting car state to OFF
2022-04-23 13:38:40.157 CEST I (338631327) v-vweup: PollSetState: AWAKE -> OFF

The transceiver bus error state gets resolved as soon as the bus is 
turned on again.

Regards,
Michael

Am 22.04.22 um 19:10 schrieb Craig Leres:
> On 4/15/22 01:24, Michael Balzer wrote:
>> This doesn't match my thought:
>>
>>> Tx fails:                   840 
>>
>> That means there actually were TX failures or TX aborts from a bus 
>> error state.
>>
>> That should manifest in the logs as well, with possibly more detail.
>
> I've appended some can messages from the log file on my sd card. 
> Timestamps correspond to when I was driving. Looking at esp32can.cpp I 
> guess errflags (aka error_flags) is a combination of several things, 
> 16 bits of "error_irqs", 8 bits of MODULE_ESP32CAN->SR.U, and 8 bits 
> of MODULE_ESP32CAN->ECC.U. I think 0x800000 is BIT(7) or 
> __CAN_IRQ_BUS_ERR or "IR.7 Bus Error Interrupt".
>
> Is it saying it doesn't like my can bus? I haven't changed the way I 
> connect to the high speed can, I tapped into the onstar connector. I 
> guess it's possible the cable got damaged (it's under the 
> right/passenger's seat) but it does seem to be able to receive frames 
> without error. (And I know the engine will not run if there are 
> problems on the high speed can bus!)
>
>         Craig
>
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370416 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=8 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370420 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=40 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370422 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=56 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370423 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=64 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370425 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=80 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370426 
> rxpkt=370190 txpkt=206 errflags=0x8000d9 rxerr=0 txerr=88 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370427 
> rxpkt=370190 txpkt=206 errflags=0x8440d9 rxerr=0 txerr=96 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370429 
> rxpkt=370190 txpkt=206 errflags=0x8040d9 rxerr=0 txerr=112 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370430 
> rxpkt=370190 txpkt=206 errflags=0x8040d9 rxerr=0 txerr=120 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
> 2022-04-21 12:03:11.684 PDT E (1213934) can: can1: intr=370433 
> rxpkt=370190 txpkt=206 errflags=0x204800 rxerr=0 txerr=128 rxinval=0 
> rxovr=0 txovr=0 txdelay=0 txfail=0 wdgreset=0 errreset=0
>

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

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openvehicles.com/pipermail/ovmsdev/attachments/20220424/86ccd725/attachment.htm>
-------------- 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/20220424/86ccd725/attachment.sig>