evcc-io
Repeating plans: charging stops on plan overrun
Describe the bug
Seit Update auf aktuelle Version wird die Ladeplanung pünktlich zum festgelegten Zeitpunkt beendet. Das Ladeziel von 100% wird nicht mehr erreicht und endet zwischen 70 und 90%. Cupra Formentor Plugin Hybrid 1 Phasig.
Die tatsächliche Ladeleistung ist 3,5kw bis ca. 92% Akkustand.
Den Ladeplan habe ich schonmal gelöscht und neu angelegt. Keine Besserung.
Hier schient das gleiche Verhalten zu sein: https://github.com/evcc-io/evcc/discussions/24291
Früher hat er den errechneten Zeitpunkt auch nicht erreicht, aber halt trotzdem bis 100% zu Ende geladen.
Steps to reproduce
1.Ladeplan erstellen 2.Ladeplan wird ausgeführt 3. ...
Configuration details
[main ] INFO 2025/10/11 16:10:24 using config file: /home/pi/evcc.yaml
[db ] INFO 2025/10/11 16:10:24 using sqlite database: /var/lib/evcc/evcc.db
charger
---
db:7 {Type:template Title: Icon: Product:} map[ip:192.168.0.71 ski:* template:eebus]
meter
---
db:1 {Type:template Title: Icon: Product:} map[battery:1 baudrate:9600 capacity:12 device:/dev/ttyUSB0 id:247 maxacpower:10000 modbus:rs485serial template:goodwe-hybrid usage:pv]
db:3 {Type:template Title: Icon: Product:} map[battery:1 baudrate:9600 capacity:12 device:/dev/ttyUSB0 id:247 maxacpower:10000 modbus:rs485serial template:goodwe-hybrid usage:battery]
db:5 {Type:template Title: Icon: Product:} map[battery:1 baudrate:9600 device:/dev/ttyUSB0 id:247 maxacpower:0 modbus:rs485serial template:goodwe-hybrid usage:grid]
vehicle
---
db:2 {Type:template Title: Icon: Product:} map[accessToken:* cache:15m capacity:42 icon:car maxCurrent:16 minCurrent:6 mode:pv password:***** refreshToken:* template:peugeot title:e208 user:***** vin:*****]
db:6 {Type:template Title: Icon: Product:} map[cache:1e+12 capacity:10.2 icon:car maxCurrent:16 minCurrent:14 mode:pv password:***** phases:1 template:seat title:Cupra user:***** vin:*****]
loadpoint
---
db:8 {Type: Title: Icon: Product:} map[charger:db:7 circuit: defaultMode:pv limitSoc:0 maxCurrent:16 meter: mode:pv phasesConfigured:3 soc:map[estimate:true poll:map[interval:3.6e+12 mode:charging]] thresholds:map[disable:map[delay:1.8e+11 threshold:0] enable:map[delay:6e+10 threshold:0]] title:Garage vehicle:]
Log details
{"status":"ok"}
[site ] DEBUG 2025/10/11 15:59:28 ----
[lp-1 ] DEBUG 2025/10/11 15:59:28 charge power: 3518W
[lp-1 ] DEBUG 2025/10/11 15:59:28 charge currents: [15.7 0 0]A
[site ] DEBUG 2025/10/11 15:59:28 grid power: 4200W
[site ] DEBUG 2025/10/11 15:59:28 battery 1 power: -260W
[site ] DEBUG 2025/10/11 15:59:28 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 15:59:28 pv 1 power: 270W
[site ] DEBUG 2025/10/11 15:59:29 grid powers: [4100 35 118]W
[site ] DEBUG 2025/10/11 15:59:29 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 15:59:14 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 15:59:29 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 15:59:29 grid currents: [18 0.5 0.7]A
[site ] DEBUG 2025/10/11 15:59:29 site power: 4040W
[lp-1 ] DEBUG 2025/10/11 15:59:29 detected active phases: 1p
[lp-1 ] DEBUG 2025/10/11 15:59:29 session energy: 5.280kWh
[lp-1 ] DEBUG 2025/10/11 15:59:29 charger status: C
[lp-1 ] DEBUG 2025/10/11 15:59:29 soc estimated: 70.95% (vehicle: 65.00%)
[lp-1 ] DEBUG 2025/10/11 15:59:29 vehicle soc: 71%
[lp-1 ] DEBUG 2025/10/11 15:59:29 vehicle range: 12km
[lp-1 ] DEBUG 2025/10/11 15:59:29 plan: charge 45m29s between 2025-10-11 15:59:29 +0200 CEST until 2025-10-11 16:00:00 +0200 CEST (overruns by 44m58s, power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 15:59:29 slot from: 2025-10-11 15:59:29 +0200 CEST to 2025-10-11 16:00:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:29 slot from: 2025-10-11 16:00:00 +0200 CEST to 2025-10-11 16:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:29 slot from: 2025-10-11 16:15:00 +0200 CEST to 2025-10-11 16:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:29 slot from: 2025-10-11 16:30:00 +0200 CEST to 2025-10-11 16:44:58 +0200 CEST cost 0.294
[site ] DEBUG 2025/10/11 15:59:43 ----
[lp-1 ] DEBUG 2025/10/11 15:59:43 charge power: 3520W
[lp-1 ] DEBUG 2025/10/11 15:59:43 charge currents: [15.7 0 0]A
[site ] DEBUG 2025/10/11 15:59:43 grid power: 4205W
[site ] DEBUG 2025/10/11 15:59:43 battery 1 power: -264W
[site ] DEBUG 2025/10/11 15:59:43 pv 1 power: 280W
[site ] DEBUG 2025/10/11 15:59:43 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 15:59:44 grid powers: [4019 34 150]W
[site ] DEBUG 2025/10/11 15:59:44 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 15:59:29 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 15:59:44 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 15:59:44 grid currents: [17.8 0.5 0.8]A
[site ] DEBUG 2025/10/11 15:59:44 site power: 4041W
[lp-1 ] DEBUG 2025/10/11 15:59:44 detected active phases: 1p
[lp-1 ] DEBUG 2025/10/11 15:59:44 session energy: 5.295kWh
[lp-1 ] DEBUG 2025/10/11 15:59:44 charger status: C
[lp-1 ] DEBUG 2025/10/11 15:59:44 soc estimated: 71.11% (vehicle: 65.00%)
[lp-1 ] DEBUG 2025/10/11 15:59:44 vehicle soc: 71%
[lp-1 ] DEBUG 2025/10/11 15:59:44 vehicle range: 12km
[lp-1 ] DEBUG 2025/10/11 15:59:44 plan: charge 45m14s between 2025-10-11 15:59:44 +0200 CEST until 2025-10-11 16:00:00 +0200 CEST (overruns by 44m58s, power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 15:59:44 slot from: 2025-10-11 15:59:44 +0200 CEST to 2025-10-11 16:00:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:44 slot from: 2025-10-11 16:00:00 +0200 CEST to 2025-10-11 16:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:44 slot from: 2025-10-11 16:15:00 +0200 CEST to 2025-10-11 16:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:44 slot from: 2025-10-11 16:30:00 +0200 CEST to 2025-10-11 16:44:58 +0200 CEST cost 0.294
[site ] DEBUG 2025/10/11 15:59:58 ----
[lp-1 ] DEBUG 2025/10/11 15:59:58 charge power: 3520W
[lp-1 ] DEBUG 2025/10/11 15:59:58 charge currents: [15.7 0 0]A
[site ] DEBUG 2025/10/11 15:59:58 grid power: 4209W
[site ] DEBUG 2025/10/11 15:59:58 battery 1 power: -278W
[site ] DEBUG 2025/10/11 15:59:58 pv 1 power: 289W
[site ] DEBUG 2025/10/11 15:59:58 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 15:59:59 grid powers: [4032 33 147]W
[site ] DEBUG 2025/10/11 15:59:59 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 15:59:44 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 15:59:59 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 15:59:59 grid currents: [17.9 0.5 0.8]A
[site ] DEBUG 2025/10/11 15:59:59 site power: 4031W
[lp-1 ] DEBUG 2025/10/11 15:59:59 detected active phases: 1p
[lp-1 ] DEBUG 2025/10/11 15:59:59 session energy: 5.310kWh
[lp-1 ] DEBUG 2025/10/11 15:59:59 charger status: C
[lp-1 ] DEBUG 2025/10/11 15:59:59 soc estimated: 71.28% (vehicle: 65.00%)
[lp-1 ] DEBUG 2025/10/11 15:59:59 vehicle soc: 71%
[lp-1 ] DEBUG 2025/10/11 15:59:59 vehicle range: 12km
[lp-1 ] DEBUG 2025/10/11 15:59:59 plan: charge 45m0s between 2025-10-11 15:59:59 +0200 CEST until 2025-10-11 16:00:00 +0200 CEST (overruns by 44m59s, power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 15:59:59 +0200 CEST to 2025-10-11 16:00:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:00:00 +0200 CEST to 2025-10-11 16:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:15:00 +0200 CEST to 2025-10-11 16:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:30:00 +0200 CEST to 2025-10-11 16:44:59 +0200 CEST cost 0.294
[site ] TRACE 2025/10/11 15:59:59 telemetry: charge: Δ0/44Wh @ 3520W
[site ] TRACE 2025/10/11 15:59:59 POST https://api.evcc.io/v1/charge
[site ] TRACE 2025/10/11 15:59:59 {"instanceId":"6a9108443f558ede6279a487f79bde8d52cf63de0139ce3554c59e10b17a0bd7","chargePower":3520,"greenPower":0,"chargeEnergy":0.04399084139197562,"greenEnergy":0}
--
{"status":"ok"}
[site ] DEBUG 2025/10/11 16:00:13 ----
[lp-1 ] DEBUG 2025/10/11 16:00:13 charge power: 3519W
[lp-1 ] DEBUG 2025/10/11 16:00:13 charge currents: [15.7 0 0]A
[site ] DEBUG 2025/10/11 16:00:13 grid power: 4206W
[site ] DEBUG 2025/10/11 16:00:13 battery 1 power: -286W
[site ] DEBUG 2025/10/11 16:00:13 grid powers: [4018 35 149]W
[site ] DEBUG 2025/10/11 16:00:13 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 16:00:14 pv 1 power: 292W
[site ] DEBUG 2025/10/11 16:00:14 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 15:59:59 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 16:00:14 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 16:00:14 grid currents: [17.8 0.5 0.8]A
[site ] DEBUG 2025/10/11 16:00:14 site power: 4020W
[site ] DEBUG 2025/10/11 16:00:14 15min household consumption: 0Wh
[lp-1 ] DEBUG 2025/10/11 16:00:14 detected active phases: 1p
[lp-1 ] DEBUG 2025/10/11 16:00:14 session energy: 5.324kWh
[lp-1 ] DEBUG 2025/10/11 16:00:14 charger status: C
[lp-1 ] DEBUG 2025/10/11 16:00:14 soc estimated: 71.44% (vehicle: 65.00%)
[lp-1 ] DEBUG 2025/10/11 16:00:14 vehicle soc: 71%
[lp-1 ] DEBUG 2025/10/11 16:00:14 vehicle range: 12km
[lp-1 ] DEBUG 2025/10/11 16:00:14 plan: charge 44m46s between 2025-10-12 15:15:14 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:15:14 +0200 CEST to 2025-10-12 15:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:30:00 +0200 CEST to 2025-10-12 15:45:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:45:00 +0200 CEST to 2025-10-12 16:00:00 +0200 CEST cost 0.294
[lp-1 ] DEBUG 2025/10/11 16:00:14 pv charge current: 0A = 16A + -17.5A (4020W @ 1p)
[lp-1 ] DEBUG 2025/10/11 16:00:14 projected site power 4020W >= 0W disable threshold
[lp-1 ] DEBUG 2025/10/11 16:00:14 pv disable in 0s
[lp-1 ] DEBUG 2025/10/11 16:00:14 pv disable timer elapsed
[lp-1 ] DEBUG 2025/10/11 16:00:14 pv timer reset
[lp-1 ] DEBUG 2025/10/11 16:00:14 pv timer inactive
[seat ] TRACE 2025/10/11 16:00:14 GET https://fal-3a.prd.eu.dp.vwg-connect.com/fs-car/bs/climatisation/v1/VW/ES/vehicles/***/climater
[seat ] TRACE 2025/10/11 16:00:15 {"climater":{"settings":{"targetTemperature":{"timestamp":"2025-10-02T18:35:54Z","content":2900},"climatisationWithoutHVpower":{"timestamp":"2025-10-02T18:35:54Z","content":false},"heaterSource":{"timestamp":"2025-10-02T18:35:54Z","content":"electric"}},"status":{"climatisationStatusData":{"climatisationState":{"timestamp":"2025-10-11T09:21:17Z","content":"off"},"remainingClimatisationTime":{"timestamp":"2025-10-11T09:21:17Z","content":0},"climatisationReason":{"timestamp":"2025-10-11T09:21:17Z","content":"immediate"}},"windowHeatingStatusData":{"windowHeatingStateFront":{"timestamp":"2025-10-11T09:21:17Z","content":"off"},"windowHeatingStateRear":{"timestamp":"2025-10-11T09:21:17Z","content":"off"}},"vehicleParkingClockStatusData":{"vehicleParkingClock":{"timestamp":"2025-10-11T09:21:56Z","content":"2025-10-11T09:21:56Z"}}}}}
[lp-1 ] DEBUG 2025/10/11 16:00:15 charger disable
[site ] DEBUG 2025/10/11 16:00:28 ----
[lp-1 ] DEBUG 2025/10/11 16:00:28 charge power: 0W
[lp-1 ] DEBUG 2025/10/11 16:00:28 charge currents: [0 0 0]A
[site ] DEBUG 2025/10/11 16:00:28 set battery mode: normal
[site ] DEBUG 2025/10/11 16:00:28 grid power: 707W
[site ] DEBUG 2025/10/11 16:00:28 battery 1 power: -285W
[site ] DEBUG 2025/10/11 16:00:28 pv 1 power: 295W
[site ] DEBUG 2025/10/11 16:00:28 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 16:00:29 grid powers: [549 32 129]W
[site ] DEBUG 2025/10/11 16:00:29 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 16:00:14 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 16:00:29 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 16:00:29 grid currents: [2.2 0.8 0.6]A
[site ] DEBUG 2025/10/11 16:00:29 site power: 522W
[lp-1 ] DEBUG 2025/10/11 16:00:29 charger status: B
[lp-1 ] INFO 2025/10/11 16:00:29 stop charging <-
[seat ] TRACE 2025/10/11 16:00:29 GET https://fal-3a.prd.eu.dp.vwg-connect.com/fs-car/bs/batterycharge/v1/VW/ES/vehicles/***/charger
[seat ] TRACE 2025/10/11 16:00:29 {"charger":{"settings":{"maxChargeCurrent":{"content":254,"timestamp":"2025-10-11T14:00:22Z"},"chargeModeSelection":{"modificationState":{"content":"canNotBeModified","timestamp":"2025-10-11T14:00:22Z"},"modificationReason":{"content":"noReason","timestamp":"2025-10-11T14:00:22Z"},"value":{"content":"timerBasedCharging","timestamp":"2025-10-11T14:00:22Z"}}},"status":{"chargingStatusData":{"chargingReason":{"content":"immediate","timestamp":"2025-10-11T14:00:24Z"},"externalPowerSupplyState":{"content":"unavailable","timestamp":"2025-10-11T14:00:24Z"},"chargingState":{"content":"off","timestamp":"2025-10-11T14:00:24Z"}},"cruisingRangeStatusData":{"engineTypeFirstEngine":{"content":"petrolGasoline","timestamp":"2025-10-11T14:00:24Z"},"primaryEngineRange":{"content":440,"timestamp":"2025-10-11T14:00:24Z"},"engineTypeSecondEngine":{"content":"typeIsElectric","timestamp":"2025-10-11T14:00:24Z"},"secondaryEngineRange":{"content":12,"timestamp":"2025-10-11T14:00:24Z"}},"batteryStatusData":{"stateOfCharge":{"content":71,"timestamp":"2025-10-11T14:00:24Z"},"remainingChargingTime":{"content":65535,"timestamp":"2025-10-11T14:00:24Z"}},"plugStatusData":{"plugState":{"content":"connected","timestamp":"2025-10-11T14:00:24Z"},"lockState":{"content":"locked","timestamp":"2025-10-11T14:00:24Z"}}}}}
[lp-1 ] DEBUG 2025/10/11 16:00:29 vehicle status: B
[lp-1 ] DEBUG 2025/10/11 16:00:29 soc gradient updated: soc: 71.0%, socDiff: 58.0%, energyDiff: 5324Wh, energyPerSocStep: 91.8Wh, virtualCapacity: 9180Wh
[lp-1 ] DEBUG 2025/10/11 16:00:29 vehicle soc: 71%
[lp-1 ] DEBUG 2025/10/11 16:00:29 vehicle range: 12km
[lp-1 ] DEBUG 2025/10/11 16:00:29 plan: charge 45m45s between 2025-10-12 15:14:15 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 16:00:29 slot from: 2025-10-12 15:14:15 +0200 CEST to 2025-10-12 15:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:29 slot from: 2025-10-12 15:15:00 +0200 CEST to 2025-10-12 15:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:29 slot from: 2025-10-12 15:30:00 +0200 CEST to 2025-10-12 15:45:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:29 slot from: 2025-10-12 15:45:00 +0200 CEST to 2025-10-12 16:00:00 +0200 CEST cost 0.294
[lp-1 ] DEBUG 2025/10/11 16:00:29 pv charge current: 0A = 0A + -2.27A (522W @ 1p)
[site ] DEBUG 2025/10/11 16:00:43 ----
[lp-1 ] DEBUG 2025/10/11 16:00:43 charge power: 0W
[lp-1 ] DEBUG 2025/10/11 16:00:43 charge currents: [0 0 0]A
[site ] DEBUG 2025/10/11 16:00:43 grid power: -41W
[site ] DEBUG 2025/10/11 16:00:43 battery 1 power: 408W
[site ] DEBUG 2025/10/11 16:00:43 grid powers: [243 -189 -93]W
[site ] DEBUG 2025/10/11 16:00:43 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 16:00:43 pv 1 power: 301W
[site ] DEBUG 2025/10/11 16:00:44 grid currents: [1.9 -0.9 -0.6]A
[site ] DEBUG 2025/10/11 16:00:44 !! solar production: accumulate set db:1 36230.100kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 16:00:29 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 16:00:44 !! solar production: accumulate moved db:1 from 5.200 to 5.200
[site ] DEBUG 2025/10/11 16:00:44 site power: 467W
[lp-1 ] DEBUG 2025/10/11 16:00:44 charger status: B
[lp-1 ] DEBUG 2025/10/11 16:00:44 plan: charge 45m45s between 2025-10-12 15:14:15 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 16:00:44 slot from: 2025-10-12 15:14:15 +0200 CEST to 2025-10-12 15:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:44 slot from: 2025-10-12 15:15:00 +0200 CEST to 2025-10-12 15:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:44 slot from: 2025-10-12 15:30:00 +0200 CEST to 2025-10-12 15:45:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:44 slot from: 2025-10-12 15:45:00 +0200 CEST to 2025-10-12 16:00:00 +0200 CEST cost 0.294
[lp-1 ] DEBUG 2025/10/11 16:00:44 pv charge current: 0A = 0A + -2.03A (467W @ 1p)
[site ] DEBUG 2025/10/11 16:00:58 ----
[lp-1 ] DEBUG 2025/10/11 16:00:58 charge power: 0W
[lp-1 ] DEBUG 2025/10/11 16:00:58 charge currents: [0 0 0]A
[site ] DEBUG 2025/10/11 16:00:58 grid power: -4W
[site ] DEBUG 2025/10/11 16:00:58 battery 1 power: 318W
[site ] DEBUG 2025/10/11 16:00:58 grid powers: [239 -174 -81]W
[site ] DEBUG 2025/10/11 16:00:58 battery 1 soc: 61%
[site ] DEBUG 2025/10/11 16:00:59 pv 1 power: 314W
[site ] DEBUG 2025/10/11 16:00:59 !! solar production: accumulate set db:1 36230.200kWh meter total (was: Accumulated: 5.200kWh updated: 2025-10-11 16:00:44 +0200 CEST meter: 36230.100kWh)
[site ] DEBUG 2025/10/11 16:00:59 !! solar production: accumulate moved db:1 from 5.200 to 5.300
[site ] DEBUG 2025/10/11 16:00:59 grid currents: [1.8 -0.8 -0.5]A
[site ] DEBUG 2025/10/11 16:00:59 site power: 414W
[lp-1 ] DEBUG 2025/10/11 16:00:59 charger status: B
[lp-1 ] DEBUG 2025/10/11 16:00:59 plan: charge 45m45s between 2025-10-12 15:14:15 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 16:00:59 slot from: 2025-10-12 15:14:15 +0200 CEST to 2025-10-12 15:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:59 slot from: 2025-10-12 15:15:00 +0200 CEST to 2025-10-12 15:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:59 slot from: 2025-10-12 15:30:00 +0200 CEST to 2025-10-12 15:45:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:59 slot from: 2025-10-12 15:45:00 +0200 CEST to 2025-10-12 16:00:00 +0200 CEST cost 0.294
[lp-1 ] DEBUG 2025/10/11 16:00:59 pv charge current: 0A = 0A + -1.8A (414W @ 1p)
What type of operating system or environment does evcc run on?
Linux
External automation
- [x] I have made sure that no external automation like HomeAssistant or Node-RED is active or accessing any of the mentioned devices when this issue occurs.
Nightly build
- [x] I have verified that the issue is reproducible with the latest nightly build
Version
v.0.209.1
Erst will der Planer danach noch weitermachen
[lp-1 ] DEBUG 2025/10/11 15:59:59 plan: charge 45m0s between 2025-10-11 15:59:59 +0200 CEST until 2025-10-11 16:00:00 +0200 CEST (overruns by 44m59s, power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 15:59:59 +0200 CEST to 2025-10-11 16:00:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:00:00 +0200 CEST to 2025-10-11 16:15:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:15:00 +0200 CEST to 2025-10-11 16:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 15:59:59 slot from: 2025-10-11 16:30:00 +0200 CEST to 2025-10-11 16:44:59 +0200 CEST cost 0.294
dann wird gestoppt und geplant soll es am nächsten Tag weitergehen
[lp-1 ] DEBUG 2025/10/11 16:00:14 plan: charge 44m46s between 2025-10-12 15:15:14 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:15:14 +0200 CEST to 2025-10-12 15:30:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:30:00 +0200 CEST to 2025-10-12 15:45:00 +0200 CEST cost 0.294
[lp-1 ] TRACE 2025/10/11 16:00:14 slot from: 2025-10-12 15:45:00 +0200 CEST to 2025-10-12 16:00:00 +0200 CEST cost 0.294
Hast du einen einmaligen oder einen wiederholenden Plan?
[lp-1 ] DEBUG 2025/10/11 15:59:44 plan: charge 45m14s between 2025-10-11 15:59:44 +0200 CEST until 2025-10-11 16:00:00 +0200 CEST (overruns by 44m58s, power: 3680W, avg cost: 0.294)
Erstmal kann der Plan schon nicht funktionieren, wo auch immer der her kommt (Ladeziel 16:00 Uhr wird nicht erreicht).
Dann- und das ist der Fehler- wird der Plan des Folgetages genommen:
[lp-1 ] DEBUG 2025/10/11 16:00:14 plan: charge 44m46s between 2025-10-12 15:15:14 +0200 CEST until 2025-10-12 16:00:00 +0200 CEST (power: 3680W, avg cost: 0.294)
...und da der erst später startet wird abgeschaltet.
@naltatis @Maschga hier stimmt die Repeating-Plan-Selection nicht für den Fall eines Plan Overruns.
@andig In meinem Fall #24291 kann man dasselbe Verhalten im Log beim repeating Plan sehen: Falls das Laden zu einem overrun führt, dann wird exakt mit dem Erreichen der gewünschten Zielladezeit (aber noch nicht erreichtem KWh-Ladeziel) der Plan für den Folgetag im Log aufgeführt und das Laden mit overrun-time abgebrochen.
Früher hat er den errechneten Zeitpunkt auch nicht erreicht, aber halt trotzdem bis 100% zu Ende geladen.
Über wie viel früher reden wir hier? In der Tat war das vor der Möglichkeit mehrere Pläne zu haben (Anfang des Jahres) mal anders. Aber seit dem verhält es sich so wie hier beschrieben. Siehe auch hier: https://github.com/evcc-io/evcc/pull/17834#issuecomment-2780912030
Die spannende Frage ist ja, wieso der Planner sich so verschätzt. Fällt die Ladeleistung so stark gegen Ende ab?
Die spannende Frage ist ja, wieso der Planner sich so verschätzt. Fällt die Ladeleistung so stark gegen Ende ab?
@naltatis Ich denke es gibt zwei Szenarien, warum sich der Planner verschätzen kann:
- Manche Autos ziehen gegen Ende der Ladezeit immer weniger Leistung.
- Lastmanagement im Haus verhindert, dass zeitweise die geplante Leistung in voller Höhe an der Ladestation zur Verfügung steht.
@naltatis Wäre es nicht ein Gedanke, dass man einen Overrun solange weiterlaufen lässt, solange er nicht in einen nachfolgenden Plan hineinläuft?
- ist noch äquivalent zu: Auto wird einfach zu spät angesteckt, als das der Plan funktionieren könnte.
Auch in diesem Fall muss natürlich weiter geladen werden! @naltatis wo hatten wir das schonmal diskutiert und was fehlte uns an der Heuristik?
@naltatis
Die letzten Vollladungen über 3 Stunden Dauer nach Plan die Nachts voll durchgelaufen sind waren Anfang Mai. Dannach halt nicht mehr, weil wir tagsüber meistens mit PV geladen haben und Nachts nur kurzes Nachladen war.
Das konnte ich so mit Grafana Trends nachvollziehen.
Welche Version ich zu der Zeit installiert hatte weiß ich nicht mehr. Aber ich Update meist so einmal im Monat. Höchstens 2.
Nutzen tue ich die Ladepläne seit es sie gibt. Lastmanagement habe ich nicht aktiv, das Auto läd durchgehend mit voller Leistung bis ca. 92% Dann sinkt die Ladeleistung abrupt von 3,5 auf ca. 2kw und dann stetig weiter bis 1,2kw.
Jetzt stoppte es aber schon bei zwischen 70% und 80%. Darum starte ich das Laden jetzt wieder Abends per Schnellladen. Sonst bekomme ich Ärger mit der besseren Hälfte.
Danke für eure stetige Arbeit und euer Bemühen.
Jetzt stoppte es aber schon bei zwischen 70% und 80%. Darum starte ich das Laden jetzt wieder Abends per Schnellladen. Sonst bekomme ich Ärger mit der besseren Hälfte.
Es braucht halt mal ein vollständiges Log das das Problem zeigt. Der Overrun ist eins, bei Dir gibts aber anscheinend noch ein systematisches dazu.
Manche Autos ziehen gegen Ende der Ladezeit immer weniger Leistung.
Dafür hat der Planer eigentlich bereits einen Sicherheitsfaktor eingebaut, der (zumindest grob) kompensieren sollte.
Wäre es nicht ein Gedanke, dass man einen Overrun solange weiterlaufen lässt, solange er nicht in einen nachfolgenden Plan hineinläuft?
Ja da brauchen wir eine Lösung. Prio 1 muss aber sein, dass der Planner das Ziel trifft. Wir können ja nicht den Nutzer empfehlen den Planner immer eine Stunde früher einzustellen. Zumindest wenn genug Zeit da ist und die Parameter stimmen (reale Leistung ~= erwartete Leistung) sollten wir das Ziel treffen.
Was soll der Log denn alles genau beinhalten. Die Kompletten 3-4 Stunden Ladezeit vom anstecken des Autos bis Ende des Ladens ? Im Modus Trace, mit eebus, db, lp, main, seat, semp, site ? Dann würde ich das die Tage mal versuchen zu liefern.
Wir raten. Es fehlt ein Log.
@andig Ich habe in diesem Post #24291 ein Log angehängt ... hilft dir das weiter?
Ich hatte grad nochmal nach dem Ladeplan geschaut als das Auto normal am Laden war.
Hier mal ein Bild von dem Plan. Ich weiß das ihr keine Bilder möchtet. Aber nur so eine Vermutung die womöglich völlig falsch ist: Könnte es sein, dass der Ladeplaner fälschlicherweise aus dem ersten nicht aktiven Plan (Ziel: 80%) die Zielzeit errechnet und es deswegen nicht klappt ?
@andig
Wald, Bäume, … Log?! Discussion #24291 angehängtes Log hier noch einmal als attachment. Ziel war das Laden auf 80% um 07:00:00 Man sieht in diesem Log sehr schön, wie der Ladeplan um 07:00:19 umspringt auf den nächsten Tag und die der Ladevorgang abgebrochen wird.
evcc-20251010-071548-debug.log
@raytech-ux ja, das wissen wir- deshalb ist das hier ja ein bug. Ändert an meinem Kommentar zu https://github.com/evcc-io/evcc/issues/24339#issuecomment-3418673352 aber nix.
@andig Welche Situation genau braucht ihr denn zum Nachvollziehen?
In meinem Log oben, kann man mE die Diskrepanz in der Zeitberechnung schon jetzt nachvollziehen. LP-1 erwartet einen Ladestrom vom 3 x 15A x 230V = 10.350W, bekommt aber nur 9.450W. Aus meinem laienhaften Verständnis errechnet EVCC zwar die Overrun-time periodisch immer wieder neu, allerdings nur auf der Basis der theoretisch zur Verfügung stehenden Leistung (= 10.350W), nicht der reellen Leistung von 9.450W.
[lp-1 ] DEBUG 2025/10/10 05:58:19 plan: charge 1h11m38s between 2025-10-10 05:58:19 +0200 CEST until 2025-10-10 07:00:00 +0200 CEST (overruns by 9m57s, power: 10350W, avg cost: 0.110) [lp-1 ] DEBUG 2025/10/10 05:58:49 charge power: 9450W
Aus meiner Erfahrung verringern manche Autos die Ladeleistung zum Ende der Ladezeit immer weiter, sodass die Diskrepanz zwischen der von EVCC errechneten (theoretisch zur Verfügung stehenden) Ladeleistung und der praktisch erreichten Ladeleistung immer größer wird.
Ich glaube nicht, dass EVCC dieses Problem lösen kann, zu sehr hängt die Verringerung der Ladeleistung zB. von Autotyp, Ladestand, Batteriezustand, Temperatur oder Softwarestand des Autos ab. Wenn man das Problem mit EVCC lösen will geht dies mE nur näherungsweise, z.B. indem
- in der evcc.yaml pro Vehicle ein optionaler Parameter für die effektive maximale Ladeleistung oder ein Dämpfungsfaktor zu maxCurrent angegeben werden kann, evtl auch ein Dämpfungsfaktor für verringerte Leistungsaufnahme zum Ende der Ladezeit.
- Overrun-time: Periodische Neuberechnung dieser Overrun-time nicht auf der Basis des theoretischen maxCurrent wie heute sondern der effektiven Charge Power (die heute schon im Log ausgewiesen wird).
- Im EVCC-Konzept zulassen, dass es eine Overrun-time geben darf, auch wenn periodische oder einmal Ladepläne angelegt sind. Falls die Overrun-time in einen neuen periodischen oder einmal-Ladeplan hineingrätscht, dann würde das Laden abgebrochen werden, sodass der neue Ladeplan greifen kann.
Aus meiner Erfahrung verringern manche Autos die Ladeleistung zum Ende der Ladezeit immer weiter, sodass die Diskrepanz zwischen der von EVCC errechneten (theoretisch zur Verfügung stehenden) Ladeleistung und der praktisch erreichten Ladeleistung immer größer wird.
Genau das beziehen wir bereits im Estimator über das dort integrierte Batteriemodell mit ein. Natürlich nur π * 👍 aber ungefähr sollte das passen, zumal wir da sehr konservativ rechnen.
Das sollte daher eigentlich hier nicht das Grundproblem sein.
Das fällt nur auf die Füße, wenn die von evcc "angenommene" Ladeleistung viel niedriger als die tatsächliche Ladeleistung ist. Das tritt aber eigentlich nur bei grob falsch messenden Boxen/Zählern oder Boxen ganz ohne Zähler auf.
@Maschga ich habe im verlinkten PR einen Test der Repeating Plans erzeugt, der das Problem zeigt. Bei Plan Overrun gilt erst der "nächste" Plan als der gültige, und der hat dann noch keinen Bedarf. Ich sehe zwei Lösungsmöglichkeiten:
- wir merken uns den aktuellen (repeating) plan und prüfen den beim overrun
- wir teilen dem
GetPlanmit, ob es sich aktuell um einen overrun handelt und erhalten damit den letzten statt des nächsten repeating plan zurück
Letzteres erscheint mir sogar einfacher. Hättest Du evtl. Lust, Dir das mal anzuschauen? Das Problem scheint mir beim static Plan übrigens nicht aufzutauchen da dieser immer noch als der "erste" noch gültige Plan auftaucht solange es einen Overrun gibt...
Das sollte daher eigentlich hier nicht das Grundproblem sein.
@premultiply In der Tat. Warum hier überhaupt ein Plan overrun passiert, und das in substantiellem, Umfang, ist unklar.
@andig Ich habe hier eine Log-Datei von gestern: Während das Laden in den letzten Wochen typischerweise - wie in der aktuellen Diskussion besprochen - exakt beim geplanten Ladeende trotz Nichterreichen des Ladeziels abbricht, wurde das Laden gestern bei beiden Ladepunkten korrekt verlängert bis die Autos das gewünschte Ladevolumen hatten. Was war anders: Ich habe den evcc-Server neu gestartet. Sollte dies für dich Erkenntnisse bringen, dann hier im Anhang die entsprechende Log-Datei.
Interessanterweise gibt die Logdatei in den Fällen wo die Ladung über die geplante Zeit hinausgeht, eine Meldung aus, die ich in den früheren Logs nicht sehen konnte: Nov 01 06:32:03 evcc evcc[10771]: [lp-2 ] DEBUG 2025/11/01 06:32:03 plan: continuing for remaining 4m35s
Moin,
@andig
sorry hat etwas gedauert, habe jetzt ein LOG "Loadpoint Debug ab anstecken des Autos)"
Auto war leer. Wurde zuerst gestern Nachmittag automatisch auf 10% Mindeststand geladen. 01:18 Start Ladeplan 01:45 Ladepause ? 02:43 Ladestart 04:00 Ende, Auto nicht voll.
Hängt es möglichweise mit dem Mindestladen beim anstecken zusammen ? Am Tag davor war kein Mindestladen nötig (SoC irgendwas mit 30%) und Nachts hat der Ladeplan korrekt funktioniert.
Christian
evcc ladeplan+mindestladung.log
I took another look at it. Unfortunately, I don't know how to change the planner accordingly. The reason is that the Loadpoint has too many attributes and I've lost track of how the attributes are set and changed.