openWB Forum

Verfasst: **Di Nov 12, 2024 11:26 am**

LenaK hat geschrieben: ↑Di Nov 12, 2024 9:15 am

Basti hat geschrieben: ↑Mo Nov 11, 2024 9:43 pm Im Moment kommt regelmäßig der Fehler im LOG. Ist das ein Bug oder ein Fehler in meinem System ?

[

Code: Alles auswählen

File "/var/www/html/openWB/packages/helpermodules/measurement_logging/process_log.py", line 398, in analyse_percentage
    grid_imported, grid_exported = get_grid_from(entry)
  File "/var/www/html/openWB/packages/helpermodules/measurement_logging/process_log.py", line 390, in get_grid_from
    raise KeyError(f"Kein Zähler für das Netz gefunden in Eintrag '{entry['timestamp']}'.")
KeyError: "Kein Zähler für das Netz gefunden in Eintrag '1731335701'."
2024-11-11 22:35:39,493 - {helpermodules.measurement_logging.process_log:432} - {ERROR:Commands} - Fehler beim Berechnen des Strom-Mix von 1731336001
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/helpermodules/measurement_logging/process_log.py", line 398, in analyse_percentage
    grid_imported, grid_exported = get_grid_from(entry)
  File "/var/www/html/openWB/packages/helpermodules/measurement_logging/process_log.py", line 390, in get_grid_from
    raise KeyError(f"Kein Zähler für das Netz gefunden in Eintrag '{entry['timestamp']}'.")
KeyError: "Kein Zähler für das Netz gefunden in Eintrag '1731336001'."

Bitte mindestens einen Zyklus im Modus Details und das Tageslog unter http://<ip der openWB>/openWB/data/daily_log/<JJJJMMDD>.json posten.

womöglich hat mein Problem auch damit zu tun. Ich hatte den SoC im manuellen SoC Modul auf 1% gesetzt, auch nach dem Anstecken des Smart #1 wird der SoC nicht vom CP aufs EV übernommen.
Kann gern nochmal logs sammeln und teilen wenn das hilft zu bestätigen ob das hier tatsächlich das identische Problem ist.

Screenshot 2024-11-12 121857.png: (193.41 KiB) Noch nie heruntergeladen

Angesteckt, im ersten Regeldurchlauf danach gibts die MAC adresse, im darauf folgenden dann auch den SoC. Sieht für mich nicht unbedingt nach einer großen Verzögerung aus. Die CSS Kommunikation wird ja auch ein paar Sekunden benötigen.

Code: Alles auswählen

ChargepointData(control_parameter=ControlParameter(chargemode='stop', current_plan=None, failed_phase_switches=0, imported_at_plan_start=None, imported_instant_charging=None, limit=None, min_current=6, phases=0, prio=False, required_current=0, required_currents=[0.0, 0.0, 0.0], state=0, submode='stop', timestamp_auto_phase_switch=None, timestamp_charge_start=None, timestamp_perform_phase_switch=None, timestamp_switch_on_off=None), get=Get(charge_state=False, charging_current=0, charging_power=0, charging_voltage=0, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=1), currents=[0, 0, 0], daily_imported=0.0, daily_exported=0.0, error_timestamp=None, evse_current=0, exported=426, fault_str='Kein Fehler.', fault_state=0, imported=1979548, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, serial_number='830892', soc=None, soc_timestamp=None, state_str='Keine Ladung, da der Ladepunkt gesperrt ist.', vehicle_id=None, voltages=[230.62, 227.46, 229.72]), set=Set(charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', costs=0, imported_at_mode_switch=0, imported_at_plugtime=0, imported_since_mode_switch=0, imported_since_plugged=0, range_charged=0, time_charged='00:00', timestamp_start_charging=None, ev=-1, prio=False, rfid=None, serial_number=None, soc_at_start=None, soc_at_end=None, range_at_start=None, range_at_end=None), manual_lock=True, phases_to_use=1, plug_state_prev=False, plug_time=1731327435.320344, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6d0493a0>, ocpp_transaction_id=None), config=Config(configuration={'ip_address': '192.168.178.207', 'duo_num': 0}, ev=18, name='Gartenhaus (pro)', type='openwb_pro', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=27, ocpp_chargebox_id=None))
2024-11-12 12:16:52,180 - {control.data:266} - {INFO:MainThread} - cp27
ChargepointData(control_parameter=ControlParameter(chargemode='stop', current_plan=None, failed_phase_switches=0, imported_at_plan_start=None, imported_instant_charging=None, limit=None, min_current=6, phases=0, prio=False, required_current=0, required_currents=[0.0, 0.0, 0.0], state=0, submode='stop', timestamp_auto_phase_switch=None, timestamp_charge_start=None, timestamp_perform_phase_switch=None, timestamp_switch_on_off=None), get=Get(charge_state=False, charging_current=0, charging_power=0, charging_voltage=0, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=1), currents=[0, 0, 0], daily_imported=0.0, daily_exported=0.0, error_timestamp=None, evse_current=0, exported=426, fault_str='Kein Fehler.', fault_state=0, imported=1979548, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, serial_number='830892', soc=None, soc_timestamp=None, state_str='Keine Ladung, da der Ladepunkt gesperrt ist.', vehicle_id='00:B0:52:00:DB:D1', voltages=[230.71, 228.38, 228.98]), set=Set(charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', costs=0, imported_at_mode_switch=0, imported_at_plugtime=0, imported_since_mode_switch=0, imported_since_plugged=0, range_charged=0, time_charged='00:00', timestamp_start_charging=None, ev=-1, prio=False, rfid=None, serial_number=None, soc_at_start=None, soc_at_end=None, range_at_start=None, range_at_end=None), manual_lock=True, phases_to_use=1, plug_state_prev=True, plug_time=1731327435.320344, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6d050d48>, ocpp_transaction_id=None), config=Config(configuration={'ip_address': '192.168.178.207', 'duo_num': 0}, ev=18, name='Gartenhaus (pro)', type='openwb_pro', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=27, ocpp_chargebox_id=None))
2024-11-12 12:17:02,572 - {control.data:266} - {INFO:MainThread} - cp27
ChargepointData(control_parameter=ControlParameter(chargemode='stop', current_plan=None, failed_phase_switches=0, imported_at_plan_start=None, imported_instant_charging=None, limit=None, min_current=6, phases=0, prio=False, required_current=0, required_currents=[0.0, 0.0, 0.0], state=0, submode='stop', timestamp_auto_phase_switch=None, timestamp_charge_start=None, timestamp_perform_phase_switch=None, timestamp_switch_on_off=None), get=Get(charge_state=False, charging_current=0, charging_power=0, charging_voltage=0, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=1), currents=[0, 0, 0], daily_imported=0.0, daily_exported=0.0, error_timestamp=None, evse_current=0, exported=426, fault_str='Kein Fehler.', fault_state=0, imported=1979548, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, serial_number='830892', soc=52, soc_timestamp=1731410208, state_str='Keine Ladung, da der Ladepunkt gesperrt ist.', vehicle_id='00:B0:52:00:DB:D1', voltages=[231.57, 229.11, 229.87]), set=Set(charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', costs=0, imported_at_mode_switch=0, imported_at_plugtime=0, imported_since_mode_switch=0, imported_since_plugged=0, range_charged=0, time_charged='00:00', timestamp_start_charging=None, ev=-1, prio=False, rfid=None, serial_number=None, soc_at_start=None, soc_at_end=None, range_at_start=None, range_at_end=None), manual_lock=True, phases_to_use=1, plug_state_prev=True, plug_time=1731327435.320344, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6d04a9a0>, ocpp_transaction_id=None), config=Config(configuration={'ip_address': '192.168.178.207', 'duo_num': 0}, ev=18, name='Gartenhaus (pro)', type='openwb_pro', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=27, ocpp_chargebox_id=None))
2024-11-12 12:17:12,239 - {control.data:266} - {INFO:MainThread} - cp27
ChargepointData(control_parameter=ControlParameter(chargemode='stop', current_plan=None, failed_phase_switches=0, imported_at_plan_start=None, imported_instant_charging=None, limit=None, min_current=6, phases=0, prio=False, required_current=0, required_currents=[0.0, 0.0, 0.0], state=0, submode='stop', timestamp_auto_phase_switch=None, timestamp_charge_start=None, timestamp_perform_phase_switch=None, timestamp_switch_on_off=None), get=Get(charge_state=False, charging_current=0, charging_power=0, charging_voltage=0, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=1), currents=[0, 0, 0], daily_imported=0.0, daily_exported=0.0, error_timestamp=None, evse_current=0, exported=426, fault_str='Kein Fehler.', fault_state=0, imported=1979548, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, serial_number='830892', soc=52, soc_timestamp=1731410208, state_str='Keine Ladung, da der Ladepunkt gesperrt ist.', vehicle_id='00:B0:52:00:DB:D1', voltages=[232.08, 227.83, 229.87]), set=Set(charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', costs=0, imported_at_mode_switch=0, imported_at_plugtime=0, imported_since_mode_switch=0, imported_since_plugged=0, range_charged=0, time_charged='00:00', timestamp_start_charging=None, ev=-1, prio=False, rfid=None, serial_number=None, soc_at_start=None, soc_at_end=None, range_at_start=None, range_at_end=None), manual_lock=True, phases_to_use=1, plug_state_prev=True, plug_time=1731327435.320344, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6d072928>, ocpp_transaction_id=None), config=Config(configuration={'ip_address': '192.168.178.207', 'duo_num': 0}, ev=18, name='Gartenhaus (pro)', type='openwb_pro', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=27, ocpp_chargebox_id=None))
2024-11-12 12:17:22,733 - {control.data:266} - {INFO:MainThread} - cp27

Verfasst: **Di Nov 12, 2024 11:48 am**

LenaK hat geschrieben: ↑Mo Nov 11, 2024 1:35 pm [Heartbeat-Meldung im Log]
Ist im Master behoben: https://github.com/openWB/core/pull/2013

Danke.

Verfasst: **Di Nov 12, 2024 11:58 am**

Hallo zusammen,

In letzter Zeit hat mein ID.7 beim Sofortladen mit 11kW öfter mal kleine Aussetzer und geht auf 2-phasiges Laden runter. Manchmal nur mehrmals ganz kurz und manchmal bleibt er dann auch 2-phasig "hängen".

Im Status der WB habe ich das hier entdeckt:

SCR-20241112-krqu.png: (90.32 KiB) Noch nie heruntergeladen

Das bleibt die ganze Zeit so auch wenn er korrekt mit 3 Phasen lädt.

Hat jemand eine Idee dazu?

Danke!
vg
t.

openWB series2 standard+ 22kW mit Phasenumschaltung
SW Version 2024-11-11 19:18:27 +0100 [8d62b8038]

Verfasst: **Di Nov 12, 2024 12:03 pm**

LenaK hat geschrieben: ↑Di Nov 12, 2024 8:48 am Wie ich hier bereits beschrieben habe, liegt das daran, dass dein Auto nicht direkt beim Anstecken den SoC liefert und erfordert eine größere Anpassung, die erst nach dem nächsten Release kommt.

Ist klar, der Link auf, den ich verwiesen hatte ist ja auch schon älter, aber da waren ja auch noch andere Probleme, z.B. das wenn man ansteckt, der SoC übernommen wird und man dann ohne dass sich etwas am PKW SoC ändert abzieht, den SoC in der openWB verstellt, dann wieder ansteckt, dass dann der SoC nie übernommen wird. Erst nach einem Reboot der Standalone wird er dann wieder übernommen. Daher meinte ich, man wahnsinnig wenn man beginnt da zu viel zu testen....

Naja, warten wir mal ab.

Aber das dürfte ja nun nichts damit zu tun haben, dass erst beim Anstecken er auf 0% bleibt (okay, PKW hat zu langsam geantwortet), dann 5 Minuten später auf irgendeinen komischen alten + errechneten Wert wechselt und das Laden einstellt.

Daher, habe ich irgendwie den Eindruck, dass bei der ganzen manuellen SoC Verarbeitung der Wurm drin ist.

Verfasst: **Di Nov 12, 2024 4:23 pm**

@LenaK

hier die Logs:

Tageslog 11.11.2024
https://paste.openwb.de/CFVWDt6cyVh9A9s
Tageslog 12.11.2024
https://paste.openwb.de/Sx79f9OoBLzwsIp

Mainlog:
https://paste.openwb.de/m1LxvjK7lfkKxQj

Internlog:
https://paste.openwb.de/HaeZIkyj64UfQk8

Was neu ist , das die Konfiguration oft verloren geht . Ich musste heute wieder nach einem Update die Struktur anpassen .

Verfasst: **Mi Nov 13, 2024 6:05 am**

2.1.6-RC.1
2024-11-12 10:24:38 +0100 [3756889b7]

Zielladen: täglich 6:00Uhr 80%

Diese Woche 2 x probiert, beide Versuche haben nicht bis zum Ziel SoC geladen.

2024-11-13 04:23:30,693 - {control.chargepoint.chargepoint:84} - {INFO:MainThread} - LP 5: Control-Pilot-Unterbrechung für 10s.

2024-11-13 04:57:20,462 - {control.counter:197} - {DEBUG:MainThread} - Zähler 6: [40.61, 39.2, 40.2]A verbleibende Ströme, 27622.1W verbleibende Leistung
2024-11-13 04:57:20,484 - {control.process:109} - {INFO:MainThread} - LP5: set current 32 A, state CHARGING_ALLOWED

2024-11-13 04:57:31,294 - {control.data:266} - {INFO:MainThread} - counter6
CounterData(config=Config(max_power_errorcase=7000, max_currents=[50, 50, 50], max_total_power=35000), get=Get(powers=[6692, 7041, 6805], currents=[29.6, 30.7, 29.6], voltages=[227.34, 229.3, 229.55], power_factors=[1, 1, 1], frequency=49.93, daily_exported=0.0, daily_imported=13176.0, imported=28198261, exported=55993880, fault_state=0, fault_str='Kein Fehler.', power=20538), set=Set(error_timer=None, reserved_surplus=0, released_surplus=0, raw_power_left=34523.1, raw_currents_left=[50.45, 19.3, 50.129999999999995], surplus_power_left=0))
2024-11-13 04:57:31,334 - {control.algorithm.common:80} - {INFO:MainThread} - LP5: Stromstärke 19.3A
2024-11-13 04:57:31,315 - {control.counter:197} - {DEBUG:MainThread} - Zähler 6: [40.45, 9.3, 40.129999999999995]A verbleibende Ströme, 27623.1W verbleibende Leistung

2024-11-13 04:59:20,722 - {control.process:109} - {INFO:MainThread} - LP5: set current 32 A, state CHARGING_ALLOWED

2024-11-13 04:59:30,706 - {control.data:266} - {INFO:MainThread} - ev1
EvData(set=Set(soc_error_counter=0), charge_template=1, ev_template=1, name='Renault ZOE', tag_id=['0011810505', '7C:BC:84:40:F8:C1'], get=Get(soc=46.0, soc_timestamp=1731470359.981249, force_soc_update=False, range=106.0, fault_state=0, fault_str='Kein Fehler.'))
2024-11-13 04:59:30,708 - {control.data:266} - {INFO:MainThread} - ev2
2024-11-13 04:59:30,740 - {control.process:109} - {INFO:MainThread} - LP5: set current 0 A, state NO_CHARGING_ALLOWED

https://paste.openwb.de/60XrJMdN6WfOY1T

Wenn ich das richtig sehe, dann war am Zähler genug Leistung zur Verfügung, um 04:57 kommen mir die 9.3A ein wenig komisch vor.

Es wurde bei uns am Zähler keine extra Strom verbraucht, den Einbruch um 4:57 sieht man gut, mal eben 30A auf einer Phase ist auch nicht möglich in unserem Haus. Jede Farbe ist ein Phase.

Bild

Verfasst: **Mi Nov 13, 2024 9:10 am**

jub hat geschrieben: ↑Do Nov 07, 2024 5:08 pm Hallo,

ich habe gerade auf den aktuellen RC 1 upgedatet und bekomme keine Werte mehr vom Huawei Zähler und WR (zeigt auch keinen Fehler an).
Reset habe ich gemacht und dann die Geräte hinzugefügt.

mit Änderung der Regelgeschwindigkeit auf "sehr langsam" gabs ausgelesene und angezeigte Werte - ich hätte den Hinweis beim Modul lesen sollen.
Mit der 2.1.5-Patch2 Version und aktuellen Firmwares beim Huawei Wechselrichter/Dongle läuft es auch mit dem normalen Intervall problemlos (das war nicht immer so, wie gesagt die jetzige Kombination aus Firmware und openWB schafft das).

Verfasst: **Do Nov 14, 2024 1:00 pm**

toemk hat geschrieben: ↑Di Nov 12, 2024 11:58 am Hallo zusammen,

In letzter Zeit hat mein ID.7 beim Sofortladen mit 11kW öfter mal kleine Aussetzer und geht auf 2-phasiges Laden runter. Manchmal nur mehrmals ganz kurz und manchmal bleibt er dann auch 2-phasig "hängen".

Im Status der WB habe ich das hier entdeckt: SCR-20241112-krqu.png
Das bleibt die ganze Zeit so auch wenn er korrekt mit 3 Phasen lädt.

Hat jemand eine Idee dazu?

Danke!
vg
t.

openWB series2 standard+ 22kW mit Phasenumschaltung
SW Version 2024-11-11 19:18:27 +0100 [8d62b8038]

Hat dazu keiner eine Idee? Dann wende ich mich mal an den Support....

vg
t.

SCR-20241112-krqu.png: (90.32 KiB) Noch nie heruntergeladen

Verfasst: **Do Nov 14, 2024 6:41 pm**

Frage da ich immernoch auf der 1.9. bin: werden immer 2.x Version inzwischen auf der Hauptseite die anderen (Smarthome) Geräte mit angezeigt?

Verfasst: **Do Nov 14, 2024 7:48 pm**

Ich habe hier den EVU Zähler mit einem Tasmota IR Lesekopf eingebunden und neuerdings bekomme ich im Main-Log:

Code: Alles auswählen

2024-11-14 15:30:05,686 - {helpermodules.utils._thread_handler:33} - {ERROR:MainThread} - device4 konnte nicht innerhalb des Timeouts abgearbeitet werden.
2024-11-14 15:30:05,920 - {modules.common.utils.component_parser:25} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät EWE Zähler Lesekopf
2024-11-14 15:30:05,964 - {modules.common.utils.component_parser:25} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät EWE Zähler Lesekopf
2024-11-14 15:30:34,458 - {helpermodules.utils._thread_handler:33} - {ERROR:MainThread} - device4 konnte nicht innerhalb des Timeouts abgearbeitet werden.
2024-11-14 15:30:34,649 - {modules.common.utils.component_parser:25} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät EWE Zähler Lesekopf
2024-11-14 15:30:34,699 - {modules.common.utils.component_parser:25} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät EWE Zähler Lesekopf

Ich habe dann mal Details aktiviert und da steht dann dieses:

Code: Alles auswählen

2024-11-14 20:09:01,120 - {urllib3.connectionpool:452} - {DEBUG:device4} - http://192.168.77.55:80 "GET /cm?cmnd=status%2010 HTTP/1.1" 200 None
2024-11-14 20:09:01,123 - {modules.common.req:32} - {DEBUG:device4} - Get-Response: {"StatusSNS":{"Time":"2024-11-14T20:09:00","EWE":{"Leistung":4036.92,"Bezug":67277.410,"Einspeisung":52638.918,"Leistung_L1":1364.74,"Leistung_L2":1442.03,"Leistung_L3":1230.15,"NetID":2147483647,"serial":"1ESY1313002719"}}}
2024-11-14 20:09:04,918 - {helpermodules.utils._thread_handler:33} - {ERROR:MainThread} - device4 konnte nicht innerhalb des Timeouts abgearbeitet werden.
2024-11-14 20:09:04,920 - {modules.common.store._api:26} - {DEBUG:device4} - Raw data CounterState(currents=[5.9336521739130434, 6.269695652173913, 5.348478260869566], powers=[1364.74, 1442.03, 1230.15], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], imported=67277.41, exported=52638.918, power=4036.92, frequency=50)

Also um 20:09:01,120 fragt er die Werte ab und bekommt 20:09:01,123 eine Antwort, also gerade mal 3 ms später. Meint dann aber 3 Sekunden später dass das Device nicht abgearbeitet werden könne. Klingt irgendwie komisch...

Hier mal ein gefiltertes Log, mit nur dieser Fehlermeldung. Das wird zur Laufzeit immer schlimmer:

https://paste.openwb.de/91otcYjFjQWQ8S1

openWB Forum

Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1

Re: Rückmeldungen 2.1.6 Release Candidate 1