openWB Forum

Die modulare Wallbox
https://forum.openwb.de/

Wiederkehrende Fehlermeldung im Log

https://forum.openwb.de/viewtopic.php?t=7254

Seite 2 von 3

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Do Jul 27, 2023 11:50 am
von zut
So hatte ich es bei mir auch beobachtet, und das Log scheint mir das auch zu sagen. Es taucht dann halt der Fehler oben auf, und danach ist kurz Pause. Ich werde nochmal messen, sobald es geht.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Fr Jul 28, 2023 11:13 am
von ID4U
ID4U hat geschrieben: ↑Do Jul 27, 2023 11:34 am Ich habe die Mindestzeit jetzt testweise von 40 auf 90 Sekunden heraufgesetzt. Werde das dann mal beobachten.
Damit tritt das Problem immer noch auf, der erst Peak dauert nun entsprechend länger:

1p3p.jpg
1p3p.jpg (20.72 KiB) 847 mal betrachtet

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Fr Jul 28, 2023 1:14 pm
von LenaK
Ohne Log kann ich das Problem leider nicht genauer analysieren. Bitte das Debuglevel auf Details stellen und das Main-Log unter System->Fehlersuche posten, direkt nachdem die zweite Umschaltung statt gefunden hat. Du kannst die Umschaltung ja auch im Sofortladen veranlassen.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Fr Jul 28, 2023 5:43 pm
von zut
Eben mal mit 12A Sofortladen mit manueller Umschaltung probiert, hierbei kein Fehler. Muß den Akku etwas entlehren. Werde dann zunächst das Umschalten mit 16A Sofortladen probieren, dann mit PV-Laden, falls der Fehler nicht auftritt.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Sa Jul 29, 2023 12:04 pm
von zut
Beim manuellen Umschalten bei 16A beim Sofortladen trat der Fehler ebenfalls nicht auf.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Sa Jul 29, 2023 12:20 pm
von zut
Hier der aus meinr Sicht relevante Auszug aus dem Mainlog. Der relevante Punkt ist 14:13:51, wo der zweite Phasigkeitswechsel gestartet wird, obwohl davor schon zweiphasig geladen wurde.
Beginn Umschaltung 14:13:51
Beginn Umschaltung 14:13:51
Doppelumschaltung.png (17.3 KiB) 778 mal betrachtet

Code: Alles auswählen

2023-07-29 14:13:41,128 - {control.data:337} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Mein PV-Laden', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=False, plans={'0': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['11:00', '16:00'], name='Zeitladen-Standard', current=16, limit=Limit(selected='soc', amount=1000, soc=80))}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=40, max_soc=88), scheduled_charging=ScheduledCharging(plans={'0': ScheduledChargingPlan(active=False, frequency=Frequency(selected='once', once='2023-07-24', weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen-Standard', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=50), time='07:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='soc', amount=1000, soc=80))))
2023-07-29 14:13:41,135 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-29 14:13:41,138 - {control.data:337} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=16, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=120), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 6, 0.0], phases=2, prio=True, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=3), charge_template=1, ev_template=2, name='Nulli', tag_id=[], get=Get(soc=81, soc_timestamp='07/29/2023, 14:06:51', force_soc_update=False, range=231.0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:13:41,140 - {control.data:337} - {INFO:MainThread} - ev3
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.STOP: 'stop'>, chargemode=<Chargemode.STOP: 'stop'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=False, range=0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:13:41,142 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:13:41,145 - {control.data:337} - {INFO:MainThread} - et2
EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=10, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=10, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:13:41,150 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=True, charging_power_reserve=200, control_range=[0, 230], feed_in_yield=0, phase_switch_delay=1, phases_to_use=0, rundown_power=1000, rundown_soc=75, switch_off_delay=360, switch_off_soc=0, switch_off_threshold=6000, switch_on_delay=60, switch_on_soc=0, switch_on_threshold=1000), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.429, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-29 14:13:41,152 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-29 14:13:41,154 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-29 14:13:41,155 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=True, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x6e750418>), led=Led(active=False), rfid=Rfid(active=False))
2023-07-29 14:13:41,164 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=5500000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, fault_state=0, fault_str='Kein Fehler.', power=-8404))
2023-07-29 14:13:41,166 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, power=-8404))
2023-07-29 14:13:41,168 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.102', 'current_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_branch': 'Release', 'current_branch_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 16, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1690632811, 'time': '14:13:31', 'grid': 0.359, 'house-power': 0.297, 'charging-all': 5.609, 'pv-all': 8.397, 'cp3-power': 5.609, 'ev2-soc': 81, 'bat-all-power': 2.85, 'bat-all-soc': 86}, 'module_update_completed': True}
2023-07-29 14:13:41,172 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'Kostal Plenticore', 'type': 'kostal_plenticore', 'id': 0, 'configuration': {'ip_address': '192.168.1.103'}}
2023-07-29 14:13:41,174 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'Kostal Plenticore Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-07-29 14:13:41,177 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'Ludwig 14', 'type': 'inverter', 'id': 1, 'configuration': {}}
2023-07-29 14:13:41,180 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'Kostal Plenticore Speicher', 'type': 'bat', 'id': 2, 'configuration': {}}
2023-07-29 14:13:41,183 - {control.data:324} - {INFO:MainThread} - 

2023-07-29 14:13:41,185 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-29 14:13:41,187 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-29 14:13:41,190 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - True, Zähler 0
2023-07-29 14:13:41,192 - {control.counter:169} - {DEBUG:MainThread} - Zähler 0: [23.79, 23.78, 28.380000000000003]A verbleibende Ströme, 32500.29998168945W verbleibende Leistung
2023-07-29 14:13:41,193 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 6A
2023-07-29 14:13:41,196 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-29 14:13:41,202 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 3615.2999816894517W
2023-07-29 14:13:41,203 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 3615.2999816894517W
2023-07-29 14:13:41,204 - {control.algorithm.algorithm:39} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-07-29 14:13:41,208 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [3]
2023-07-29 14:13:41,210 - {control.algorithm.surplus_controlled:42} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - True, Zähler 0
2023-07-29 14:13:41,212 - {control.loadmanagement:82} - {DEBUG:MainThread} - Leistungsüberschreitung auf 3615.2999816894517W korrigieren: [10.0, 10.0, 0.0]
2023-07-29 14:13:41,217 - {control.counter:176} - {DEBUG:MainThread} - Zähler 0: [15.930652213718583, 15.920652213718585, 28.380000000000003]A verbleibende Ströme, 0.0W verbleibender Überschuss
2023-07-29 14:13:41,218 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 13.859347786281417A
2023-07-29 14:13:41,219 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-29 14:13:41,220 - {control.chargelog:52} - {DEBUG:MainThread} - imported_since_mode_switch 331.0600000000559 counter 798258.0
2023-07-29 14:13:41,229 - {control.process:117} - {INFO:MainThread} - LP3: set current 13.86 A, state WAIT_FOR_USING_PHASES
2023-07-29 14:13:41,231 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:13:41,249 - {control.counter:186} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-07-29 14:13:41,481 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-29 14:13:41,606 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:13:45,619 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:13:45,620 - {root:52} - {DEBUG:MainThread} - Don't start multiple instances of smarthome thread.
2023-07-29 14:13:50,631 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-07-29 14:13:50,632 - {root:64} - {INFO:MainThread} - # ***Start*** 
2023-07-29 14:13:50,701 - {modules.common.component_context:51} - {DEBUG:device0} - Update Komponenten ['Kostal Plenticore Zähler', 'Ludwig 14', 'Kostal Plenticore Speicher']
2023-07-29 14:13:50,703 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:13:50,719 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1690632820.705283, power=2857, imported=35053.62795069435, exported=33165.43179125753)
2023-07-29 14:13:50,720 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00278168, power1: 2857, power2: 2857
2023-07-29 14:13:50,720 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 7.94727
2023-07-29 14:13:50,721 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 7.94727 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1690632830.7193458, power=2857, imported=35061.575222264444, exported=33165.43179125753)
2023-07-29 14:13:50,723 - {modules.devices.kostal_plenticore.bat:28} - {DEBUG:device0} - raw bat power 2857
2023-07-29 14:13:50,790 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1690632820.8065295, power=347.3000183105469, imported=1324.6243056332157, exported=154992.4776796913)
2023-07-29 14:13:50,791 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.0027734, power1: 347.3, power2: 357.5
2023-07-29 14:13:50,791 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0.977346
2023-07-29 14:13:50,792 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0.977346 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1690632830.7907658, power=357.5, imported=1325.6016514505827, exported=154992.4776796913)
2023-07-29 14:13:50,792 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[223.19100952148438, 224.75201416015625, 227.66700744628906], powers=[1108.300048828125, 1141.7000732421875, -1899.300048828125], currents=[5.134000301361084, 5.194000244140625, -8.35200023651123], power_factors=[1.0, 1.0, 1.0], imported=1325.6016514505827, exported=154992.4776796913, power=357.5, frequency=49.97300338745117)
2023-07-29 14:13:50,814 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-8404, exported=12170816.0, dc_power=None)
2023-07-29 14:13:50,815 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=35061.575222264444, exported=33165.43179125753, power=2857, soc=87)
2023-07-29 14:13:50,819 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Ludwig 14']
2023-07-29 14:13:50,820 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-8404, exported=12170816.0, dc_power=None)
2023-07-29 14:13:50,822 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Kostal Plenticore Speicher']
2023-07-29 14:13:50,822 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-8404, exported=12170816.0, dc_power=None)
2023-07-29 14:13:50,825 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:13:50,828 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=35061.575222264444, exported=33165.43179125753, power=2857, soc=87)
2023-07-29 14:13:50,881 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Kostal Plenticore Zähler']
2023-07-29 14:13:50,882 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[223.19100952148438, 224.75201416015625, 227.66700744628906], powers=[1108.300048828125, 1141.7000732421875, -1899.300048828125], currents=[5.134000301361084, 5.194000244140625, -8.35200023651123], power_factors=[1.0, 1.0, 1.0], imported=1325.6016514505827, exported=154992.4776796913, power=357.5, frequency=49.97300338745117)
2023-07-29 14:13:51,020 - {control.bat_all:192} - {DEBUG:MainThread} - Erlaubte Entlade-Leistung nutzen 1000W
2023-07-29 14:13:51,021 - {control.bat_all:164} - {INFO:MainThread} - 1000W verbleibende Speicher-Leistung
2023-07-29 14:13:51,022 - {control.counter:138} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [29.81, 29.79, 28.42]A
2023-07-29 14:13:51,023 - {control.counter:161} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 35261.28W
2023-07-29 14:13:51,025 - {control.chargepoint.chargepoint:661} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 2
2023-07-29 14:13:51,028 - {control.chargepoint.chargepoint:853} - {INFO:MainThread} - LP 3, EV: Nulli (EV-Nr.2): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 2, Priorität: True, max. Ist-Strom: 12.98
2023-07-29 14:13:51,032 - {control.data:337} - {INFO:MainThread} - bat2
BatData(get=Get(soc=87, daily_exported=1842.08, daily_imported=3063.83, imported=35061.58, exported=33165.43, fault_state=0, fault_str='Kein Fehler.', power=2857))
2023-07-29 14:13:51,033 - {control.data:307} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=87, daily_exported=1842.08, daily_imported=3063.83, imported=35061.58, exported=33165.43, power=2857), set=Set(charging_power_left=1000, switch_on_soc_reached=True))
2023-07-29 14:13:51,034 - {control.data:308} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=570.01, daily_exported=0, power=5618.78, imported=798272.95, exported=0))
2023-07-29 14:13:51,035 - {control.data:337} - {INFO:MainThread} - cp3
ChargepointData(get=Get(charge_state=True, 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=81), currents=[12.94, 12.98, 0.07], daily_imported=570.01, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=798272.95, phases_in_use=2, plug_state=True, power=5618.78, rfid_timestamp=None, rfid=None, state_str=None, voltages=[216.14, 217.84, 231.69]), set=Set(change_ev_permitted=[True, ''], charging_ev=2, charging_ev_prev=2, current=13.86, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='pv_charging', imported_at_mode_switch=797926.94, imported_at_plugtime=797052.98, imported_since_mode_switch=331.0600000000559, imported_since_plugged=1205.0200000000186, range_charged=2.364714285714685, time_charged='0:07', timestamp_start_charging='07/29/2023, 14:06:51'), manual_lock=False, phases_to_use=3, plug_state_prev=True, plug_time='07/28/2023, 17:25:11', required_power=2760.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6e577aa8>), config=Config(configuration={'mode': 'series', 'ip_address': 'localhost', 'duo_num': 0}, ev=2, name='Interne openWB', type='internal_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=3))
2023-07-29 14:13:51,042 - {control.data:337} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=16, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-07-29 14:13:51,043 - {control.data:337} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[22, 22, 20], max_total_power=30000), get=Get(powers=[1108.3, 1141.7, -1899.3], currents=[5.13, 5.19, -8.35], voltages=[223.19, 224.75, 227.67], power_factors=[1.0, 1.0, 1.0], unbalanced_load=0, frequency=49.97300338745117, daily_exported=4381.65964235525, daily_imported=148.6428133458819, imported=1325.6016514505827, exported=154992.4776796913, fault_state=0, fault_str='Kein Fehler.', power=357.5), set=Set(error_counter=0, reserved_surplus=0, released_surplus=0, raw_power_left=35261.28, raw_currents_left=[29.81, 29.79, 28.42], surplus_power_left=0, state_str=''))
2023-07-29 14:13:51,044 - {control.data:312} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}, {'id': 3, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=285.72000000000025, invalid_home_consumption=0, daily_yield_home_consumption=3449.223170990632, disengageable_smarthome_power=0))
2023-07-29 14:13:51,046 - {control.data:337} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={'1': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['06:00', '07:00'], name='Zeitladen-Standard', current=16, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=100), scheduled_charging=ScheduledCharging(plans={'1': ScheduledChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen-Standard', limit=ScheduledLimit(selected='amount', amount=10000, soc_limit=90, soc_scheduled=80), time='07:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-07-29 14:13:51,052 - {control.data:337} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Mein PV-Laden', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=False, plans={'0': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['11:00', '16:00'], name='Zeitladen-Standard', current=16, limit=Limit(selected='soc', amount=1000, soc=80))}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=40, max_soc=88), scheduled_charging=ScheduledCharging(plans={'0': ScheduledChargingPlan(active=False, frequency=Frequency(selected='once', once='2023-07-24', weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen-Standard', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=50), time='07:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='soc', amount=1000, soc=80))))
2023-07-29 14:13:51,054 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-29 14:13:51,056 - {control.data:337} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=16, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=120), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 6, 0.0], phases=2, prio=True, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=3), charge_template=1, ev_template=2, name='Nulli', tag_id=[], get=Get(soc=81, soc_timestamp='07/29/2023, 14:06:51', force_soc_update=False, range=231.0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:13:51,058 - {control.data:337} - {INFO:MainThread} - ev3
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.STOP: 'stop'>, chargemode=<Chargemode.STOP: 'stop'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=False, range=0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:13:51,061 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:13:51,067 - {control.data:337} - {INFO:MainThread} - et2
EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=10, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=10, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:13:51,070 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=True, charging_power_reserve=200, control_range=[0, 230], feed_in_yield=0, phase_switch_delay=1, phases_to_use=0, rundown_power=1000, rundown_soc=75, switch_off_delay=360, switch_off_soc=0, switch_off_threshold=6000, switch_on_delay=60, switch_on_soc=0, switch_on_threshold=1000), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.429, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-29 14:13:51,072 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-29 14:13:51,073 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-29 14:13:51,074 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=True, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x6e750250>), led=Led(active=False), rfid=Rfid(active=False))
2023-07-29 14:13:51,076 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=5500000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, fault_state=0, fault_str='Kein Fehler.', power=-8404))
2023-07-29 14:13:51,077 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, power=-8404))
2023-07-29 14:13:51,078 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.102', 'current_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_branch': 'Release', 'current_branch_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 16, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1690632821, 'time': '14:13:41', 'grid': 0.347, 'house-power': 0.287, 'charging-all': 5.608, 'pv-all': 8.404, 'cp3-power': 5.608, 'ev2-soc': 81, 'bat-all-power': 2.857, 'bat-all-soc': 87}, 'module_update_completed': True}
2023-07-29 14:13:51,079 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'Kostal Plenticore', 'type': 'kostal_plenticore', 'id': 0, 'configuration': {'ip_address': '192.168.1.103'}}
2023-07-29 14:13:51,090 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'Kostal Plenticore Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-07-29 14:13:51,092 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'Ludwig 14', 'type': 'inverter', 'id': 1, 'configuration': {}}
2023-07-29 14:13:51,097 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'Kostal Plenticore Speicher', 'type': 'bat', 'id': 2, 'configuration': {}}
2023-07-29 14:13:51,100 - {control.data:324} - {INFO:MainThread} - 

2023-07-29 14:13:51,101 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-29 14:13:51,103 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-29 14:13:51,107 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - True, Zähler 0
2023-07-29 14:13:51,109 - {control.counter:169} - {DEBUG:MainThread} - Zähler 0: [23.81, 23.79, 28.42]A verbleibende Ströme, 32501.28W verbleibende Leistung
2023-07-29 14:13:51,113 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 6A
2023-07-29 14:13:51,115 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-29 14:13:51,118 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 3616.279999999999W
2023-07-29 14:13:51,119 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 3616.279999999999W
2023-07-29 14:13:51,121 - {control.algorithm.algorithm:39} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-07-29 14:13:51,124 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [3]
2023-07-29 14:13:51,126 - {control.algorithm.surplus_controlled:42} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - True, Zähler 0
2023-07-29 14:13:51,130 - {control.loadmanagement:82} - {DEBUG:MainThread} - Leistungsüberschreitung auf 3616.279999999999W korrigieren: [10.0, 10.0, 0.0]
2023-07-29 14:13:51,132 - {control.counter:176} - {DEBUG:MainThread} - Zähler 0: [15.948521739130436, 15.928521739130437, 28.42]A verbleibende Ströme, 0.0W verbleibender Überschuss
2023-07-29 14:13:51,134 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 13.861478260869562A
2023-07-29 14:13:51,135 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-29 14:13:51,138 - {control.chargelog:52} - {DEBUG:MainThread} - imported_since_mode_switch 346.0100000000093 counter 798272.95
2023-07-29 14:13:51,141 - {control.chargepoint.chargepoint:574} - {DEBUG:MainThread} - Lp 3: Ladung aktiv halten 120s
2023-07-29 14:13:51,144 - {control.phase_switch:36} - {DEBUG:MainThread} - Thread zur Phasenumschaltung an LP3 gestartet.
2023-07-29 14:13:51,145 - {control.chargepoint.chargepoint:578} - {DEBUG:MainThread} - start phase switch phases_to_use 3control_parameter phases 2
2023-07-29 14:13:51,148 - {control.chargepoint.chargepoint:271} - {INFO:MainThread} - LP 3: Umschaltung von 1 auf 3 Phasen.
2023-07-29 14:13:51,153 - {control.process:117} - {INFO:MainThread} - LP3: set current 0 A, state PERFORMING_PHASE_SWITCH
2023-07-29 14:13:51,162 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:13:51,199 - {control.counter:186} - {INFO:MainThread} - 11040W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-07-29 14:13:51,477 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-29 14:13:51,599 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:13:55,609 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:13:56,149 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:13:58,048 - {modules.common.component_context:24} - {DEBUG:Thread-85320} - Update Komponente ['Ladepunkt 0']
2023-07-29 14:14:00,620 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-07-29 14:14:00,620 - {root:64} - {INFO:MainThread} - # ***Start*** 
2023-07-29 14:14:00,650 - {modules.common.component_context:51} - {DEBUG:device0} - Update Komponenten ['Kostal Plenticore Zähler', 'Ludwig 14', 'Kostal Plenticore Speicher']
2023-07-29 14:14:00,652 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:14:00,668 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1690632830.7193458, power=2857, imported=35061.575222264444, exported=33165.43179125753)
2023-07-29 14:14:00,669 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00276362, power1: 2857, power2: 2861
2023-07-29 14:14:00,669 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 7.90119
2023-07-29 14:14:00,669 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 7.90119 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1690632840.6683838, power=2861, imported=35069.47641663225, exported=33165.43179125753)
2023-07-29 14:14:00,677 - {modules.devices.kostal_plenticore.bat:28} - {DEBUG:device0} - raw bat power 2861
2023-07-29 14:14:00,774 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1690632830.7907658, power=357.5, imported=1325.6016514505827, exported=154992.4776796913)
2023-07-29 14:14:00,775 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00277328, power1: 357.5, power2: -5409
2023-07-29 14:14:00,775 - {modules.common.simcount._calculate:26} - {DEBUG:device0} - power changed sign. Total energy: -7.00461, exported energy: -7.03534
2023-07-29 14:14:00,775 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0.0307329 Wh, exported: 7.03534 Wh, new state: SimCounterState(timestamp=1690632840.7745738, power=-5409.0, imported=1325.6323843490864, exported=154999.5130245783)
2023-07-29 14:14:00,776 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[226.4340057373047, 227.6820068359375, 225.4960174560547], powers=[-1790.9000244140625, -1784.7000732421875, -1840.300048828125], currents=[-7.9210004806518555, -7.865000247955322, -8.13700008392334], power_factors=[1.0, 1.0, 1.0], imported=1325.6323843490864, exported=154999.5130245783, power=-5409.0, frequency=49.970001220703125)
2023-07-29 14:14:00,799 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-8409, exported=12170816.0, dc_power=None)
2023-07-29 14:14:00,800 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=35069.47641663225, exported=33165.43179125753, power=2861, soc=87)
2023-07-29 14:14:00,810 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Ludwig 14']
2023-07-29 14:14:00,811 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-8409, exported=12170816.0, dc_power=None)
2023-07-29 14:14:00,812 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-8409, exported=12170816.0, dc_power=None)
2023-07-29 14:14:00,813 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Kostal Plenticore Speicher']
2023-07-29 14:14:00,814 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:14:00,815 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=35069.47641663225, exported=33165.43179125753, power=2861, soc=87)
2023-07-29 14:14:00,868 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Kostal Plenticore Zähler']
2023-07-29 14:14:00,870 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[226.4340057373047, 227.6820068359375, 225.4960174560547], powers=[-1790.9000244140625, -1784.7000732421875, -1840.300048828125], currents=[-7.9210004806518555, -7.865000247955322, -8.13700008392334], power_factors=[1.0, 1.0, 1.0], imported=1325.6323843490864, exported=154999.5130245783, power=-5409.0, frequency=49.970001220703125)
2023-07-29 14:14:01,004 - {control.bat_all:192} - {DEBUG:MainThread} - Erlaubte Entlade-Leistung nutzen 1000W
2023-07-29 14:14:01,005 - {control.bat_all:164} - {INFO:MainThread} - 1000W verbleibende Speicher-Leistung
2023-07-29 14:14:01,006 - {control.counter:138} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [29.92, 29.87, 28.14]A
2023-07-29 14:14:01,007 - {control.counter:161} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 35409.0W
2023-07-29 14:14:01,009 - {control.chargepoint.chargepoint:661} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 2
2023-07-29 14:14:01,011 - {control.chargepoint.chargepoint:644} - {DEBUG:MainThread} - Phasenzahl Lademodus: 1
2023-07-29 14:14:01,014 - {control.chargepoint.chargepoint:853} - {INFO:MainThread} - LP 3, EV: Nulli (EV-Nr.2): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: True, max. Ist-Strom: 0.0
2023-07-29 14:14:01,017 - {control.data:337} - {INFO:MainThread} - bat2
BatData(get=Get(soc=87, daily_exported=1842.08, daily_imported=3063.83, imported=35069.48, exported=33165.43, fault_state=0, fault_str='Kein Fehler.', power=2861))
2023-07-29 14:14:01,023 - {control.data:307} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=87, daily_exported=1842.08, daily_imported=3063.83, imported=35069.48, exported=33165.43, power=2861), set=Set(charging_power_left=1000, switch_on_soc_reached=True))
2023-07-29 14:14:01,024 - {control.data:308} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=570.01, daily_exported=0, power=0, imported=798279.97, exported=0))
2023-07-29 14:14:01,026 - {control.data:337} - {INFO:MainThread} - cp3
ChargepointData(get=Get(charge_state=False, 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=81), currents=[0.0, 0.0, 0.0], daily_imported=570.01, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=798279.97, phases_in_use=2, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[225.66, 226.83, 225.38]), set=Set(change_ev_permitted=[True, ''], charging_ev=2, charging_ev_prev=2, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='pv_charging', imported_at_mode_switch=797926.94, imported_at_plugtime=797052.98, imported_since_mode_switch=346.0100000000093, imported_since_plugged=1219.969999999972, range_charged=2.4715000000000664, time_charged='0:07', timestamp_start_charging='07/29/2023, 14:06:51'), manual_lock=False, phases_to_use=2, plug_state_prev=True, plug_time='07/28/2023, 17:25:11', required_power=1380.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x6e766da8>), config=Config(configuration={'mode': 'series', 'ip_address': 'localhost', 'duo_num': 0}, ev=2, name='Interne openWB', type='internal_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=3))
2023-07-29 14:14:01,030 - {control.data:337} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=16, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-07-29 14:14:01,032 - {control.data:337} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[22, 22, 20], max_total_power=30000), get=Get(powers=[-1790.9, -1784.7, -1840.3], currents=[-7.92, -7.87, -8.14], voltages=[226.43, 227.68, 225.5], power_factors=[1.0, 1.0, 1.0], unbalanced_load=0, frequency=49.970001220703125, daily_exported=4381.65964235525, daily_imported=148.6428133458819, imported=1325.6323843490864, exported=154999.5130245783, fault_state=0, fault_str='Kein Fehler.', power=-5409.0), set=Set(error_counter=0, reserved_surplus=11040, released_surplus=0, raw_power_left=35409.0, raw_currents_left=[29.92, 29.87, 28.14], surplus_power_left=0, state_str=''))
2023-07-29 14:14:01,033 - {control.data:312} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}, {'id': 3, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=139.0, invalid_home_consumption=0, daily_yield_home_consumption=3449.223170990632, disengageable_smarthome_power=0))
2023-07-29 14:14:01,037 - {control.data:337} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={'1': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['06:00', '07:00'], name='Zeitladen-Standard', current=16, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=100), scheduled_charging=ScheduledCharging(plans={'1': ScheduledChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen-Standard', limit=ScheduledLimit(selected='amount', amount=10000, soc_limit=90, soc_scheduled=80), time='07:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-07-29 14:14:01,039 - {control.data:337} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Mein PV-Laden', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=False, plans={'0': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['11:00', '16:00'], name='Zeitladen-Standard', current=16, limit=Limit(selected='soc', amount=1000, soc=80))}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=40, max_soc=88), scheduled_charging=ScheduledCharging(plans={'0': ScheduledChargingPlan(active=False, frequency=Frequency(selected='once', once='2023-07-24', weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen-Standard', limit=ScheduledLimit(selected='soc', amount=1000, soc_limit=100, soc_scheduled=50), time='07:00')}), instant_charging=InstantCharging(current=16, limit=Limit(selected='soc', amount=1000, soc=80))))
2023-07-29 14:14:01,040 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-29 14:14:01,043 - {control.data:337} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=16, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=120), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 0.0, 0.0], phases=1, prio=True, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch='07/29/2023, 14:13:51', submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=2), charge_template=1, ev_template=2, name='Nulli', tag_id=[], get=Get(soc=81, soc_timestamp='07/29/2023, 14:06:51', force_soc_update=False, range=231.0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:14:01,045 - {control.data:337} - {INFO:MainThread} - ev3
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=32, battery_capacity=82000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=0, required_currents=[0.0, 0.0, 0.0], phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.STOP: 'stop'>, chargemode=<Chargemode.STOP: 'stop'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=False, range=0, fault_state=0, fault_str='Kein Fehler.'))
2023-07-29 14:14:01,047 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=16, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:14:01,056 - {control.data:337} - {INFO:MainThread} - et2
EvTemplateData(name='e-up-Vorlage', max_current_multi_phases=10, max_phases=2, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=14000, min_current=6, max_current_single_phase=10, battery_capacity=32000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-29 14:14:01,058 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=True, charging_power_reserve=200, control_range=[0, 230], feed_in_yield=0, phase_switch_delay=1, phases_to_use=0, rundown_power=1000, rundown_soc=75, switch_off_delay=360, switch_off_soc=0, switch_off_threshold=6000, switch_on_delay=60, switch_on_soc=0, switch_on_threshold=1000), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.429, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-29 14:14:01,059 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-29 14:14:01,063 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-29 14:14:01,071 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=True, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x6e77f7d8>), led=Led(active=False), rfid=Rfid(active=False))
2023-07-29 14:14:01,074 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=5500000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, fault_state=0, fault_str='Kein Fehler.', power=-8409))
2023-07-29 14:14:01,077 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=9474.0, monthly_exported=0, yearly_exported=0, exported=12170816.0, power=-8409))
2023-07-29 14:14:01,079 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.102', 'current_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_branch': 'Release', 'current_branch_commit': '2023-07-17 11:46:58 +0200 [da6031826]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 16, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1690632831, 'time': '14:13:51', 'grid': 0.357, 'house-power': 0.286, 'charging-all': 5.619, 'pv-all': 8.404, 'cp3-power': 5.619, 'ev2-soc': 81, 'bat-all-power': 2.857, 'bat-all-soc': 87}, 'module_update_completed': True}
2023-07-29 14:14:01,085 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'Kostal Plenticore', 'type': 'kostal_plenticore', 'id': 0, 'configuration': {'ip_address': '192.168.1.103'}}
2023-07-29 14:14:01,087 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'Kostal Plenticore Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-07-29 14:14:01,089 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'Ludwig 14', 'type': 'inverter', 'id': 1, 'configuration': {}}
2023-07-29 14:14:01,090 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'Kostal Plenticore Speicher', 'type': 'bat', 'id': 2, 'configuration': {}}
2023-07-29 14:14:01,091 - {control.data:324} - {INFO:MainThread} - 

2023-07-29 14:14:01,093 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-29 14:14:01,094 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-29 14:14:01,100 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - True, Zähler 0
2023-07-29 14:14:01,103 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-29 14:14:01,109 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 6524.0W
2023-07-29 14:14:01,111 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 6524.0W
2023-07-29 14:14:01,113 - {control.algorithm.algorithm:39} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-07-29 14:14:01,117 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [3]
2023-07-29 14:14:01,123 - {control.algorithm.filter_chargepoints:47} - {INFO:MainThread} - LP 3: Keine Zuteilung des Mindeststroms, daher keine weitere Berücksichtigung
2023-07-29 14:14:01,130 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-29 14:14:01,138 - {control.chargepoint.chargepoint:537} - {DEBUG:MainThread} - phase switch running
2023-07-29 14:14:01,140 - {control.process:117} - {INFO:MainThread} - LP3: set current 0 A, state WAIT_FOR_USING_PHASES
2023-07-29 14:14:01,143 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-29 14:14:01,177 - {control.counter:186} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-07-29 14:14:01,455 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-29 14:14:01,549 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:14:05,564 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-29 14:14:05,566 - {root:52} - {DEBUG:MainThread} - Don't start multiple instances of smarthome thread.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Mi Aug 02, 2023 10:34 am
von zut
Kann ich noch etwas sinnvolles beisteuern, um die Ursache der doppelten 1->2-Umschaltung aufzuklären?

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Fr Aug 04, 2023 11:45 am
von zut
Auch in Release 2.1.0 erfolgt die Doppelumschaltung 1->3 beim PV-Laden.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Mo Aug 07, 2023 10:07 am
von LenaK
Sollte hiermit behoben sein: https://github.com/openWB/core/pull/1082 Es steht noch das Review aus, danach kommt es in den Master.

Re: Wiederkehrende Fehlermeldung im Log

Verfasst: Mo Aug 07, 2023 10:43 am
von ID4U
Super, danke!
Alle Zeiten sind UTC
Seite 2 von 3

Powered by phpBB® Forum Software © phpBB Limited

Deutsche Übersetzung durch phpBB.de