5 posts / 0 new
Last post
juanheredia
Duplicate Notifications on Charge Start event

Hi, 

Have you noticed that OVMS module on charge start event is beeing fired twice (the second one after 40 seconds). I'm receiving the charge notification twice on the smart phone. Then I've tried to write a sigle "print('test')"; on the "vehicle.charge.state" event and can see that the start charge and stop charge envent run twice each one. 

I mean, 

vehicle.charge.start ---> fires on charging the EV, then

vehicle.charge.stop ---> fires after a few seconds (inmediately), then 

vehicle.charge.start ---> runs againg after 40 seconds 

I'm using the OVMS on a Hyundai Kona EV, but it seems something generally because I have a friend with an Opel Ampera and other with a Nissan Leaf and are experiencing the same issue. We all are running Firmware Version 3.2.015

dexter
dexter's picture
Duplicate Notifications on Charge Start event

Not sure if you're aware that "vehicle.charge.state" isn't coupled to the ".start/.stop" events, and the ".start/.stop" events don't trigger a notification by default. ".state" is triggered by changes of metric "v.c.state", ".start/.stop" reflect changes to "v.c.charging".

I've never before heard of this, and 3.2.015 has been in use for quite a while. I suggest checking if you're all running a specific plugin and try disabling that.

Please provide a log excerpt at level "debug" if that's not the case.

Regards,
Michael

juanheredia
Thanks Michael for your reply

Thanks Michael for your reply. 

I'm not using any plugin. This is my log on debug mode (sorry for the lenght, I've tried to trim the most important parts):

As you an see at 06:25:41 "vehicle.charge.start" then at 06:26:14 "vehicle.charge.stop", then agait at 06:26:16 "vehicle.charge.start"

BTW, is it correct that the Poller Send/Receive run constantly?

Thank you for your suppot. 

2021-02-19 06:25:37 CET D (30185868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC03], expecting 770/778-778
2021-02-19 06:25:37 CET D (30185898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=0 len=3 off=0 rem=5
2021-02-19 06:25:37 CET D (30185938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=1 len=5 off=3 rem=0
2021-02-19 06:25:40 CET D (30188868) vehicle: PollerSend(1): send [bus=0, type=22, pid=101], expecting 7e4/7ec-7ec
2021-02-19 06:25:40 CET D (30188878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=0 len=3 off=0 rem=56
2021-02-19 06:25:40 CET D (30188908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=1 len=7 off=3 rem=49
2021-02-19 06:25:40 CET D (30188938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=2 len=7 off=10 rem=42
2021-02-19 06:25:40 CET D (30188968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=3 len=7 off=17 rem=35
2021-02-19 06:25:40 CET D (30188998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=4 len=7 off=24 rem=28
2021-02-19 06:25:40 CET D (30189028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=5 len=7 off=31 rem=21
2021-02-19 06:25:40 CET D (30189058) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=6 len=7 off=38 rem=14
2021-02-19 06:25:40 CET D (30189088) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=7 len=7 off=45 rem=7
2021-02-19 06:25:40 CET D (30189118) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=8 len=7 off=52 rem=0
2021-02-19 06:25:41 CET I (30189868) v-kianiroev: Charging starting
2021-02-19 06:25:41 CET D (30189878) websocket: UpdateTicker: can't lock client list, ticker run skipped
2021-02-19 06:25:41 CET D (30189878) events: Signal(vehicle.charge.prepare)
2021-02-19 06:25:41 CET I (30189878) ovms-server-v3: Tx event vehicle.charge.prepare
2021-02-19 06:25:41 CET D (30189888) events: Signal(vehicle.charge.state)
2021-02-19 06:25:41 CET D (30189978) events: Signal(vehicle.charge.start)
2021-02-19 06:25:41 CET I (30189978) ovms-server-v3: Tx event vehicle.charge.start
2021-02-19 06:25:41 CET D (30189978) events: Signal(vehicle.charge.12v.start)
2021-02-19 06:25:41 CET I (30189988) ovms-server-v3: Tx event vehicle.charge.12v.start
2021-02-19 06:25:41 CET D (30189988) events: Signal(vehicle.charge.pilot.on)
2021-02-19 06:25:41 CET I (30189988) ovms-server-v3: Tx event vehicle.charge.pilot.on
2021-02-19 06:25:42 CET I (30190868) powermgmt: Charging 12V battery..
2021-02-19 06:25:42 CET D (30190868) vehicle: PollerSend(1): send [bus=0, type=1A, pid=80], expecting 7e2/7ea-7ea
2021-02-19 06:25:42 CET D (30190878) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=0 len=4 off=0 rem=93
2021-02-19 06:25:42 CET D (30190888) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=1 len=7 off=4 rem=86
2021-02-19 06:25:42 CET D (30190898) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=2 len=7 off=11 rem=79
2021-02-19 06:25:42 CET D (30190908) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=3 len=7 off=18 rem=72
2021-02-19 06:25:42 CET D (30190918) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=4 len=7 off=25 rem=65
2021-02-19 06:25:42 CET D (30190928) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=5 len=7 off=32 rem=58
2021-02-19 06:25:42 CET D (30190938) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=6 len=7 off=39 rem=51
2021-02-19 06:25:42 CET D (30190948) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=7 len=7 off=46 rem=44
2021-02-19 06:25:42 CET D (30190958) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=8 len=7 off=53 rem=37
2021-02-19 06:25:42 CET D (30190968) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=9 len=7 off=60 rem=30
2021-02-19 06:25:42 CET D (30190978) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=10 len=7 off=67 rem=23
2021-02-19 06:25:42 CET D (30190988) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=11 len=7 off=74 rem=16
2021-02-19 06:25:42 CET D (30190998) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=12 len=7 off=81 rem=9
2021-02-19 06:25:42 CET D (30191008) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=13 len=7 off=88 rem=2
2021-02-19 06:25:42 CET D (30191018) vehicle: PollerReceive[7EA]: process OBD/UDS response 1A(80) frm=14 len=2 off=95 rem=0
2021-02-19 06:25:43 CET D (30191868) vehicle: PollerSend(1): send [bus=0, type=22, pid=101], expecting 7e4/7ec-7ec
2021-02-19 06:25:43 CET D (30191878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=0 len=3 off=0 rem=56
2021-02-19 06:25:43 CET D (30191878) notify: Created entry type 'info' subtype 'charge.started' size 171 has 4 readers pending
2021-02-19 06:25:43 CET I (30191878) ovms-server-v2: Send MP-0 PIStandard - Charging|0.0V/infA|Full: 1440 mins|0%: 112 mins|0km: 112 mins|Charged: -0.0kWh|SOC: 75.0%|Ideal range: 225km|Est. range: 341km|ODO: 0.0km|CAC: 73.5Ah|SOH: 100%
2021-02-19 06:25:43 CET D (30191888) simcom: rx line ch=3 len=10  : +CREG: 1,1
2021-02-19 06:25:43 CET I (30191888) ovms-server-v3: Tx notify ovms/jchm/KonaEV/notify/info/charge.started=Standard - Charging|0.0V/infA|Full: 1440 mins|0%: 112 mins|0km: 112 mins|Charged: -0.0kWh|SOC: 75.0%|Ideal range: 225km|Est. range: 341km|ODO: 0.0km|CAC: 73.5Ah|SOH: 100%
2021-02-19 06:25:43 CET D (30191888) simcom: rx line ch=3 len=29  : +CCLK: "21/02/19,06:25:42+04"
2021-02-19 06:25:43 CET D (30191888) simcom: rx line ch=3 len=10  : +CSQ: 7,99
2021-02-19 06:25:43 CET D (30191888) simcom: rx line ch=3 len=20  : +COPS: 0,0,"simyo",2
2021-02-19 06:25:43 CET D (30191898) simcom: rx line ch=3 len=2   : OK
2021-02-19 06:25:43 CET D (30191898) events: Signal(notify.info.charge.started)
2021-02-19 06:25:43 CET I (30191898) ovms-server-v3: Tx event notify.info.charge.started
2021-02-19 06:25:43 CET D (30191908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=1 len=7 off=3 rem=49
2021-02-19 06:25:43 CET D (30191938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=2 len=7 off=10 rem=42
2021-02-19 06:25:43 CET D (30191968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=3 len=7 off=17 rem=35
2021-02-19 06:25:43 CET D (30191998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=4 len=7 off=24 rem=28
2021-02-19 06:25:43 CET D (30192028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=5 len=7 off=31 rem=21
2021-02-19 06:25:43 CET D (30192058) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=6 len=7 off=38 rem=14
2021-02-19 06:25:43 CET D (30192088) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=7 len=7 off=45 rem=7
2021-02-19 06:25:43 CET D (30192118) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=8 len=7 off=52 rem=0
2021-02-19 06:25:43 CET I (30192388) ovms-server-v3: Message publishing acknowledged (msg_id: 2020)
2021-02-19 06:25:44 CET D (30192868) vehicle: PollerSend(1): send [bus=0, type=22, pid=102], expecting 7e4/7ec-7ec
2021-02-19 06:25:44 CET D (30192878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=0 len=3 off=0 rem=33
2021-02-19 06:25:44 CET D (30192908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=1 len=7 off=3 rem=26
2021-02-19 06:25:44 CET D (30192938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=2 len=7 off=10 rem=19
2021-02-19 06:25:44 CET D (30192968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=3 len=7 off=17 rem=12
2021-02-19 06:25:44 CET D (30192998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=4 len=7 off=24 rem=5
2021-02-19 06:25:44 CET D (30193028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=5 len=5 off=31 rem=0
2021-02-19 06:25:45 CET D (30193868) vehicle: PollerSend(1): send [bus=0, type=22, pid=103], expecting 7e4/7ec-7ec
2021-02-19 06:25:45 CET D (30193878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=0 len=3 off=0 rem=33
2021-02-19 06:25:45 CET D (30193908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=1 len=7 off=3 rem=26
2021-02-19 06:25:45 CET D (30193938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=2 len=7 off=10 rem=19
2021-02-19 06:25:45 CET D (30193968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=3 len=7 off=17 rem=12
2021-02-19 06:25:45 CET D (30193998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=4 len=7 off=24 rem=5
2021-02-19 06:25:45 CET D (30194028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=5 len=5 off=31 rem=0
2021-02-19 06:25:46 CET D (30194868) vehicle: PollerSend(1): send [bus=0, type=22, pid=104], expecting 7e4/7ec-7ec
2021-02-19 06:25:46 CET D (30194878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=0 len=3 off=0 rem=33
2021-02-19 06:25:46 CET D (30194908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=1 len=7 off=3 rem=26
2021-02-19 06:25:46 CET D (30194938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=2 len=7 off=10 rem=19
2021-02-19 06:25:46 CET D (30194968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=3 len=7 off=17 rem=12
2021-02-19 06:25:46 CET D (30194998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=4 len=7 off=24 rem=5
2021-02-19 06:25:46 CET D (30195028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=5 len=5 off=31 rem=0
2021-02-19 06:25:47 CET D (30195868) vehicle: PollerSend(1): send [bus=0, type=22, pid=105], expecting 7e4/7ec-7ec
2021-02-19 06:25:47 CET D (30195878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=0 len=3 off=0 rem=40
2021-02-19 06:25:47 CET D (30195908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=1 len=7 off=3 rem=33
2021-02-19 06:25:47 CET D (30195938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=2 len=7 off=10 rem=26
2021-02-19 06:25:47 CET D (30195968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=3 len=7 off=17 rem=19
2021-02-19 06:25:47 CET D (30195998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=4 len=7 off=24 rem=12
2021-02-19 06:25:47 CET D (30196028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=5 len=7 off=31 rem=5
2021-02-19 06:25:47 CET D (30196058) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=6 len=5 off=38 rem=0
2021-02-19 06:25:48 CET D (30196868) vehicle: PollerSend(1): send [bus=0, type=22, pid=106], expecting 7e4/7ec-7ec
2021-02-19 06:25:48 CET D (30196878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=0 len=3 off=0 rem=21
2021-02-19 06:25:48 CET D (30196908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=1 len=7 off=3 rem=14
2021-02-19 06:25:48 CET D (30196938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=2 len=7 off=10 rem=7
2021-02-19 06:25:48 CET D (30196968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=3 len=7 off=17 rem=0
2021-02-19 06:25:49 CET D (30197868) vehicle: PollerSend(1): send [bus=0, type=22, pid=B00C], expecting 7a0/7a8-7a8
2021-02-19 06:25:51 CET D (30199868) vehicle: PollerSend(1): send [bus=0, type=22, pid=B00E], expecting 7a0/7a8-7a8
2021-02-19 06:25:51 CET D (30199878) vehicle: PollerReceive[7A8]: process OBD/UDS response 22(B00E) frm=0 len=3 off=0 rem=5
2021-02-19 06:25:51 CET D (30199918) vehicle: PollerReceive[7A8]: process OBD/UDS response 22(B00E) frm=1 len=5 off=3 rem=0
2021-02-19 06:25:52 CET D (30200868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC03], expecting 770/778-778
2021-02-19 06:25:52 CET D (30200898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=0 len=3 off=0 rem=5
2021-02-19 06:25:52 CET D (30200938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=1 len=5 off=3 rem=0
2021-02-19 06:25:53 CET D (30201868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC04], expecting 770/778-778
2021-02-19 06:25:53 CET D (30201898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC04) frm=0 len=3 off=0 rem=5
2021-02-19 06:25:53 CET D (30201938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC04) frm=1 len=5 off=3 rem=0
2021-02-19 06:25:54 CET D (30202868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC07], expecting 770/778-778
2021-02-19 06:25:54 CET D (30202898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC07) frm=0 len=3 off=0 rem=5
2021-02-19 06:25:54 CET D (30202938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC07) frm=1 len=5 off=3 rem=0
2021-02-19 06:25:55 CET D (30203868) vehicle: PollerSend(1): send [bus=0, type=22, pid=100], expecting 7b3/7bb-7bb
2021-02-19 06:25:55 CET D (30203888) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=0 len=3 off=0 rem=32
2021-02-19 06:25:55 CET D (30203908) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=1 len=7 off=3 rem=25
2021-02-19 06:25:55 CET D (30203918) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=2 len=7 off=10 rem=18
2021-02-19 06:25:55 CET D (30203928) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=3 len=7 off=17 rem=11
2021-02-19 06:25:55 CET D (30203938) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=4 len=7 off=24 rem=4
2021-02-19 06:25:55 CET D (30203948) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=5 len=4 off=31 rem=0
2021-02-19 06:25:56 CET D (30204868) vehicle: PollerSend(1): send [bus=0, type=22, pid=B002], expecting 7c6/7ce-7ce
2021-02-19 06:25:56 CET D (30204878) vehicle: PollerReceive[7CE]: process OBD/UDS response 22(B002) frm=0 len=3 off=0 rem=9
2021-02-19 06:25:56 CET D (30204888) vehicle: PollerReceive[7CE]: process OBD/UDS response 22(B002) frm=1 len=7 off=3 rem=2
2021-02-19 06:25:56 CET D (30204918) vehicle: PollerReceive[7CE]: process OBD/UDS response 22(B002) frm=2 len=2 off=10 rem=0
2021-02-19 06:25:57 CET D (30205868) vehicle: PollerSend(1): send [bus=0, type=22, pid=C101], expecting 7d1/7d9-7d9
2021-02-19 06:25:59 CET D (30207868) vehicle: PollerSend(1): send [bus=0, type=21, pid=1], expecting 7e5/7ed-7ed
2021-02-19 06:25:59 CET D (30207878) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=0 len=4 off=0 rem=52
2021-02-19 06:25:59 CET D (30207888) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=1 len=7 off=4 rem=45
2021-02-19 06:25:59 CET D (30207898) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=2 len=7 off=11 rem=38
2021-02-19 06:25:59 CET D (30207908) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=3 len=7 off=18 rem=31
2021-02-19 06:25:59 CET D (30207918) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=4 len=7 off=25 rem=24
2021-02-19 06:25:59 CET D (30207928) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=5 len=7 off=32 rem=17
2021-02-19 06:25:59 CET D (30207938) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=6 len=7 off=39 rem=10
2021-02-19 06:25:59 CET D (30207948) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=7 len=7 off=46 rem=3
2021-02-19 06:25:59 CET D (30207948) v-kianiroev: OBC Main batt: 355.899994
2021-02-19 06:25:59 CET D (30207958) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=8 len=3 off=53 rem=0
2021-02-19 06:26:00 CET D (30208868) vehicle: PollerSend(1): send [bus=0, type=21, pid=3], expecting 7e5/7ed-7ed
2021-02-19 06:26:00 CET I (30208878) ovms-server-v3: Tx event clock.0626
2021-02-19 06:26:00 CET D (30208878) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=0 len=4 off=0 rem=43
2021-02-19 06:26:00 CET D (30208888) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=1 len=7 off=4 rem=36
2021-02-19 06:26:00 CET D (30208898) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=2 len=7 off=11 rem=29
2021-02-19 06:26:00 CET D (30208908) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=3 len=7 off=18 rem=22
2021-02-19 06:26:00 CET D (30208918) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=4 len=7 off=25 rem=15
2021-02-19 06:26:00 CET D (30208928) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=5 len=7 off=32 rem=8
2021-02-19 06:26:00 CET D (30208938) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=6 len=7 off=39 rem=1
2021-02-19 06:26:00 CET D (30208948) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=7 len=1 off=46 rem=0
2021-02-19 06:26:01 CET D (30209868) vehicle: PollerSend(1): send [bus=0, type=21, pid=1], expecting 7e2/7ea-7ea
2021-02-19 06:26:01 CET D (30209878) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(1) frm=0 len=4 off=0 rem=18
2021-02-19 06:26:01 CET D (30209888) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(1) frm=1 len=7 off=4 rem=11
2021-02-19 06:26:01 CET D (30209898) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(1) frm=2 len=7 off=11 rem=4
2021-02-19 06:26:01 CET D (30209908) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(1) frm=3 len=4 off=18 rem=0
2021-02-19 06:26:02 CET D (30210868) vehicle: PollerSend(1): send [bus=0, type=21, pid=2], expecting 7e2/7ea-7ea
2021-02-19 06:26:02 CET D (30210878) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=0 len=4 off=0 rem=33
2021-02-19 06:26:02 CET D (30210888) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=1 len=7 off=4 rem=26
2021-02-19 06:26:02 CET D (30210898) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=2 len=7 off=11 rem=19
2021-02-19 06:26:02 CET D (30210908) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=3 len=7 off=18 rem=12
2021-02-19 06:26:02 CET D (30210918) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=4 len=7 off=25 rem=5
2021-02-19 06:26:02 CET D (30210928) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=5 len=5 off=32 rem=0
2021-02-19 06:26:03 CET D (30211868) vehicle: PollerSend(1): send [bus=0, type=21, pid=2], expecting 7e3/7eb-7eb
2021-02-19 06:26:03 CET D (30211868) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=0 len=4 off=0 rem=52
2021-02-19 06:26:03 CET D (30211878) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=1 len=7 off=4 rem=45
2021-02-19 06:26:03 CET D (30211888) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=2 len=7 off=11 rem=38
2021-02-19 06:26:03 CET D (30211898) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=3 len=7 off=18 rem=31
2021-02-19 06:26:03 CET D (30211908) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=4 len=7 off=25 rem=24
2021-02-19 06:26:03 CET D (30211918) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=5 len=7 off=32 rem=17
2021-02-19 06:26:03 CET D (30211928) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=6 len=7 off=39 rem=10
2021-02-19 06:26:03 CET D (30211938) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=7 len=7 off=46 rem=3
2021-02-19 06:26:03 CET D (30211948) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=8 len=3 off=53 rem=0
2021-02-19 06:26:11 CET D (30219868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC03], expecting 770/778-778
2021-02-19 06:26:11 CET D (30219898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=0 len=3 off=0 rem=5
2021-02-19 06:26:11 CET D (30219938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC03) frm=1 len=5 off=3 rem=0
2021-02-19 06:26:12 CET D (30220868) vehicle: PollerSend(1): send [bus=0, type=21, pid=2], expecting 7e2/7ea-7ea
2021-02-19 06:26:12 CET D (30220878) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=0 len=4 off=0 rem=33
2021-02-19 06:26:12 CET D (30220888) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=1 len=7 off=4 rem=26
2021-02-19 06:26:12 CET D (30220898) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=2 len=7 off=11 rem=19
2021-02-19 06:26:12 CET D (30220908) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=3 len=7 off=18 rem=12
2021-02-19 06:26:12 CET D (30220918) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=4 len=7 off=25 rem=5
2021-02-19 06:26:12 CET D (30220928) vehicle: PollerReceive[7EA]: process OBD/UDS response 21(2) frm=5 len=5 off=32 rem=0
2021-02-19 06:26:13 CET D (30221888) simcom: rx line ch=3 len=10  : +CREG: 1,1
2021-02-19 06:26:13 CET D (30221888) simcom: rx line ch=3 len=29  : +CCLK: "21/02/19,06:26:12+04"
2021-02-19 06:26:13 CET D (30221898) simcom: rx line ch=3 len=10  : +CSQ: 7,99
2021-02-19 06:26:13 CET D (30221898) simcom: rx line ch=3 len=20  : +COPS: 0,0,"simyo",2
2021-02-19 06:26:13 CET D (30221898) simcom: rx line ch=3 len=2   : OK
2021-02-19 06:26:14 CET I (30222868) v-kianiroev: Charging done...
2021-02-19 06:26:14 CET D (30223058) events: Signal(vehicle.charge.finish)
2021-02-19 06:26:14 CET I (30223058) ovms-server-v3: Tx event vehicle.charge.finish
2021-02-19 06:26:14 CET D (30223138) events: Signal(vehicle.charge.stop)
2021-02-19 06:26:14 CET I (30223138) ovms-server-v3: Tx event vehicle.charge.stop
2021-02-19 06:26:14 CET D (30223148) events: Signal(vehicle.charge.12v.stop)
2021-02-19 06:26:14 CET I (30223148) ovms-server-v3: Tx event vehicle.charge.12v.stop
2021-02-19 06:26:14 CET D (30223158) events: Signal(vehicle.charge.pilot.off)
2021-02-19 06:26:14 CET I (30223158) ovms-server-v3: Tx event vehicle.charge.pilot.off
2021-02-19 06:26:15 CET I (30223868) powermgmt: No longer charging 12V battery..
2021-02-19 06:26:15 CET D (30223868) vehicle: PollerSend(1): send [bus=0, type=22, pid=101], expecting 7e4/7ec-7ec
2021-02-19 06:26:15 CET D (30223878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=0 len=3 off=0 rem=56
2021-02-19 06:26:15 CET D (30223908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=1 len=7 off=3 rem=49
2021-02-19 06:26:15 CET D (30223938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=2 len=7 off=10 rem=42
2021-02-19 06:26:15 CET D (30223968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=3 len=7 off=17 rem=35
2021-02-19 06:26:15 CET D (30223998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=4 len=7 off=24 rem=28
2021-02-19 06:26:15 CET D (30224028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=5 len=7 off=31 rem=21
2021-02-19 06:26:15 CET D (30224058) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=6 len=7 off=38 rem=14
2021-02-19 06:26:15 CET D (30224088) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=7 len=7 off=45 rem=7
2021-02-19 06:26:15 CET D (30224118) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(101) frm=8 len=7 off=52 rem=0
2021-02-19 06:26:16 CET D (30224868) vehicle: PollerSend(1): send [bus=0, type=22, pid=102], expecting 7e4/7ec-7ec
2021-02-19 06:26:16 CET I (30224868) v-kianiroev: Charging starting
2021-02-19 06:26:16 CET D (30224878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=0 len=3 off=0 rem=33
2021-02-19 06:26:16 CET D (30224878) events: Signal(vehicle.charge.prepare)
2021-02-19 06:26:16 CET I (30224878) ovms-server-v3: Tx event vehicle.charge.prepare
2021-02-19 06:26:16 CET D (30224908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=1 len=7 off=3 rem=26
2021-02-19 06:26:16 CET D (30224938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=2 len=7 off=10 rem=19
2021-02-19 06:26:16 CET D (30224968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=3 len=7 off=17 rem=12
2021-02-19 06:26:16 CET D (30224998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=4 len=7 off=24 rem=5
2021-02-19 06:26:16 CET D (30225028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(102) frm=5 len=5 off=31 rem=0
2021-02-19 06:26:16 CET D (30225048) events: Signal(vehicle.charge.start)
2021-02-19 06:26:16 CET I (30225048) ovms-server-v3: Tx event vehicle.charge.start
2021-02-19 06:26:16 CET D (30225048) events: Signal(vehicle.charge.12v.start)
2021-02-19 06:26:16 CET I (30225058) ovms-server-v3: Tx event vehicle.charge.12v.start
2021-02-19 06:26:16 CET D (30225058) events: Signal(vehicle.charge.pilot.on)
2021-02-19 06:26:16 CET I (30225058) ovms-server-v3: Tx event vehicle.charge.pilot.on
2021-02-19 06:26:17 CET I (30225868) powermgmt: Charging 12V battery..
2021-02-19 06:26:17 CET D (30225868) vehicle: PollerSend(1): send [bus=0, type=22, pid=103], expecting 7e4/7ec-7ec
2021-02-19 06:26:17 CET D (30225878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=0 len=3 off=0 rem=33
2021-02-19 06:26:17 CET D (30225908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=1 len=7 off=3 rem=26
2021-02-19 06:26:17 CET D (30225938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=2 len=7 off=10 rem=19
2021-02-19 06:26:17 CET D (30225968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=3 len=7 off=17 rem=12
2021-02-19 06:26:17 CET D (30225998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=4 len=7 off=24 rem=5
2021-02-19 06:26:17 CET D (30226028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(103) frm=5 len=5 off=31 rem=0
2021-02-19 06:26:18 CET D (30226868) vehicle: PollerSend(1): send [bus=0, type=22, pid=104], expecting 7e4/7ec-7ec
2021-02-19 06:26:18 CET D (30226878) notify: Created entry type 'info' subtype 'charge.started' size 173 has 4 readers pending
2021-02-19 06:26:18 CET D (30226878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=0 len=3 off=0 rem=33
2021-02-19 06:26:18 CET I (30226878) ovms-server-v2: Send MP-0 PIStandard - Charging|232.0V/21.6A|Full: 116 mins|0%: 116 mins|0km: 116 mins|Charged: -0.0kWh|SOC: 75.0%|Ideal range: 225km|Est. range: 341km|ODO: 0.0km|CAC: 73.5Ah|SOH: 100%
2021-02-19 06:26:18 CET I (30226888) ovms-server-v3: Tx notify ovms/jchm/KonaEV/notify/info/charge.started=Standard - Charging|232.0V/21.6A|Full: 116 mins|0%: 116 mins|0km: 116 mins|Charged: -0.0kWh|SOC: 75.0%|Ideal range: 225km|Est. range: 341km|ODO: 0.0km|CAC: 73.5Ah|SOH: 100%
2021-02-19 06:26:18 CET D (30226888) events: Signal(notify.info.charge.started)
2021-02-19 06:26:18 CET I (30226898) ovms-server-v3: Tx event notify.info.charge.started
2021-02-19 06:26:18 CET D (30226908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=1 len=7 off=3 rem=26
2021-02-19 06:26:18 CET D (30226938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=2 len=7 off=10 rem=19
2021-02-19 06:26:18 CET D (30226968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=3 len=7 off=17 rem=12
2021-02-19 06:26:18 CET D (30226998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=4 len=7 off=24 rem=5
2021-02-19 06:26:18 CET D (30227028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(104) frm=5 len=5 off=31 rem=0
2021-02-19 06:26:18 CET I (30227338) ovms-server-v3: Message publishing acknowledged (msg_id: 2033)
2021-02-19 06:26:19 CET D (30227868) vehicle: PollerSend(1): send [bus=0, type=22, pid=105], expecting 7e4/7ec-7ec
2021-02-19 06:26:19 CET D (30227878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=0 len=3 off=0 rem=40
2021-02-19 06:26:19 CET D (30227908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=1 len=7 off=3 rem=33
2021-02-19 06:26:19 CET D (30227938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=2 len=7 off=10 rem=26
2021-02-19 06:26:19 CET D (30227968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=3 len=7 off=17 rem=19
2021-02-19 06:26:19 CET D (30227998) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=4 len=7 off=24 rem=12
2021-02-19 06:26:19 CET D (30228028) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=5 len=7 off=31 rem=5
2021-02-19 06:26:19 CET D (30228058) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(105) frm=6 len=5 off=38 rem=0
2021-02-19 06:26:20 CET D (30228868) vehicle: PollerSend(1): send [bus=0, type=22, pid=106], expecting 7e4/7ec-7ec
2021-02-19 06:26:20 CET D (30228878) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=0 len=3 off=0 rem=21
2021-02-19 06:26:20 CET D (30228908) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=1 len=7 off=3 rem=14
2021-02-19 06:26:20 CET D (30228938) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=2 len=7 off=10 rem=7
2021-02-19 06:26:20 CET D (30228968) vehicle: PollerReceive[7EC]: process OBD/UDS response 22(106) frm=3 len=7 off=17 rem=0
2021-02-19 06:26:22 CET D (30230868) vehicle: PollerSend(1): send [bus=0, type=22, pid=B00E], expecting 7a0/7a8-7a8
2021-02-19 06:26:24 CET D (30232868) vehicle: PollerSend(1): send [bus=0, type=22, pid=100], expecting 7b3/7bb-7bb
2021-02-19 06:26:24 CET D (30232888) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=0 len=3 off=0 rem=32
2021-02-19 06:26:24 CET D (30232908) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=1 len=7 off=3 rem=25
2021-02-19 06:26:24 CET D (30232918) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=2 len=7 off=10 rem=18
2021-02-19 06:26:24 CET D (30232928) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=3 len=7 off=17 rem=11
2021-02-19 06:26:24 CET D (30232938) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=4 len=7 off=24 rem=4
2021-02-19 06:26:24 CET D (30232948) vehicle: PollerReceive[7BB]: process OBD/UDS response 22(100) frm=5 len=4 off=31 rem=0
2021-02-19 06:26:26 CET D (30234868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC04], expecting 770/778-778
2021-02-19 06:26:26 CET D (30234898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC04) frm=0 len=3 off=0 rem=5
2021-02-19 06:26:26 CET D (30234938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC04) frm=1 len=5 off=3 rem=0
2021-02-19 06:26:27 CET D (30235868) vehicle: PollerSend(1): send [bus=0, type=21, pid=1], expecting 7e5/7ed-7ed
2021-02-19 06:26:27 CET D (30235878) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=0 len=4 off=0 rem=52
2021-02-19 06:26:27 CET D (30235888) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=1 len=7 off=4 rem=45
2021-02-19 06:26:27 CET D (30235898) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=2 len=7 off=11 rem=38
2021-02-19 06:26:27 CET D (30235908) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=3 len=7 off=18 rem=31
2021-02-19 06:26:27 CET D (30235918) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=4 len=7 off=25 rem=24
2021-02-19 06:26:27 CET D (30235928) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=5 len=7 off=32 rem=17
2021-02-19 06:26:27 CET D (30235938) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=6 len=7 off=39 rem=10
2021-02-19 06:26:27 CET D (30235948) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=7 len=7 off=46 rem=3
2021-02-19 06:26:27 CET D (30235948) v-kianiroev: OBC Main batt: 356.200012
2021-02-19 06:26:27 CET D (30235958) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(1) frm=8 len=3 off=53 rem=0
2021-02-19 06:26:28 CET D (30236868) vehicle: PollerSend(1): send [bus=0, type=21, pid=3], expecting 7e5/7ed-7ed
2021-02-19 06:26:28 CET D (30236878) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=0 len=4 off=0 rem=43
2021-02-19 06:26:28 CET D (30236888) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=1 len=7 off=4 rem=36
2021-02-19 06:26:28 CET D (30236898) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=2 len=7 off=11 rem=29
2021-02-19 06:26:28 CET D (30236908) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=3 len=7 off=18 rem=22
2021-02-19 06:26:28 CET D (30236918) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=4 len=7 off=25 rem=15
2021-02-19 06:26:28 CET D (30236928) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=5 len=7 off=32 rem=8
2021-02-19 06:26:28 CET D (30236938) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=6 len=7 off=39 rem=1
2021-02-19 06:26:28 CET D (30236948) vehicle: PollerReceive[7ED]: process OBD/UDS response 21(3) frm=7 len=1 off=46 rem=0
2021-02-19 06:26:29 CET D (30237868) vehicle: PollerSend(1): send [bus=0, type=21, pid=2], expecting 7e3/7eb-7eb
2021-02-19 06:26:29 CET D (30237868) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=0 len=4 off=0 rem=52
2021-02-19 06:26:29 CET D (30237878) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=1 len=7 off=4 rem=45
2021-02-19 06:26:29 CET D (30237888) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=2 len=7 off=11 rem=38
2021-02-19 06:26:29 CET D (30237908) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=3 len=7 off=18 rem=31
2021-02-19 06:26:29 CET D (30237908) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=4 len=7 off=25 rem=24
2021-02-19 06:26:29 CET D (30237918) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=5 len=7 off=32 rem=17
2021-02-19 06:26:29 CET D (30237928) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=6 len=7 off=39 rem=10
2021-02-19 06:26:29 CET D (30237948) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=7 len=7 off=46 rem=3
2021-02-19 06:26:29 CET D (30237958) vehicle: PollerReceive[7EB]: process OBD/UDS response 21(2) frm=8 len=3 off=53 rem=0
2021-02-19 06:26:32 CET D (30240868) vehicle: PollerSend(1): send [bus=0, type=22, pid=BC07], expecting 770/778-778
2021-02-19 06:26:32 CET D (30240898) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC07) frm=0 len=3 off=0 rem=5
2021-02-19 06:26:32 CET D (30240938) vehicle: PollerReceive[778]: process OBD/UDS response 22(BC07) frm=1 len=5 off=3 rem=0
2021-02-19 06:26:33 CET D (30242018) script: Duktape: Compacting DukTape memory done in 120 ms
dexter
dexter's picture
Duplicate Notifications on Charge Start event

As you can see from the log…

2021-02-19 06:26:14 CET I (30222868) v-kianiroev: Charging done...

…it's the vehicle module that actually misdetects the charge stop. Please contact the vehicle developer (Geir I assume).

Regards,
Michael

juanheredia
Thanks for your replay. May I

Thanks for your replay. May I kindly ask, where to contact? Do you mean in this Forum? Thanks for your support

Log in or register to post comments