Feedback Beta 2

Fragen zur Nutzung, Features, usw..
Nasdero
Beiträge: 366
Registriert: Mo Dez 16, 2019 9:01 pm

Re: Feedback Beta 2

Beitrag von Nasdero »

LenaK hat geschrieben: Di Apr 11, 2023 9:57 am
Zu 2.: Ist die vorgegebene Phasenzahl 1 oder fängt das Auto mit einer Phase an zu laden und schaltet dann weitere hinzu? Die vorgegebene Phasenzahl siehst Du im Status beim Ladepunkt.

Zu3.: Die Modbus-Abfrage dauert mehrere Hundert Millisekunden je Wert. Max 1/3 des Regelintervalls darf für die Abfrage der Werte aufgewendet werden. Stelle mal das Regelintervall auf Langsam.

Zu 4.: Ich habe den Hinweistext angepasst: "Stoppen des Ladevorgangs verhindert, da in der Fahrzeug-Vorlage die Einstellung"
" 'Ladung aktiv halten' aktiviert ist." Bitte dort deaktiveren, wenn die Ladung gestoppt werden darf.

Zu 5.: Kommen die Neustart-Meldungen noch, nachdem Du heute das Update gemacht hast?
zu 2: Wenn der Zoe wieder da ist, schaue ich in den Status, es wurde mit einer Phase angefangen und dann im Prinzip sofort abgeschaltet und dann ist die Meldung "Umschaltung von 1 auf 3 Phasen" (sinngemäß) gekommen.

zu 3: Ich hab es nun auf langsam und werde es beobachten

zu 4: "Ladung aktiv halten" nun auf AUS

zu 5: JA

Code: Alles auswählen

2023-04-11 09:20:08,047 - {helpermodules.subdata:671} - {ERROR:Thread-5} - Fehler im subdata-Modul
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
    raise FaultState.error(__name__+" "+str(response))
modules.common.fault_state.FaultState: ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/var/www/html/openWB/packages/helpermodules/subdata.py", line 635, in process_system_topic
    var["device"+index].add_component(config)
  File "/var/www/html/openWB/packages/modules/devices/solaredge/device.py", line 71, in add_component
    self.synergy_units = int(self.client.read_holding_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 118, in read_holding_registers
    return self.__read_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 100, in __read_registers
    raise FaultState.error(__name__+" "+str(type(e))+" " +
modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
2023-04-11 09:20:08,183 - {helpermodules.subdata:671} - {ERROR:Thread-5} - Fehler im subdata-Modul
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
    raise FaultState.error(__name__+" "+str(response))
modules.common.fault_state.FaultState: ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/var/www/html/openWB/packages/helpermodules/subdata.py", line 635, in process_system_topic
    var["device"+index].add_component(config)
  File "/var/www/html/openWB/packages/modules/devices/solaredge/device.py", line 71, in add_component
    self.synergy_units = int(self.client.read_holding_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 118, in read_holding_registers
    return self.__read_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 100, in __read_registers
    raise FaultState.error(__name__+" "+str(type(e))+" " +
modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
2023-04-11 09:20:08,504 - {modules.devices.solaredge.device:74} - {DEBUG:Thread-5} - Synergy Units: 1
2023-04-11 09:20:08,504 - {modules.devices.solaredge.device:94} - {DEBUG:Thread-5} - SolarEdge Zähler: internal meter id: 1, synergy units: 1
2023-04-11 09:20:20,765 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
ChristianM
Beiträge: 148
Registriert: Di Okt 22, 2019 9:42 am

Re: Feedback Beta 2

Beitrag von ChristianM »

LenaK hat geschrieben: Di Apr 11, 2023 10:39 am Bei der Beta 1.9.299 gab es ein Problem mit der Duo. Bitte nochmal ein Update der Duo auf die Beta durchführen. Dann im ersten Schritt im Modus Sofortladen die Ladung starten.
Updates sind installiert:
1.9.299.1
2023-04-11 08:43:35 +0200 [655d05ee]

Einen Ladevorgang konnte ich noch nicht testen. Obwohl kein Auto angeschlossen ist, wird dies in der OpenWB 2 angezeigt mit "Ladevorgang läuft..."

Code: Alles auswählen

2023-04-11 15:35:40,768 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-11 15:35:40,833 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72293a48>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x722933e8>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72293550>}
2023-04-11 15:35:40,834 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x722938b0>}
2023-04-11 15:35:40,834 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:40,835 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:40,835 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:40,839 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:40,972 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4806], Scale 0
2023-04-11 15:35:40,980 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66502880], Scale 0
2023-04-11 15:35:41,026 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [664, 665, 664], Scale -2
2023-04-11 15:35:41,032 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4879], Scale 0
2023-04-11 15:35:41,033 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [6.640000000000001, 6.65, 6.640000000000001]
2023-04-11 15:35:41,033 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[6.640000000000001, 6.65, 6.640000000000001], power=-4806.0, exported=66502880.0, dc_power=-4879.0)
2023-04-11 15:35:41,141 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1492, -1501, -2559], currents=[-6.48695652173913, -6.526086956521739, -11.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-5552, frequency=49.97)
2023-04-11 15:35:41,142 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:41,297 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,298 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:41,456 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681220131.1860921, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:41,456 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00285284, power1: 0, power2: 0
2023-04-11 15:35:41,457 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-11 15:35:41,457 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681220141.4563038, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:41,458 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:41,461 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:41,462 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:41,465 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:41,467 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,467 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,471 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:41,472 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-4806.0, exported=66502880.0, dc_power=None)
2023-04-11 15:35:41,473 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,474 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-4806.0, exported=66502880.0, dc_power=None)
2023-04-11 15:35:41,477 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,529 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:41,530 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1492, -1501, -2559], currents=[-6.48695652173913, -6.526086956521739, -11.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-5552, frequency=49.97)
2023-04-11 15:35:41,667 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0W
2023-04-11 15:35:41,668 - {control.bat_all:180} - {DEBUG:MainThread} - Keine Ladeleistungs-Reserve für den Speicher vorhalten, da dieser bereits voll geladen ist.
2023-04-11 15:35:41,668 - {control.bat_all:150} - {INFO:MainThread} - 0W verbliebende Speicher-Leistung
2023-04-11 15:35:41,671 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [38.49, 38.53, 43.13]A
2023-04-11 15:35:41,672 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 68552W
2023-04-11 15:35:41,678 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-11 15:35:41,681 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 16A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0.0
2023-04-11 15:35:41,686 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-11 15:35:41,692 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, fault_state=0, fault_str='Kein Fehler.', power=0))
2023-04-11 15:35:41,694 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=True))
2023-04-11 15:35:41,695 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0, daily_exported=0, power=0, imported=7612810.8, exported=0))
2023-04-11 15:35:41,696 - {control.data:334} - {INFO:MainThread} - cp5
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=0), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5246546.88, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[241.8, 242.09, 240.71]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/09/2023, 11:55:21', required_power=11040, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710ef550>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 2}}, power_module={}, ev=0, name='Drinnen', type='external_openwb', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-11 15:35:41,701 - {control.data:334} - {INFO:MainThread} - cp4
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=ConnectedSoc(fault_str='Kein Fehler.', fault_state=0, range_charged=0, range_unit='km', range=0, soc=0, timestamp=None)), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=2366263.92, phases_in_use=0, plug_state=False, power=0, rfid_timestamp=None, rfid=None, state_str='Keine Ladung, da kein Auto angesteckt ist.', voltages=[242.16, 240.31, 242.0]), set=Set(change_ev_permitted=False, charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', 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), manual_lock=False, phases_to_use=0, plug_state_prev=False, plug_time=None, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7107f418>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 1}}, power_module={}, ev=0, name='Draußen', type='external_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=4))
2023-04-11 15:35:41,702 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-11 15:35:41,702 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[-1492, -1501, -2559], currents=[-6.49, -6.53, -11.13], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.97, daily_exported=0, daily_imported=0, imported=2840570, exported=1756330, fault_state=0, fault_str='Kein Fehler.', power=-5552), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=68552, raw_currents_left=[38.49, 38.53, 43.13], surplus_power_left=0, state_str=''))
2023-04-11 15:35:41,703 - {control.data:310} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'bat', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'cp', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=339.0, invalid_home_consumption=0, daily_yield_home_consumption=0))
2023-04-11 15:35:41,703 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-11 15:35:41,704 - {control.data:334} - {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=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=16, required_currents=[16, 16, 16], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), 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-04-11 15:35:41,707 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-11 15:35:41,708 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=20000, phase_switch_delay=7, phases_to_use=0, rundown_power=6000, rundown_soc=60, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=20, unbalanced_load=True), 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.39, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-11 15:35:41,709 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-11 15:35:41,709 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=False))
2023-04-11 15:35:41,709 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=706500, fault_state=0, fault_str='Kein Fehler.', power=-1085))
2023-04-11 15:35:41,710 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=66502880.0, fault_state=0, fault_str='Kein Fehler.', power=-4806.0))
2023-04-11 15:35:41,710 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=0, monthly_exported=0, yearly_exported=0, exported=67209368.0, power=-5800.0))
2023-04-11 15:35:41,711 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.0.186', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681220131, 'time': '15:35:31', 'grid': -5.451, 'house-power': 0.349, 'charging-all': 0.0, 'pv-all': 5.696, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-04-11 15:35:41,714 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-11 15:35:41,714 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-11 15:35:41,715 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-11 15:35:41,715 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-11 15:35:41,716 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-11 15:35:41,716 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-11 15:35:41,716 - {control.data:321} - {INFO:MainThread} - 

2023-04-11 15:35:41,717 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-11 15:35:41,718 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-11 15:35:41,720 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-11 15:35:41,721 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [32.49, 32.53, 37.13]A verbleibende Ströme, 64412W verbleibende Leistung
2023-04-11 15:35:41,722 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 6A
2023-04-11 15:35:41,726 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-11 15:35:41,732 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-11 15:35:41,732 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-11 15:35:41,736 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 1297.0W
2023-04-11 15:35:41,741 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 1297.0W
2023-04-11 15:35:41,743 - {control.algorithm.algorithm:41} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-04-11 15:35:41,749 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-11 15:35:41,752 - {control.process:115} - {INFO:MainThread} - LP5: set current 6 A, state CHARGING_ALLOWED
2023-04-11 15:35:41,756 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,759 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,782 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-11 15:35:42,016 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-11 15:35:50,054 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-11 15:35:50,055 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-11 15:35:50,113 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72293a48>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x722933e8>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72293550>}
2023-04-11 15:35:50,115 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x722938b0>}
2023-04-11 15:35:50,115 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:50,116 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,119 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,122 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:50,271 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [5429], Scale 0
2023-04-11 15:35:50,360 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66502896], Scale 0
2023-04-11 15:35:50,408 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [750, 750, 747], Scale -2
2023-04-11 15:35:50,417 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1680, -1685, -2789], currents=[-7.304347826086956, -7.326086956521739, -12.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-6051, frequency=49.98)
2023-04-11 15:35:50,419 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:50,492 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [5602], Scale 0
2023-04-11 15:35:50,493 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [7.5, 7.5, 7.47]
2023-04-11 15:35:50,493 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[7.5, 7.5, 7.47], power=-5429.0, exported=66502896.0, dc_power=-5602.0)
2023-04-11 15:35:50,574 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,575 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:50,733 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681220141.4563038, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:50,733 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00257695, power1: 0, power2: 0
2023-04-11 15:35:50,734 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-11 15:35:50,734 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681220150.7333384, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:50,735 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:50,737 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:50,740 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:50,748 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:50,749 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,749 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,755 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:50,757 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-5429.0, exported=66502896.0, dc_power=None)
2023-04-11 15:35:50,758 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-5429.0, exported=66502896.0, dc_power=None)
2023-04-11 15:35:50,759 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,762 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,806 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:50,807 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1680, -1685, -2789], currents=[-7.304347826086956, -7.326086956521739, -12.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-6051, frequency=49.98)
2023-04-11 15:35:50,942 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0W
2023-04-11 15:35:50,943 - {control.bat_all:180} - {DEBUG:MainThread} - Keine Ladeleistungs-Reserve für den Speicher vorhalten, da dieser bereits voll geladen ist.
2023-04-11 15:35:50,944 - {control.bat_all:150} - {INFO:MainThread} - 0W verbliebende Speicher-Leistung
2023-04-11 15:35:50,945 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [39.3, 39.33, 44.13]A
2023-04-11 15:35:50,947 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 69051W
2023-04-11 15:35:50,948 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-11 15:35:50,954 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 16A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0.0
2023-04-11 15:35:50,958 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-11 15:35:50,962 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, fault_state=0, fault_str='Kein Fehler.', power=0))
2023-04-11 15:35:50,963 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=True))
2023-04-11 15:35:50,965 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0, daily_exported=0, power=0, imported=7612810.8, exported=0))
2023-04-11 15:35:50,966 - {control.data:334} - {INFO:MainThread} - cp5
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=0), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5246546.88, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[241.96, 242.27, 240.88]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/09/2023, 11:55:21', required_power=11040, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710d0dd8>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 2}}, power_module={}, ev=0, name='Drinnen', type='external_openwb', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-11 15:35:50,968 - {control.data:334} - {INFO:MainThread} - cp4
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=ConnectedSoc(fault_str='Kein Fehler.', fault_state=0, range_charged=0, range_unit='km', range=0, soc=0, timestamp=None)), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=2366263.92, phases_in_use=0, plug_state=False, power=0, rfid_timestamp=None, rfid=None, state_str='Keine Ladung, da kein Auto angesteckt ist.', voltages=[242.29, 240.48, 242.17]), set=Set(change_ev_permitted=False, charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', 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), manual_lock=False, phases_to_use=0, plug_state_prev=False, plug_time=None, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7107f0b8>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 1}}, power_module={}, ev=0, name='Draußen', type='external_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=4))
2023-04-11 15:35:50,968 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-11 15:35:50,969 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[-1680, -1685, -2789], currents=[-7.3, -7.33, -12.13], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.98, daily_exported=0, daily_imported=0, imported=2840570, exported=1756330, fault_state=0, fault_str='Kein Fehler.', power=-6051), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=69051, raw_currents_left=[39.3, 39.33, 44.13], surplus_power_left=0, state_str=''))
2023-04-11 15:35:50,969 - {control.data:310} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'bat', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'cp', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=537.0, invalid_home_consumption=0, daily_yield_home_consumption=0))
2023-04-11 15:35:50,969 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-11 15:35:50,970 - {control.data:334} - {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=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=16, required_currents=[16, 16, 16], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), 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-04-11 15:35:50,972 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-11 15:35:50,973 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=20000, phase_switch_delay=7, phases_to_use=0, rundown_power=6000, rundown_soc=60, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=20, unbalanced_load=True), 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.39, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-11 15:35:50,973 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-11 15:35:50,973 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=False))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=706500, fault_state=0, fault_str='Kein Fehler.', power=-1159))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=66502896.0, fault_state=0, fault_str='Kein Fehler.', power=-5429.0))
2023-04-11 15:35:50,974 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=0, monthly_exported=0, yearly_exported=0, exported=67209380.0, power=-5891.0))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.0.186', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681220141, 'time': '15:35:41', 'grid': -5.552, 'house-power': 0.339, 'charging-all': 0.0, 'pv-all': 5.8, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-04-11 15:35:50,976 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-11 15:35:50,976 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-11 15:35:50,978 - {control.data:321} - {INFO:MainThread} - 

2023-04-11 15:35:50,978 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-11 15:35:50,979 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-11 15:35:50,981 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-11 15:35:50,982 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [33.3, 33.33, 38.13]A verbleibende Ströme, 64911W verbleibende Leistung
2023-04-11 15:35:50,982 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 6A
2023-04-11 15:35:50,985 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-11 15:35:50,990 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-11 15:35:50,991 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-11 15:35:50,992 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 1796.0W
2023-04-11 15:35:50,992 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 1796.0W
2023-04-11 15:35:50,992 - {control.algorithm.algorithm:41} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-04-11 15:35:50,995 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-11 15:35:50,998 - {control.process:115} - {INFO:MainThread} - LP5: set current 6 A, state CHARGING_ALLOWED
2023-04-11 15:35:51,008 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:51,011 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:51,049 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-11 15:35:51,266 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-11 15:36:00,317 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-11 15:36:00,318 - {root:61} - {INFO:MainThread} - # ***Start*** 
Nasdero
Beiträge: 366
Registriert: Mo Dez 16, 2019 9:01 pm

Re: Feedback Beta 2

Beitrag von Nasdero »

LenaK hat geschrieben: Di Apr 11, 2023 9:57 am Zu3.: Die Modbus-Abfrage dauert mehrere Hundert Millisekunden je Wert. Max 1/3 des Regelintervalls darf für die Abfrage der Werte aufgewendet werden. Stelle mal das Regelintervall auf Langsam.
Kommt leider wieder, in der 1.9 stand der Regler auf "Normal", da ist mir so etwas nicht aufgefallen, was aber nicht heißt es gab den Fehler nicht:

Code: Alles auswählen

22023-04-11 15:28:36,676 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:28:36,677 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,679 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,680 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,680 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,691 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:39:30,928 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1073.1999999999998W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:40:56,797 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:40:56,797 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,799 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,799 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,800 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,809 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:42:14,101 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1729.5W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:43:12,215 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1336.1999999999998W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:55:56,736 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:55:56,737 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,743 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,921 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 16:01:36,921 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,924 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,925 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,925 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,933 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,879 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 16:01:56,879 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,881 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,882 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,882 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,890 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
Nasdero
Beiträge: 366
Registriert: Mo Dez 16, 2019 9:01 pm

Re: Feedback Beta 2

Beitrag von Nasdero »

LenaK hat geschrieben: Di Apr 11, 2023 9:57 am Zu 2.: Ist die vorgegebene Phasenzahl 1 oder fängt das Auto mit einer Phase an zu laden und schaltet dann weitere hinzu? Die vorgegebene Phasenzahl siehst Du im Status beim Ladepunkt.
So ich hab das mit dem ZOE probiert heute früh.

ZOE war angeschlossen, ich habe Sofortladen als Lademodus ausgewählt (eingestellt ist Sofortladen max. Anzahl Phasen)

Im Status steht dann Vorgabe 3, Aktuell 1, dann wird der Stecker am Ladepunkt grün, kurz passiert etwas, die Ladeleistung bewegt sich und der Stecker wird wieder gelb.

Dann kommt Vorgabe 3 und Aktuell 3, stecker wird wieder grün und der "Ladevorgang läuft" wird angezeigt, der ZOE läd nun aber nicht, vermute er hat kurz 1p bekommen, nun müsste ich ihn abstecken und wieder anstecken damit er läd.

So habe ich das wahrgenommen.
sofortladen.png

Code: Alles auswählen

2023-04-12 09:27:10,712 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-12 09:30:00,465 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/1/get/daily_exported, Payload -113.2 liegt in keinem der angegebenen Wertebereiche.
2023-04-12 09:33:30,703 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x7f754a8aec10>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x7f754a8ae070>, 'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8d6790>, 'component4': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8c65b0>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8ad7c0>}
2023-04-12 09:33:30,703 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:30,704 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-12 09:33:30,706 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-04-12 09:33:30,734 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.1.101:80 "GET /connect.php HTTP/1.1" 200 327
2023-04-12 09:33:30,734 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: {"date":"2023:04:12-07:33:30","timestamp":1681284810,"powers":[0,0,0],"power_all":0,"currents":[0,0,0],"imported":1463084,"exported":2049,"plug_state":true,"charge_state":false,"phases_actual":0,"phases_target":3,"phases_in_use":3,"offered_current":10,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"479411"}
2023-04-12 09:33:30,734 - {modules.common.store._api:26} - {DEBUG:cp5} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=1463084, exported=2049, power=0, phases_in_use=3, charge_state=False, plug_state=True, rfid=None)
2023-04-12 09:33:30,808 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-388, -362, -105, 79], Scale 0
2023-04-12 09:33:30,816 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23, 13, 0], Scale -1
2023-04-12 09:33:31,021 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23644, 23889, 23840, -24329, -24371, -24201, -24414], Scale -2
2023-04-12 09:33:31,186 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [5011], Scale -2
2023-04-12 09:33:31,269 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [6000, 3436, -7816], Scale -2
2023-04-12 09:33:31,469 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [44042628, 19682968, 21223582, 17869924, 20122861, 14785300, 11644693, 8426712], Scale 0
2023-04-12 09:33:31,469 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[236.44, 238.89000000000001, 238.4], powers=[362.0, 105.0, -79.0], currents=[2.3000000000000003, 1.3, 0.0], power_factors=[0.6, 0.3436, -0.7816], imported=20122861.0, exported=44042628.0, power=388.0, frequency=50.11)
2023-04-12 09:33:31,470 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-04-12 09:33:31,499 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681284791.2670112, power=0.0, imported=27086.934899080934, exported=28306.228172097795)
2023-04-12 09:33:31,499 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00562008, power1: 0, power2: 0
2023-04-12 09:33:31,499 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-12 09:33:31,499 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681284811.499303, power=0.0, imported=27086.934899080934, exported=28306.228172097795)
2023-04-12 09:33:31,499 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=27086.934899080934, exported=28306.228172097795, power=0.0, soc=9.498736381530762)
2023-04-12 09:33:31,503 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-12 09:33:31,550 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [16000], Scale -2
2023-04-12 09:33:31,609 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [31519490], Scale 0
2023-04-12 09:33:31,660 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [10312, 65535, 65535], Scale -4
2023-04-12 09:33:31,709 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [16243], Scale -2
2023-04-12 09:33:31,709 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [1.0312000000000001, 0, 0]
2023-04-12 09:33:31,709 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[1.0312000000000001, 0, 0], power=-160.0, exported=31519490.0, dc_power=-162.43)
2023-04-12 09:33:31,711 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-12 09:33:31,855 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [14662], Scale -2
2023-04-12 09:33:31,934 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23556804], Scale 0
2023-04-12 09:33:31,988 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [77, 65535, 65535], Scale -2
2023-04-12 09:33:32,064 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [14814], Scale -2
2023-04-12 09:33:32,065 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [0.77, 0, 0]
2023-04-12 09:33:32,065 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.77, 0, 0], power=-146.62, exported=23556804.0, dc_power=-148.14000000000001)
2023-04-12 09:33:32,066 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-12 09:33:32,078 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [12800], Scale -2
2023-04-12 09:33:32,084 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [35836820], Scale 0
2023-04-12 09:33:32,097 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [9375, 65535, 65535], Scale -4
2023-04-12 09:33:32,102 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [12994], Scale -2
2023-04-12 09:33:32,102 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [0.9375, 0, 0]
2023-04-12 09:33:32,102 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.9375, 0, 0], power=-128.0, exported=35836820.0, dc_power=-129.94)
2023-04-12 09:33:32,106 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-04-12 09:33:32,106 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=27086.934899080934, exported=28306.228172097795, power=0.0, soc=9.498736381530762)
2023-04-12 09:33:32,113 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-12 09:33:32,113 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-128.0, exported=35835600.7, dc_power=None)
2023-04-12 09:33:32,113 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-128.0, exported=35835600.7, dc_power=None)
2023-04-12 09:33:32,113 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-12 09:33:32,113 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-160.0, exported=31519490.0, dc_power=None)
2023-04-12 09:33:32,114 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-160.0, exported=31519490.0, dc_power=None)
2023-04-12 09:33:32,114 - {modules.common.component_context:24} - {DEBUG:component4} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-12 09:33:32,115 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:32,116 - {modules.common.store._api:26} - {DEBUG:component4} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-146.62, exported=23556804.0, dc_power=None)
2023-04-12 09:33:32,118 - {modules.common.store._api:30} - {INFO:cp5} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=1463084, exported=2049, power=0, phases_in_use=3, charge_state=False, plug_state=True, rfid=None)
2023-04-12 09:33:32,118 - {modules.common.store._api:30} - {INFO:component4} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-146.62, exported=23556804.0, dc_power=None)
2023-04-12 09:33:32,125 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-04-12 09:33:32,125 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[236.44, 238.89000000000001, 238.4], powers=[362.0, 105.0, -79.0], currents=[2.3000000000000003, 1.3, 0.0], power_factors=[0.6, 0.3436, -0.7816], imported=20122861.0, exported=44042628.0, power=388.0, frequency=50.11)
2023-04-12 09:33:32,136 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0.0W
2023-04-12 09:33:32,136 - {control.bat_all:177} - {DEBUG:MainThread} - Ladeleistungs-Reserve (1000W) subtrahieren: -1000.0
2023-04-12 09:33:32,136 - {control.bat_all:150} - {INFO:MainThread} - -1000.0W verbliebende Speicher-Leistung
2023-04-12 09:33:32,136 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [29.7, 30.7, 32.0]A
2023-04-12 09:33:32,136 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 23612.0W
2023-04-12 09:33:32,136 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-12 09:33:32,137 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Renault ZOE (EV-Nr.1): Theoretisch benötigter Strom 10A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - bat2
BatData(get=Get(soc=9, daily_exported=3269.2, daily_imported=0.0, imported=27086.93, exported=28306.23, fault_state=0, fault_str='Kein Fehler.', power=0.0))
2023-04-12 09:33:32,137 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=9, daily_exported=3269.2, daily_imported=0.0, imported=27086.93, exported=28306.23, power=0.0), set=Set(charging_power_left=-1000.0, switch_on_soc_reached=True))
2023-04-12 09:33:32,137 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=5, daily_exported=0, power=0, imported=1463084, exported=2049))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - cp5
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=67.0), currents=[0, 0, 0], daily_imported=5, daily_exported=0, exported=2049, fault_str='Kein Fehler.', fault_state=0, imported=1463084, phases_in_use=3, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[0.0, 0.0, 0.0]), set=Set(change_ev_permitted=[True, ''], charging_ev=1, charging_ev_prev=1, current=10, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='instant_charging', imported_at_mode_switch=1463079, imported_at_plugtime=1463079, imported_since_mode_switch=5, imported_since_plugged=5, range_charged=0.029411764705882353, time_charged='0:03', timestamp_start_charging='04/12/2023, 09:28:31'), manual_lock=False, phases_to_use=3, plug_state_prev=True, plug_time='04/12/2023, 09:11:33', required_power=6900, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7f754a8d68e0>), config=Config(connection_module={'type': 'openwb_pro', 'name': 'openWB Pro', 'configuration': {'ip_address': '192.168.1.101'}}, power_module={}, ev=1, name='Standard-Ladepunkt', type='openwb_pro', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=24000), get=Get(powers=[362.0, 105.0, -79.0], currents=[2.3, 1.3, 0.0], voltages=[236.44, 238.89, 238.4], power_factors=[0.6, 0.34, -0.78], unbalanced_load=0, frequency=50.11, daily_exported=44.0, daily_imported=2119.0, imported=20122861.0, exported=44042628.0, fault_state=0, fault_str='Kein Fehler.', power=388.0), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=23612.0, raw_currents_left=[29.7, 30.7, 32.0], surplus_power_left=0, state_str=''))
2023-04-12 09:33:32,137 - {control.data:310} - {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': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=822.62, invalid_home_consumption=0, daily_yield_home_consumption=5518.0))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Renault ZOE', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ct2
ChargeTemplateData(name='Opel Corsa', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='stop', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=32, max_phases=1, phase_switch_pause=2, prevent_phase_switch=True, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=120), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=10, 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='pv_charging', chargemode='pv_charging', 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-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev1
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Renault ZOE', max_current_multi_phases=32, max_phases=3, phase_switch_pause=10, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=60), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=10, required_currents=[10, 10, 10], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), charge_template=1, ev_template=1, name='Renault ZOE', tag_id=['7C:BC:84:40:F8:C1'], get=Get(soc=67.0, soc_timestamp='04/12/2023, 09:31:40', force_soc_update=False, range=151.0, fault_state=0, fault_str='Kein Fehler.'))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Opel Corsa', max_current_multi_phases=10, max_phases=1, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=True, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=42, nominal_difference=0.5, 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=2, ev_template=2, name='Opel Corsa', tag_id=['00:18:87:02:13:8C'], get=Get(soc=100, soc_timestamp='04/12/2023, 09:31:40', force_soc_update=False, range=296, fault_state=0, fault_str='Kein Fehler.'))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=32, max_phases=1, phase_switch_pause=2, prevent_phase_switch=True, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=120)
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et1
EvTemplateData(name='Renault ZOE', max_current_multi_phases=32, max_phases=3, phase_switch_pause=10, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=60)
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et2
EvTemplateData(name='Opel Corsa', max_current_multi_phases=10, max_phases=1, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=42, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-12 09:33:32,138 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=1000, control_range=[0, 230], feed_in_yield=0, phase_switch_delay=13, phases_to_use=1, rundown_power=2500, rundown_soc=100, switch_off_delay=60, switch_off_soc=0, switch_off_threshold=200, switch_on_delay=30, switch_on_soc=0, switch_on_threshold=2000), scheduled_charging=ScheduledCharging(phases_to_use=3), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=20, 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.34, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-12 09:33:32,138 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-12 09:33:32,138 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=True))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=4600), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=168.0, monthly_exported=0, yearly_exported=0, exported=31519490.0, fault_state=0, fault_str='Kein Fehler.', power=-160.0))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv4
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=124.0, monthly_exported=0, yearly_exported=0, exported=23556804.0, fault_state=0, fault_str='Kein Fehler.', power=-146.62))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=35835600.7, fault_state=0, fault_str='Kein Fehler.', power=-128.0))
2023-04-12 09:33:32,138 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=292.0, monthly_exported=0, yearly_exported=0, exported=90911890.7, power=-417.27))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.100', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'boot_done': True, 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681284792, 'time': '09:33:12', 'grid': 0.381, 'house-power': 0.798, 'charging-all': 0.0, 'pv-all': 0.364, 'cp5-power': 0.0, 'ev1-soc': 67.0, 'ev2-soc': 100, 'bat-all-power': 0.0, 'bat-all-soc': 9}, 'module_update_completed': True}
2023-04-12 09:33:32,138 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.1.99'}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter 2', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 5}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component4
{'name': 'SolarEdge Wechselrichter 3', 'type': 'inverter', 'id': 4, 'configuration': {'modbus_id': 8}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'SolarEdge Wechselrichter 1', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2023-04-12 09:33:32,138 - {control.data:321} - {INFO:MainThread} - 

2023-04-12 09:33:32,138 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-12 09:33:32,138 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-12 09:33:32,139 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-12 09:33:32,139 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [19.7, 20.7, 22.0]A verbleibende Ströme, 16712.0W verbleibende Leistung
2023-04-12 09:33:32,139 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 10A
2023-04-12 09:33:32,139 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-12 09:33:32,139 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-12 09:33:32,139 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-12 09:33:32,139 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-04-12 09:33:32,139 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-04-12 09:33:32,139 - {control.algorithm.algorithm:46} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-04-12 09:33:32,140 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-12 09:33:32,140 - {control.process:115} - {INFO:MainThread} - LP5: set current 10 A, state CHARGING_ALLOWED
2023-04-12 09:33:32,143 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:32,143 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-12 09:33:32,182 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.1.101:80 "POST /connect.php HTTP/1.1" 200 20
2023-04-12 09:33:32,183 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: OK Value:10 accepted
2023-04-12 09:33:32,183 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-12 09:33:32,222 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-12 09:33:40,234 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 09:33:40,235 - {root:61} - {INFO:MainThread} - # ***Start*** 
vuffiraa
Beiträge: 250
Registriert: Mo Apr 19, 2021 11:26 am

Re: Feedback Beta 2

Beitrag von vuffiraa »

Hallo,

mit 2023-04-11 08:43:35 +0200 [655d05ee3] scheint jetzt bei mir die Umschaltung zwischen 1 und 3 Phasen grundsätzlich zu klappen. Das konnte ich über Ostern mehrmals beobachten. Ein interessantes Verhalten habe ich dann aber doch noch gefunden.

Nach einer vollständigen Ladung, bei Beendung der Ladung wurden 3 Phasen genutzt, wollte die nächste Ladung nicht 1-phasig starten. Ich habe das dann mal ausgesessen und als genug PV-Leistung für 3-phasiges Laden vorhanden war, startete der Ladevorgang. Die Phasenumschaltung war die ganze Zeit auf Automatik. Nach Start der Ladung wurde auch wieder je nach PV-Leistung zwischen 1- und 3-phasig gewechselt.

Hier noch mal der komplette Ablauf:
- OWB Lademodus PV
- Auto lädt 3-phasig
- Ladung wird durch Auto beendet, da voll
- OWB Lademodus auf Stop geändert
- Auto abgesteckt
- gefahren :D
- Auto angesteckt
- OWB Lademodus wieder auf PV gestellt
- auf Sonne gewartet

Ich hätte erwartet, dass die Ladung wieder 1-phasig startet. Im Status wurde die Phasenvorgabe auch mit 1 angezeigt:
Untitled.png
Hier ein Logauszug:

Code: Alles auswählen

2023-04-12 09:15:00,720 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 09:15:00,721 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-12 09:15:00,762 - {modules.devices.fronius.device:59} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.fronius.counter_sm.FroniusSmCounter object at 0x722beb50>, 'component1': <modules.devices.fronius.inverter.FroniusInverter object at 0x7226eac0>}
2023-04-12 09:15:00,763 - {modules.common.component_context:24} - {DEBUG:cp2} - Update Komponente ['Ladepunkt']
2023-04-12 09:15:00,764 - {modules.common.component_context:51} - {DEBUG:device0} - Update Komponenten ['Fronius SM Zähler', 'Fronius Wechselrichter']
2023-04-12 09:15:00,779 - {urllib3.connectionpool:227} - {DEBUG:device0} - Starting new HTTP connection (1): 192.168.2.49:80
2023-04-12 09:15:00,816 - {urllib3.connectionpool:452} - {DEBUG:device0} - http://192.168.2.49:80 "GET /solar_api/v1/GetMeterRealtimeData.cgi?Scope=Device&DeviceId=2 HTTP/1.1" 200 2237
2023-04-12 09:15:00,819 - {modules.common.req:11} - {DEBUG:device0} - Get-Response: {
   "Body" : {
      "Data" : {
         "Current_AC_Phase_1" : 0.92300000000000004,
         "Current_AC_Phase_2" : 0.192,
         "Current_AC_Phase_3" : 1.016,
         "Details" : {
            "Manufacturer" : "Fronius",
            "Model" : "Smart Meter 63A",
            "Serial" : "xxx"
         },
         "Enable" : 1,
         "EnergyReactive_VArAC_Sum_Consumed" : 6287970,
         "EnergyReactive_VArAC_Sum_Produced" : 82939410,
         "EnergyReal_WAC_Minus_Absolute" : 19032654,
         "EnergyReal_WAC_Plus_Absolute" : 0,
         "EnergyReal_WAC_Sum_Consumed" : 19032654,
         "EnergyReal_WAC_Sum_Produced" : 0,
         "Frequency_Phase_Average" : 50,
         "Meter_Location_Current" : 1,
         "PowerApparent_S_Phase_1" : 218.47409999999999,
         "PowerApparent_S_Phase_2" : 45.388800000000003,
         "PowerApparent_S_Phase_3" : 239.77600000000001,
         "PowerApparent_S_Sum" : 361,
         "PowerFactor_Phase_1" : 0.71999999999999997,
         "PowerFactor_Phase_2" : 0.45000000000000001,
         "PowerFactor_Phase_3" : 0.81999999999999995,
         "PowerFactor_Sum" : 0.73999999999999999,
         "PowerReactive_Q_Phase_1" : -118.43000000000001,
         "PowerReactive_Q_Phase_2" : -29.48,
         "PowerReactive_Q_Phase_3" : -92.439999999999998,
         "PowerReactive_Q_Sum" : -240.34999999999999,
         "PowerReal_P_Phase_1" : -125.05,
         "PowerReal_P_Phase_2" : -14.949999999999999,
         "PowerReal_P_Phase_3" : -130.41,
         "PowerReal_P_Sum" : -270.41000000000003,
         "TimeStamp" : 1681283699,
         "Visible" : 1,
         "Voltage_AC_PhaseToPhase_12" : 409.69999999999999,
         "Voltage_AC_PhaseToPhase_23" : 409.10000000000002,
         "Voltage_AC_PhaseToPhase_31" : 409.39999999999998,
         "Voltage_AC_Phase_1" : 236.69999999999999,
         "Voltage_AC_Phase_2" : 236.40000000000001,
         "Voltage_AC_Phase_3" : 236
      }
   },
   "Head" : {
      "RequestArguments" : {
         "DeviceClass" : "Meter",
         "DeviceId" : "2",
         "Scope" : "Device"
      },
      "Status" : {
         "Code" : 0,
         "Reason" : "",
         "UserMessage" : ""
      },
      "Timestamp" : "2023-04-12T09:15:00+02:00"
   }
}

2023-04-12 09:15:00,821 - {modules.devices.fronius.counter_sm:67} - {DEBUG:device0} - Einbauort: MeterLocation.load
2023-04-12 09:15:00,846 - {urllib3.connectionpool:452} - {DEBUG:device0} - http://192.168.2.49:80 "GET /solar_api/v1/GetPowerFlowRealtimeData.fcgi?Scope=System HTTP/1.1" 200 941
2023-04-12 09:15:00,847 - {modules.common.req:11} - {DEBUG:device0} - Get-Response: {
   "Body" : {
      "Data" : {
         "Inverters" : {
            "1" : {
               "DT" : 123,
               "E_Day" : 1735.5,
               "E_Total" : 55002600,
               "E_Year" : 1532213.625,
               "P" : 2216
            }
         },
         "Site" : {
            "E_Day" : 1735.5,
            "E_Total" : 55002600,
            "E_Year" : 1532213.625,
            "Meter_Location" : "load",
            "Mode" : "meter",
            "P_Akku" : null,
            "P_Grid" : -1945.5899999999999,
            "P_Load" : -270.41000000000008,
            "P_PV" : 2216,
            "rel_Autonomy" : 100,
            "rel_SelfConsumption" : 12.202617328519858
         },
         "Version" : "12"
      }
   },
   "Head" : {
      "RequestArguments" : {},
      "Status" : {
         "Code" : 0,
         "Reason" : "",
         "UserMessage" : ""
      },
      "Timestamp" : "2023-04-12T09:15:00+02:00"
   }
}

2023-04-12 09:15:00,849 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681283691.1194243, power=-1954.6100000000001, imported=922220.1431627271, exported=970945.6106510956)
2023-04-12 09:15:00,850 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00270285, power1: -1954.61, power2: -1945.59
2023-04-12 09:15:00,850 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: -5.27083
2023-04-12 09:15:00,851 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 5.27083 Wh, new state: SimCounterState(timestamp=1681283700.8496957, power=-1945.59, imported=922220.1431627271, exported=970950.8814850232)
2023-04-12 09:15:00,852 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[236.7, 236.4, 236], powers=[-613.6166666666667, -723.7166666666666, -608.2566666666667], currents=[-2.5923813547387695, -3.0614072194021427, -2.577358757062147], power_factors=[0.72, 0.45, 0.82], imported=922220.1431627271, exported=970950.8814850232, power=-1945.59, frequency=50)
2023-04-12 09:15:00,860 - {urllib3.connectionpool:227} - {DEBUG:device0} - Starting new HTTP connection (1): 192.168.2.49:80
2023-04-12 09:15:00,879 - {urllib3.connectionpool:452} - {DEBUG:device0} - http://192.168.2.49:80 "GET /solar_api/v1/GetPowerFlowRealtimeData.fcgi?Scope=System HTTP/1.1" 200 941
2023-04-12 09:15:00,881 - {modules.common.req:11} - {DEBUG:device0} - Get-Response: {
   "Body" : {
      "Data" : {
         "Inverters" : {
            "1" : {
               "DT" : 123,
               "E_Day" : 1735.5,
               "E_Total" : 55002600,
               "E_Year" : 1532213.625,
               "P" : 2216
            }
         },
         "Site" : {
            "E_Day" : 1735.5,
            "E_Total" : 55002600,
            "E_Year" : 1532213.625,
            "Meter_Location" : "load",
            "Mode" : "meter",
            "P_Akku" : null,
            "P_Grid" : -1945.5899999999999,
            "P_Load" : -270.41000000000008,
            "P_PV" : 2216,
            "rel_Autonomy" : 100,
            "rel_SelfConsumption" : 12.202617328519858
         },
         "Version" : "12"
      }
   },
   "Head" : {
      "RequestArguments" : {},
      "Status" : {
         "Code" : 0,
         "Reason" : "",
         "UserMessage" : ""
      },
      "Timestamp" : "2023-04-12T09:15:00+02:00"
   }
}

2023-04-12 09:15:00,883 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681283691.157222, power=-2223.0, imported=0.0, exported=1858974.8706962073)
2023-04-12 09:15:00,884 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00270166, power1: -2223, power2: -2216
2023-04-12 09:15:00,884 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: -5.99634
2023-04-12 09:15:00,884 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 5.99634 Wh, new state: SimCounterState(timestamp=1681283700.8832004, power=-2216.0, imported=0.0, exported=1858980.8670320413)
2023-04-12 09:15:00,885 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-2216.0, exported=1858980.8670320413, dc_power=None)
2023-04-12 09:15:00,898 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Fronius Wechselrichter']
2023-04-12 09:15:00,899 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-2216.0, exported=1858980.8670320413, dc_power=None)
2023-04-12 09:15:00,899 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-2216.0, exported=1858980.8670320413, dc_power=None)
2023-04-12 09:15:00,902 - {modules.common.component_context:24} - {DEBUG:cp2} - Update Komponente ['Ladepunkt']
2023-04-12 09:15:00,949 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Fronius SM Zähler']
2023-04-12 09:15:00,950 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[236.7, 236.4, 236], powers=[-613.6166666666667, -723.7166666666666, -608.2566666666667], currents=[-2.5923813547387695, -3.0614072194021427, -2.577358757062147], power_factors=[0.72, 0.45, 0.82], imported=922220.1431627271, exported=970950.8814850232, power=-1945.59, frequency=50)
2023-04-12 09:15:01,073 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [37.59, 38.06, 37.58]A
2023-04-12 09:15:01,075 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 25945.59W
2023-04-12 09:15:01,081 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-12 09:15:01,085 - {control.chargepoint:897} - {INFO:MainThread} - LP 2, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0.0
2023-04-12 09:15:01,091 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=False), get=Get(soc=0, daily_exported=0, daily_imported=0, imported=0, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=False))
2023-04-12 09:15:01,092 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0.0, daily_exported=0, power=0, imported=665880.0, exported=0))
2023-04-12 09:15:01,093 - {control.data:334} - {INFO:MainThread} - cp2
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=59), currents=[0.0, 0.0, 0.0], daily_imported=0.0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=665880.0, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[235.96, 235.61, 236.28]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=665880.0, imported_at_plugtime=665880.0, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/12/2023, 08:36:30', required_power=4140, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710988c8>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.2.54', 'duo_num': 1}}, power_module={}, ev=0, name='Standard-Ladepunkt', type='external_openwb', template=0, connected_phases=3, phase_1=2, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=2))
2023-04-12 09:15:01,094 - {control.data:334} - {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-04-12 09:15:01,096 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[35, 35, 35], max_total_power=24000), get=Get(powers=[-613.62, -723.72, -608.26], currents=[-2.59, -3.06, -2.58], voltages=[236.7, 236.4, 236], power_factors=[0.72, 0.45, 0.82], unbalanced_load=0, frequency=50, daily_exported=801.2846635763, daily_imported=1595.2313067704, imported=922220.1431627271, exported=970950.8814850232, fault_state=0, fault_str='Kein Fehler.', power=-1945.59), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=25945.59, raw_currents_left=[37.59, 38.06, 37.58], surplus_power_left=0, state_str=''))
2023-04-12 09:15:01,098 - {control.data:310} - {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': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=270.4100000000001, invalid_home_consumption=0, daily_yield_home_consumption=2351.8216431941))
2023-04-12 09:15:01,099 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=85), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-12 09:15:01,099 - {control.data:334} - {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=4, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=21, min_current=6, max_current_single_phase=16, battery_capacity=77, nominal_difference=2, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 6, 6], phases=3, prio=False, 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=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=59, soc_timestamp='04/12/2023, 08:36:41', force_soc_update=False, range=277.0, fault_state=0, fault_str='Kein Fehler.'))
2023-04-12 09:15:01,100 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=4, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=21, min_current=6, max_current_single_phase=16, battery_capacity=77, nominal_difference=2, keep_charge_active_duration=40)
2023-04-12 09:15:01,100 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=15000, phase_switch_delay=10, phases_to_use=0, rundown_power=1000, rundown_soc=50, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=20, unbalanced_load=True), 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.2582, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-12 09:15:01,101 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-12 09:15:01,102 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=False))
2023-04-12 09:15:01,103 - {control.data:334} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=1557.875, monthly_exported=0, yearly_exported=0, exported=1858980.867, fault_state=0, fault_str='Kein Fehler.', power=-2216.0))
2023-04-12 09:15:01,103 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=1557.875, monthly_exported=0, yearly_exported=0, exported=1858974.871, power=-2223.0))
2023-04-12 09:15:01,103 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.2.53', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee3]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee3]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681283691, 'time': '09:14:51', 'grid': -1.955, 'house-power': 0.268, 'charging-all': 0.0, 'pv-all': 2.224, 'cp2-power': 0.0, 'ev0-soc': 59}, 'module_update_completed': True}
2023-04-12 09:15:01,104 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Fronius', 'type': 'fronius', 'id': 0, 'configuration': {'ip_address': '192.168.2.49'}}
2023-04-12 09:15:01,104 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Fronius SM Zähler', 'type': 'counter_sm', 'id': 0, 'configuration': {'meter_id': 2, 'variant': 0}}
2023-04-12 09:15:01,104 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Fronius Wechselrichter', 'type': 'inverter', 'id': 1, 'configuration': {}}
2023-04-12 09:15:01,105 - {control.data:321} - {INFO:MainThread} - 

2023-04-12 09:15:01,105 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-12 09:15:01,106 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-12 09:15:01,116 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - False, Zähler 0
2023-04-12 09:15:01,118 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-12 09:15:01,123 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 1830.5900000000001W
2023-04-12 09:15:01,123 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 1830.5900000000001W
2023-04-12 09:15:01,124 - {control.chargepoint:356} - {INFO:MainThread} - LP 2: Die Ladung kann nicht gestartet werden, da die Einschaltschwelle 1500W nicht erreicht wird.
2023-04-12 09:15:01,124 - {control.algorithm.algorithm:41} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-04-12 09:15:01,128 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [2]
2023-04-12 09:15:01,129 - {control.algorithm.filter_chargepoints:47} - {INFO:MainThread} - LP 2: Keine Zuteilung des Mindeststroms, daher keine weitere Berücksichtigung
2023-04-12 09:15:01,131 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-12 09:15:01,132 - {control.process:115} - {INFO:MainThread} - LP2: set current 0 A, state NO_CHARGING_ALLOWED
2023-04-12 09:15:01,136 - {modules.common.component_context:24} - {DEBUG:cp2} - Update Komponente ['Ladepunkt']
2023-04-12 09:15:01,152 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-12 09:15:01,394 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-12 09:15:01,426 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=hours, do=inner, args=(), kwargs={})
2023-04-12 09:15:01,446 - {root:74} - {DEBUG:MainThread} - 5 Minuten Handler ausführen.
2023-04-12 09:15:01,447 - {helpermodules.logger:54} - {DEBUG:MainThread} - Logdateien kürzen
2023-04-12 09:15:01,867 - {helpermodules.measurement_log:292} - {INFO:MainThread} - Modul all wurde zwischenzeitlich gelöscht und wird daher nicht mehr aufgeführt.
2023-04-12 09:15:01,901 - {helpermodules.system:71} - {INFO:MainThread} - my IP: 192.168.2.53
2023-04-12 09:15:10,917 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 09:15:10,918 - {root:61} - {INFO:MainThread} - # ***Start*** 
openWB serie 2 custom 11kW
Skoda Enyaq iV80
PV 9,4kWp SSW, Fronius Symo 8.2-3-M, Fronius Smart Meter 63A
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Feedback Beta 2

Beitrag von LenaK »

Gero hat geschrieben: Di Apr 11, 2023 12:22 pm
LenaK hat geschrieben: Di Apr 11, 2023 10:33 am Hast Du ein Broker-Reset durchgeführt, seit das Problem mit der doppelten Speicherleistung aufgetreten ist?
Ja, habe ich. Aber direkt nach dem update heute früh nicht. Habe ich jetzt einmal nachgeholt. Bei der Ladeleistung sieht es noch so aus, als ob der Wert verdoppelt ist. Die Zähler sind jetzt auf Null - oh Moment, nun sind sie wieder da. Aber auch diese haben den reset_broker überlebt und sind doppelt so hoch wie in der 1.9
Mach dazu bitte ein Support-Ticket auf.
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Feedback Beta 2

Beitrag von LenaK »

ChristianM hat geschrieben: Di Apr 11, 2023 1:40 pm
LenaK hat geschrieben: Di Apr 11, 2023 10:39 am Bei der Beta 1.9.299 gab es ein Problem mit der Duo. Bitte nochmal ein Update der Duo auf die Beta durchführen. Dann im ersten Schritt im Modus Sofortladen die Ladung starten.
Updates sind installiert:
1.9.299.1
2023-04-11 08:43:35 +0200 [655d05ee]

Einen Ladevorgang konnte ich noch nicht testen. Obwohl kein Auto angeschlossen ist, wird dies in der OpenWB 2 angezeigt mit "Ladevorgang läuft..."

Code: Alles auswählen

2023-04-11 15:35:40,768 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-11 15:35:40,833 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72293a48>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x722933e8>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72293550>}
2023-04-11 15:35:40,834 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x722938b0>}
2023-04-11 15:35:40,834 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:40,835 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:40,835 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:40,839 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:40,972 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4806], Scale 0
2023-04-11 15:35:40,980 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66502880], Scale 0
2023-04-11 15:35:41,026 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [664, 665, 664], Scale -2
2023-04-11 15:35:41,032 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4879], Scale 0
2023-04-11 15:35:41,033 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [6.640000000000001, 6.65, 6.640000000000001]
2023-04-11 15:35:41,033 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[6.640000000000001, 6.65, 6.640000000000001], power=-4806.0, exported=66502880.0, dc_power=-4879.0)
2023-04-11 15:35:41,141 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1492, -1501, -2559], currents=[-6.48695652173913, -6.526086956521739, -11.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-5552, frequency=49.97)
2023-04-11 15:35:41,142 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:41,297 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,298 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:41,456 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681220131.1860921, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:41,456 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00285284, power1: 0, power2: 0
2023-04-11 15:35:41,457 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-11 15:35:41,457 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681220141.4563038, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:41,458 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:41,461 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:41,462 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:41,465 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:41,467 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,467 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1085, exported=706500, dc_power=None)
2023-04-11 15:35:41,471 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:41,472 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-4806.0, exported=66502880.0, dc_power=None)
2023-04-11 15:35:41,473 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,474 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-4806.0, exported=66502880.0, dc_power=None)
2023-04-11 15:35:41,477 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,529 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:41,530 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1492, -1501, -2559], currents=[-6.48695652173913, -6.526086956521739, -11.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-5552, frequency=49.97)
2023-04-11 15:35:41,667 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0W
2023-04-11 15:35:41,668 - {control.bat_all:180} - {DEBUG:MainThread} - Keine Ladeleistungs-Reserve für den Speicher vorhalten, da dieser bereits voll geladen ist.
2023-04-11 15:35:41,668 - {control.bat_all:150} - {INFO:MainThread} - 0W verbliebende Speicher-Leistung
2023-04-11 15:35:41,671 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [38.49, 38.53, 43.13]A
2023-04-11 15:35:41,672 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 68552W
2023-04-11 15:35:41,678 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-11 15:35:41,681 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 16A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0.0
2023-04-11 15:35:41,686 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-11 15:35:41,692 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, fault_state=0, fault_str='Kein Fehler.', power=0))
2023-04-11 15:35:41,694 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=True))
2023-04-11 15:35:41,695 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0, daily_exported=0, power=0, imported=7612810.8, exported=0))
2023-04-11 15:35:41,696 - {control.data:334} - {INFO:MainThread} - cp5
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=0), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5246546.88, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[241.8, 242.09, 240.71]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/09/2023, 11:55:21', required_power=11040, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710ef550>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 2}}, power_module={}, ev=0, name='Drinnen', type='external_openwb', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-11 15:35:41,701 - {control.data:334} - {INFO:MainThread} - cp4
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=ConnectedSoc(fault_str='Kein Fehler.', fault_state=0, range_charged=0, range_unit='km', range=0, soc=0, timestamp=None)), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=2366263.92, phases_in_use=0, plug_state=False, power=0, rfid_timestamp=None, rfid=None, state_str='Keine Ladung, da kein Auto angesteckt ist.', voltages=[242.16, 240.31, 242.0]), set=Set(change_ev_permitted=False, charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', 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), manual_lock=False, phases_to_use=0, plug_state_prev=False, plug_time=None, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7107f418>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 1}}, power_module={}, ev=0, name='Draußen', type='external_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=4))
2023-04-11 15:35:41,702 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-11 15:35:41,702 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[-1492, -1501, -2559], currents=[-6.49, -6.53, -11.13], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.97, daily_exported=0, daily_imported=0, imported=2840570, exported=1756330, fault_state=0, fault_str='Kein Fehler.', power=-5552), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=68552, raw_currents_left=[38.49, 38.53, 43.13], surplus_power_left=0, state_str=''))
2023-04-11 15:35:41,703 - {control.data:310} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'bat', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'cp', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=339.0, invalid_home_consumption=0, daily_yield_home_consumption=0))
2023-04-11 15:35:41,703 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-11 15:35:41,704 - {control.data:334} - {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=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=16, required_currents=[16, 16, 16], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), 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-04-11 15:35:41,707 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-11 15:35:41,708 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=20000, phase_switch_delay=7, phases_to_use=0, rundown_power=6000, rundown_soc=60, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=20, unbalanced_load=True), 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.39, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-11 15:35:41,709 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-11 15:35:41,709 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=False))
2023-04-11 15:35:41,709 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=706500, fault_state=0, fault_str='Kein Fehler.', power=-1085))
2023-04-11 15:35:41,710 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=66502880.0, fault_state=0, fault_str='Kein Fehler.', power=-4806.0))
2023-04-11 15:35:41,710 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=0, monthly_exported=0, yearly_exported=0, exported=67209368.0, power=-5800.0))
2023-04-11 15:35:41,711 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.0.186', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681220131, 'time': '15:35:31', 'grid': -5.451, 'house-power': 0.349, 'charging-all': 0.0, 'pv-all': 5.696, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-04-11 15:35:41,714 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-11 15:35:41,714 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-11 15:35:41,715 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-11 15:35:41,715 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-11 15:35:41,716 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-11 15:35:41,716 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-11 15:35:41,716 - {control.data:321} - {INFO:MainThread} - 

2023-04-11 15:35:41,717 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-11 15:35:41,718 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-11 15:35:41,720 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-11 15:35:41,721 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [32.49, 32.53, 37.13]A verbleibende Ströme, 64412W verbleibende Leistung
2023-04-11 15:35:41,722 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 6A
2023-04-11 15:35:41,726 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-11 15:35:41,732 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-11 15:35:41,732 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-11 15:35:41,736 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 1297.0W
2023-04-11 15:35:41,741 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 1297.0W
2023-04-11 15:35:41,743 - {control.algorithm.algorithm:41} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-04-11 15:35:41,749 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-11 15:35:41,752 - {control.process:115} - {INFO:MainThread} - LP5: set current 6 A, state CHARGING_ALLOWED
2023-04-11 15:35:41,756 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,759 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:41,782 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-11 15:35:42,016 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-11 15:35:50,054 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-11 15:35:50,055 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-11 15:35:50,113 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72293a48>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x722933e8>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72293550>}
2023-04-11 15:35:50,115 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x722938b0>}
2023-04-11 15:35:50,115 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:50,116 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,119 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,122 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:50,271 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [5429], Scale 0
2023-04-11 15:35:50,360 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66502896], Scale 0
2023-04-11 15:35:50,408 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [750, 750, 747], Scale -2
2023-04-11 15:35:50,417 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1680, -1685, -2789], currents=[-7.304347826086956, -7.326086956521739, -12.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-6051, frequency=49.98)
2023-04-11 15:35:50,419 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:50,492 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [5602], Scale 0
2023-04-11 15:35:50,493 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [7.5, 7.5, 7.47]
2023-04-11 15:35:50,493 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[7.5, 7.5, 7.47], power=-5429.0, exported=66502896.0, dc_power=-5602.0)
2023-04-11 15:35:50,574 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,575 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:50,733 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681220141.4563038, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:50,733 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00257695, power1: 0, power2: 0
2023-04-11 15:35:50,734 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-11 15:35:50,734 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681220150.7333384, power=0, imported=156650.85958932887, exported=0)
2023-04-11 15:35:50,735 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:50,737 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-11 15:35:50,740 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=0, power=0, soc=100)
2023-04-11 15:35:50,748 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-11 15:35:50,749 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,749 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1159, exported=706500, dc_power=None)
2023-04-11 15:35:50,755 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-11 15:35:50,757 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-5429.0, exported=66502896.0, dc_power=None)
2023-04-11 15:35:50,758 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-5429.0, exported=66502896.0, dc_power=None)
2023-04-11 15:35:50,759 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,762 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:50,806 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-11 15:35:50,807 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[-1680, -1685, -2789], currents=[-7.304347826086956, -7.326086956521739, -12.126086956521739], power_factors=[0.0, 0.0, 0.0], imported=2840570, exported=1756330, power=-6051, frequency=49.98)
2023-04-11 15:35:50,942 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0W
2023-04-11 15:35:50,943 - {control.bat_all:180} - {DEBUG:MainThread} - Keine Ladeleistungs-Reserve für den Speicher vorhalten, da dieser bereits voll geladen ist.
2023-04-11 15:35:50,944 - {control.bat_all:150} - {INFO:MainThread} - 0W verbliebende Speicher-Leistung
2023-04-11 15:35:50,945 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [39.3, 39.33, 44.13]A
2023-04-11 15:35:50,947 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 69051W
2023-04-11 15:35:50,948 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-11 15:35:50,954 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 16A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0.0
2023-04-11 15:35:50,958 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-11 15:35:50,962 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, fault_state=0, fault_str='Kein Fehler.', power=0))
2023-04-11 15:35:50,963 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=0, daily_imported=0, imported=156650.86, exported=0, power=0), set=Set(charging_power_left=0, switch_on_soc_reached=True))
2023-04-11 15:35:50,965 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0, daily_exported=0, power=0, imported=7612810.8, exported=0))
2023-04-11 15:35:50,966 - {control.data:334} - {INFO:MainThread} - cp5
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=0), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5246546.88, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[241.96, 242.27, 240.88]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=0, imported_since_plugged=0.0, range_charged=0, time_charged='00:00', timestamp_start_charging=None), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/09/2023, 11:55:21', required_power=11040, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710d0dd8>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 2}}, power_module={}, ev=0, name='Drinnen', type='external_openwb', template=0, connected_phases=3, phase_1=3, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-11 15:35:50,968 - {control.data:334} - {INFO:MainThread} - cp4
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=ConnectedSoc(fault_str='Kein Fehler.', fault_state=0, range_charged=0, range_unit='km', range=0, soc=0, timestamp=None)), currents=[0.0, 0.0, 0.0], daily_imported=0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=2366263.92, phases_in_use=0, plug_state=False, power=0, rfid_timestamp=None, rfid=None, state_str='Keine Ladung, da kein Auto angesteckt ist.', voltages=[242.29, 240.48, 242.17]), set=Set(change_ev_permitted=False, charging_ev=-1, charging_ev_prev=-1, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', 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), manual_lock=False, phases_to_use=0, plug_state_prev=False, plug_time=None, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7107f0b8>), config=Config(connection_module={'type': 'external_openwb', 'name': 'Externe openWB', 'configuration': {'ip_address': '192.168.0.221', 'duo_num': 1}}, power_module={}, ev=0, name='Draußen', type='external_openwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=4))
2023-04-11 15:35:50,968 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-11 15:35:50,969 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[-1680, -1685, -2789], currents=[-7.3, -7.33, -12.13], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.98, daily_exported=0, daily_imported=0, imported=2840570, exported=1756330, fault_state=0, fault_str='Kein Fehler.', power=-6051), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=69051, raw_currents_left=[39.3, 39.33, 44.13], surplus_power_left=0, state_str=''))
2023-04-11 15:35:50,969 - {control.data:310} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'bat', 'children': []}, {'id': 2, 'type': 'inverter', 'children': []}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'cp', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=537.0, invalid_home_consumption=0, daily_yield_home_consumption=0))
2023-04-11 15:35:50,969 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-11 15:35:50,970 - {control.data:334} - {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=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=16, required_currents=[16, 16, 16], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), 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-04-11 15:35:50,972 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=7, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=True, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=32, battery_capacity=64, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-11 15:35:50,973 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=200, control_range=[-230, 0], feed_in_yield=20000, phase_switch_delay=7, phases_to_use=0, rundown_power=6000, rundown_soc=60, switch_off_delay=60, switch_off_soc=40, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=60, switch_on_threshold=1500), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=1), unbalanced_load_limit=20, unbalanced_load=True), 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.39, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-11 15:35:50,973 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-11 15:35:50,973 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=False))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=706500, fault_state=0, fault_str='Kein Fehler.', power=-1159))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=66502896.0, fault_state=0, fault_str='Kein Fehler.', power=-5429.0))
2023-04-11 15:35:50,974 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=0, monthly_exported=0, yearly_exported=0, exported=67209380.0, power=-5891.0))
2023-04-11 15:35:50,974 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.0.186', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681220141, 'time': '15:35:41', 'grid': -5.552, 'house-power': 0.339, 'charging-all': 0.0, 'pv-all': 5.8, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-04-11 15:35:50,976 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-11 15:35:50,976 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-11 15:35:50,977 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-11 15:35:50,977 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-11 15:35:50,978 - {control.data:321} - {INFO:MainThread} - 

2023-04-11 15:35:50,978 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-11 15:35:50,979 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-11 15:35:50,981 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-11 15:35:50,982 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [33.3, 33.33, 38.13]A verbleibende Ströme, 64911W verbleibende Leistung
2023-04-11 15:35:50,982 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 6A
2023-04-11 15:35:50,985 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-11 15:35:50,990 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-11 15:35:50,991 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-11 15:35:50,992 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 1796.0W
2023-04-11 15:35:50,992 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 1796.0W
2023-04-11 15:35:50,992 - {control.algorithm.algorithm:41} - {INFO:MainThread} - **PV-geführten Strom setzen**
2023-04-11 15:35:50,995 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-11 15:35:50,998 - {control.process:115} - {INFO:MainThread} - LP5: set current 6 A, state CHARGING_ALLOWED
2023-04-11 15:35:51,008 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:51,011 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-11 15:35:51,049 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-11 15:35:51,266 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-11 15:36:00,317 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-11 15:36:00,318 - {root:61} - {INFO:MainThread} - # ***Start*** 
Schon ein Reboot der Duo probiert?
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Feedback Beta 2

Beitrag von LenaK »

Nasdero hat geschrieben: Di Apr 11, 2023 12:29 pm
LenaK hat geschrieben: Di Apr 11, 2023 9:57 am
Zu 2.: Ist die vorgegebene Phasenzahl 1 oder fängt das Auto mit einer Phase an zu laden und schaltet dann weitere hinzu? Die vorgegebene Phasenzahl siehst Du im Status beim Ladepunkt.

Zu3.: Die Modbus-Abfrage dauert mehrere Hundert Millisekunden je Wert. Max 1/3 des Regelintervalls darf für die Abfrage der Werte aufgewendet werden. Stelle mal das Regelintervall auf Langsam.

Zu 4.: Ich habe den Hinweistext angepasst: "Stoppen des Ladevorgangs verhindert, da in der Fahrzeug-Vorlage die Einstellung"
" 'Ladung aktiv halten' aktiviert ist." Bitte dort deaktiveren, wenn die Ladung gestoppt werden darf.

Zu 5.: Kommen die Neustart-Meldungen noch, nachdem Du heute das Update gemacht hast?
zu 2: Wenn der Zoe wieder da ist, schaue ich in den Status, es wurde mit einer Phase angefangen und dann im Prinzip sofort abgeschaltet und dann ist die Meldung "Umschaltung von 1 auf 3 Phasen" (sinngemäß) gekommen.

zu 3: Ich hab es nun auf langsam und werde es beobachten

zu 4: "Ladung aktiv halten" nun auf AUS

zu 5: JA

Code: Alles auswählen

2023-04-11 09:20:08,047 - {helpermodules.subdata:671} - {ERROR:Thread-5} - Fehler im subdata-Modul
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
    raise FaultState.error(__name__+" "+str(response))
modules.common.fault_state.FaultState: ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/var/www/html/openWB/packages/helpermodules/subdata.py", line 635, in process_system_topic
    var["device"+index].add_component(config)
  File "/var/www/html/openWB/packages/modules/devices/solaredge/device.py", line 71, in add_component
    self.synergy_units = int(self.client.read_holding_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 118, in read_holding_registers
    return self.__read_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 100, in __read_registers
    raise FaultState.error(__name__+" "+str(type(e))+" " +
modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
2023-04-11 09:20:08,183 - {helpermodules.subdata:671} - {ERROR:Thread-5} - Fehler im subdata-Modul
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 85, in __read_registers
    raise FaultState.error(__name__+" "+str(response))
modules.common.fault_state.FaultState: ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/var/www/html/openWB/packages/helpermodules/subdata.py", line 635, in process_system_topic
    var["device"+index].add_component(config)
  File "/var/www/html/openWB/packages/modules/devices/solaredge/device.py", line 71, in add_component
    self.synergy_units = int(self.client.read_holding_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 118, in read_holding_registers
    return self.__read_registers(
  File "/var/www/html/openWB/packages/modules/common/modbus.py", line 100, in __read_registers
    raise FaultState.error(__name__+" "+str(type(e))+" " +
modules.common.fault_state.FaultState: ("modules.common.modbus <class 'modules.common.fault_state.FaultState'> ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>)", <FaultStateLevel.ERROR: 2>)
2023-04-11 09:20:08,504 - {modules.devices.solaredge.device:74} - {DEBUG:Thread-5} - Synergy Units: 1
2023-04-11 09:20:08,504 - {modules.devices.solaredge.device:94} - {DEBUG:Thread-5} - SolarEdge Zähler: internal meter id: 1, synergy units: 1
2023-04-11 09:20:20,765 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
Neustart-Meldungen sehe ich in dem Logauszug keine. Falls Du die modules.common.fault_state.FaultState: ('modules.common.modbus Exception Response(131, 3, IllegalAddress)', <FaultStateLevel.ERROR: 2>) Meldung meinst, dein WR hat offenbar kein Register für die Synergy Units. Daher wird standardmäßig 1 angenommen.
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Feedback Beta 2

Beitrag von LenaK »

Nasdero hat geschrieben: Di Apr 11, 2023 2:09 pm
LenaK hat geschrieben: Di Apr 11, 2023 9:57 am Zu3.: Die Modbus-Abfrage dauert mehrere Hundert Millisekunden je Wert. Max 1/3 des Regelintervalls darf für die Abfrage der Werte aufgewendet werden. Stelle mal das Regelintervall auf Langsam.
Kommt leider wieder, in der 1.9 stand der Regler auf "Normal", da ist mir so etwas nicht aufgefallen, was aber nicht heißt es gab den Fehler nicht:

Code: Alles auswählen

22023-04-11 15:28:36,676 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:28:36,677 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,679 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,680 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,680 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:28:36,691 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:39:30,928 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1073.1999999999998W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:40:56,797 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:40:56,797 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,799 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,799 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,800 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:40:56,809 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:42:14,101 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1729.5W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:43:12,215 - {control.counter_all:94} - {ERROR:MainThread} - Ungültiger Hausverbrauch: -1336.1999999999998W, Berücksichtigte Komponenten neben EVU [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}, {'id': 2, 'type': 'bat', 'children': []}]
2023-04-11 15:55:56,736 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 15:55:56,737 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,738 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 15:55:56,743 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,921 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 16:01:36,921 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,924 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,925 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,925 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:36,933 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,879 - {helpermodules.utils._thread_handler:21} - {ERROR:MainThread} - device0 konnte nicht innerhalb des Timeouts die Werte abfragen, die abgefragten Werte werden nicht in der Regelung verwendet.
2023-04-11 16:01:56,879 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,881 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,882 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,882 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-11 16:01:56,890 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
Das sieht nicht nach einem grundsätzlichen Problem aus, da es nur ab und an vorkommt. Fragst Du die Werte vom WR noch mit der 1.9 ab? Könnte es am Netzwerk liegen?
LenaK
Beiträge: 1029
Registriert: Fr Jan 22, 2021 6:40 am

Re: Feedback Beta 2

Beitrag von LenaK »

Nasdero hat geschrieben: Mi Apr 12, 2023 7:42 am
LenaK hat geschrieben: Di Apr 11, 2023 9:57 am Zu 2.: Ist die vorgegebene Phasenzahl 1 oder fängt das Auto mit einer Phase an zu laden und schaltet dann weitere hinzu? Die vorgegebene Phasenzahl siehst Du im Status beim Ladepunkt.
So ich hab das mit dem ZOE probiert heute früh.

ZOE war angeschlossen, ich habe Sofortladen als Lademodus ausgewählt (eingestellt ist Sofortladen max. Anzahl Phasen)

Im Status steht dann Vorgabe 3, Aktuell 1, dann wird der Stecker am Ladepunkt grün, kurz passiert etwas, die Ladeleistung bewegt sich und der Stecker wird wieder gelb.

Dann kommt Vorgabe 3 und Aktuell 3, stecker wird wieder grün und der "Ladevorgang läuft" wird angezeigt, der ZOE läd nun aber nicht, vermute er hat kurz 1p bekommen, nun müsste ich ihn abstecken und wieder anstecken damit er läd.

So habe ich das wahrgenommen.

sofortladen.png

Code: Alles auswählen

2023-04-12 09:27:10,712 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-12 09:30:00,465 - {helpermodules.setdata:290} - {ERROR:Thread-6} - Payload ungültig: Topic openWB/set/pv/1/get/daily_exported, Payload -113.2 liegt in keinem der angegebenen Wertebereiche.
2023-04-12 09:33:30,703 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x7f754a8aec10>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x7f754a8ae070>, 'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8d6790>, 'component4': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8c65b0>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f754a8ad7c0>}
2023-04-12 09:33:30,703 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:30,704 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-12 09:33:30,706 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-04-12 09:33:30,734 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.1.101:80 "GET /connect.php HTTP/1.1" 200 327
2023-04-12 09:33:30,734 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: {"date":"2023:04:12-07:33:30","timestamp":1681284810,"powers":[0,0,0],"power_all":0,"currents":[0,0,0],"imported":1463084,"exported":2049,"plug_state":true,"charge_state":false,"phases_actual":0,"phases_target":3,"phases_in_use":3,"offered_current":10,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"479411"}
2023-04-12 09:33:30,734 - {modules.common.store._api:26} - {DEBUG:cp5} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=1463084, exported=2049, power=0, phases_in_use=3, charge_state=False, plug_state=True, rfid=None)
2023-04-12 09:33:30,808 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-388, -362, -105, 79], Scale 0
2023-04-12 09:33:30,816 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23, 13, 0], Scale -1
2023-04-12 09:33:31,021 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23644, 23889, 23840, -24329, -24371, -24201, -24414], Scale -2
2023-04-12 09:33:31,186 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [5011], Scale -2
2023-04-12 09:33:31,269 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [6000, 3436, -7816], Scale -2
2023-04-12 09:33:31,469 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [44042628, 19682968, 21223582, 17869924, 20122861, 14785300, 11644693, 8426712], Scale 0
2023-04-12 09:33:31,469 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[236.44, 238.89000000000001, 238.4], powers=[362.0, 105.0, -79.0], currents=[2.3000000000000003, 1.3, 0.0], power_factors=[0.6, 0.3436, -0.7816], imported=20122861.0, exported=44042628.0, power=388.0, frequency=50.11)
2023-04-12 09:33:31,470 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-04-12 09:33:31,499 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681284791.2670112, power=0.0, imported=27086.934899080934, exported=28306.228172097795)
2023-04-12 09:33:31,499 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00562008, power1: 0, power2: 0
2023-04-12 09:33:31,499 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-04-12 09:33:31,499 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681284811.499303, power=0.0, imported=27086.934899080934, exported=28306.228172097795)
2023-04-12 09:33:31,499 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=27086.934899080934, exported=28306.228172097795, power=0.0, soc=9.498736381530762)
2023-04-12 09:33:31,503 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-12 09:33:31,550 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [16000], Scale -2
2023-04-12 09:33:31,609 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [31519490], Scale 0
2023-04-12 09:33:31,660 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [10312, 65535, 65535], Scale -4
2023-04-12 09:33:31,709 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [16243], Scale -2
2023-04-12 09:33:31,709 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [1.0312000000000001, 0, 0]
2023-04-12 09:33:31,709 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[1.0312000000000001, 0, 0], power=-160.0, exported=31519490.0, dc_power=-162.43)
2023-04-12 09:33:31,711 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-12 09:33:31,855 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [14662], Scale -2
2023-04-12 09:33:31,934 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23556804], Scale 0
2023-04-12 09:33:31,988 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [77, 65535, 65535], Scale -2
2023-04-12 09:33:32,064 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [14814], Scale -2
2023-04-12 09:33:32,065 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [0.77, 0, 0]
2023-04-12 09:33:32,065 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.77, 0, 0], power=-146.62, exported=23556804.0, dc_power=-148.14000000000001)
2023-04-12 09:33:32,066 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-12 09:33:32,078 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [12800], Scale -2
2023-04-12 09:33:32,084 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [35836820], Scale 0
2023-04-12 09:33:32,097 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [9375, 65535, 65535], Scale -4
2023-04-12 09:33:32,102 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [12994], Scale -2
2023-04-12 09:33:32,102 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [0.9375, 0, 0]
2023-04-12 09:33:32,102 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.9375, 0, 0], power=-128.0, exported=35836820.0, dc_power=-129.94)
2023-04-12 09:33:32,106 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-04-12 09:33:32,106 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=27086.934899080934, exported=28306.228172097795, power=0.0, soc=9.498736381530762)
2023-04-12 09:33:32,113 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-12 09:33:32,113 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-128.0, exported=35835600.7, dc_power=None)
2023-04-12 09:33:32,113 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-128.0, exported=35835600.7, dc_power=None)
2023-04-12 09:33:32,113 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-12 09:33:32,113 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-160.0, exported=31519490.0, dc_power=None)
2023-04-12 09:33:32,114 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-160.0, exported=31519490.0, dc_power=None)
2023-04-12 09:33:32,114 - {modules.common.component_context:24} - {DEBUG:component4} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-12 09:33:32,115 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:32,116 - {modules.common.store._api:26} - {DEBUG:component4} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-146.62, exported=23556804.0, dc_power=None)
2023-04-12 09:33:32,118 - {modules.common.store._api:30} - {INFO:cp5} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=1463084, exported=2049, power=0, phases_in_use=3, charge_state=False, plug_state=True, rfid=None)
2023-04-12 09:33:32,118 - {modules.common.store._api:30} - {INFO:component4} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-146.62, exported=23556804.0, dc_power=None)
2023-04-12 09:33:32,125 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-04-12 09:33:32,125 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[236.44, 238.89000000000001, 238.4], powers=[362.0, 105.0, -79.0], currents=[2.3000000000000003, 1.3, 0.0], power_factors=[0.6, 0.3436, -0.7816], imported=20122861.0, exported=44042628.0, power=388.0, frequency=50.11)
2023-04-12 09:33:32,136 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: 0.0W
2023-04-12 09:33:32,136 - {control.bat_all:177} - {DEBUG:MainThread} - Ladeleistungs-Reserve (1000W) subtrahieren: -1000.0
2023-04-12 09:33:32,136 - {control.bat_all:150} - {INFO:MainThread} - -1000.0W verbliebende Speicher-Leistung
2023-04-12 09:33:32,136 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [29.7, 30.7, 32.0]A
2023-04-12 09:33:32,136 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 23612.0W
2023-04-12 09:33:32,136 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-12 09:33:32,137 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Renault ZOE (EV-Nr.1): Theoretisch benötigter Strom 10A, Lademodus instant_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 3, Priorität: False, max. Ist-Strom: 0
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - bat2
BatData(get=Get(soc=9, daily_exported=3269.2, daily_imported=0.0, imported=27086.93, exported=28306.23, fault_state=0, fault_str='Kein Fehler.', power=0.0))
2023-04-12 09:33:32,137 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=9, daily_exported=3269.2, daily_imported=0.0, imported=27086.93, exported=28306.23, power=0.0), set=Set(charging_power_left=-1000.0, switch_on_soc_reached=True))
2023-04-12 09:33:32,137 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=5, daily_exported=0, power=0, imported=1463084, exported=2049))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - cp5
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=67.0), currents=[0, 0, 0], daily_imported=5, daily_exported=0, exported=2049, fault_str='Kein Fehler.', fault_state=0, imported=1463084, phases_in_use=3, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[0.0, 0.0, 0.0]), set=Set(change_ev_permitted=[True, ''], charging_ev=1, charging_ev_prev=1, current=10, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='instant_charging', imported_at_mode_switch=1463079, imported_at_plugtime=1463079, imported_since_mode_switch=5, imported_since_plugged=5, range_charged=0.029411764705882353, time_charged='0:03', timestamp_start_charging='04/12/2023, 09:28:31'), manual_lock=False, phases_to_use=3, plug_state_prev=True, plug_time='04/12/2023, 09:11:33', required_power=6900, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7f754a8d68e0>), config=Config(connection_module={'type': 'openwb_pro', 'name': 'openWB Pro', 'configuration': {'ip_address': '192.168.1.101'}}, power_module={}, ev=1, name='Standard-Ladepunkt', type='openwb_pro', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=5))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=32, max_current_single_phase=32, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=24000), get=Get(powers=[362.0, 105.0, -79.0], currents=[2.3, 1.3, 0.0], voltages=[236.44, 238.89, 238.4], power_factors=[0.6, 0.34, -0.78], unbalanced_load=0, frequency=50.11, daily_exported=44.0, daily_imported=2119.0, imported=20122861.0, exported=44042628.0, fault_state=0, fault_str='Kein Fehler.', power=388.0), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=23612.0, raw_currents_left=[29.7, 30.7, 32.0], surplus_power_left=0, state_str=''))
2023-04-12 09:33:32,137 - {control.data:310} - {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': 'inverter', 'children': []}, {'id': 4, 'type': 'inverter', 'children': []}, {'id': 5, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=822.62, invalid_home_consumption=0, daily_yield_home_consumption=5518.0))
2023-04-12 09:33:32,137 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Renault ZOE', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ct2
ChargeTemplateData(name='Opel Corsa', disable_after_unplug=False, prio=False, load_default=True, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='stop', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=10000, soc=50))))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=32, max_phases=1, phase_switch_pause=2, prevent_phase_switch=True, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=120), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=10, 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='pv_charging', chargemode='pv_charging', 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-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev1
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Renault ZOE', max_current_multi_phases=32, max_phases=3, phase_switch_pause=10, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=60), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=10, required_currents=[10, 10, 10], phases=3, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), charge_template=1, ev_template=1, name='Renault ZOE', tag_id=['7C:BC:84:40:F8:C1'], get=Get(soc=67.0, soc_timestamp='04/12/2023, 09:31:40', force_soc_update=False, range=151.0, fault_state=0, fault_str='Kein Fehler.'))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Opel Corsa', max_current_multi_phases=10, max_phases=1, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=True, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=42, nominal_difference=0.5, 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=2, ev_template=2, name='Opel Corsa', tag_id=['00:18:87:02:13:8C'], get=Get(soc=100, soc_timestamp='04/12/2023, 09:31:40', force_soc_update=False, range=296, fault_state=0, fault_str='Kein Fehler.'))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=32, max_phases=1, phase_switch_pause=2, prevent_phase_switch=True, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=120)
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et1
EvTemplateData(name='Renault ZOE', max_current_multi_phases=32, max_phases=3, phase_switch_pause=10, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=54, nominal_difference=0.5, keep_charge_active_duration=60)
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - et2
EvTemplateData(name='Opel Corsa', max_current_multi_phases=10, max_phases=1, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=10, max_current_single_phase=32, battery_capacity=42, nominal_difference=0.5, keep_charge_active_duration=40)
2023-04-12 09:33:32,138 - {control.data:314} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=1000, control_range=[0, 230], feed_in_yield=0, phase_switch_delay=13, phases_to_use=1, rundown_power=2500, rundown_soc=100, switch_off_delay=60, switch_off_soc=0, switch_off_threshold=200, switch_on_delay=30, switch_on_soc=0, switch_on_threshold=2000), scheduled_charging=ScheduledCharging(phases_to_use=3), standby=Standby(phases_to_use=1), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=20, 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.34, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-12 09:33:32,138 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-12 09:33:32,138 - {control.data:316} - {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=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme='cards'), led=Led(active=False), rfid=Rfid(active=True))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=4600), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=168.0, monthly_exported=0, yearly_exported=0, exported=31519490.0, fault_state=0, fault_str='Kein Fehler.', power=-160.0))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv4
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=124.0, monthly_exported=0, yearly_exported=0, exported=23556804.0, fault_state=0, fault_str='Kein Fehler.', power=-146.62))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=0), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=0, monthly_exported=0, yearly_exported=0, exported=35835600.7, fault_state=0, fault_str='Kein Fehler.', power=-128.0))
2023-04-12 09:33:32,138 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=292.0, monthly_exported=0, yearly_exported=0, exported=90911890.7, power=-417.27))
2023-04-12 09:33:32,138 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '192.168.1.100', 'current_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_branch': 'master', 'current_branch_commit': '2023-04-11 08:43:35 +0200 [655d05ee]', 'current_missing_commits': [], 'boot_done': True, 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681284792, 'time': '09:33:12', 'grid': 0.381, 'house-power': 0.798, 'charging-all': 0.0, 'pv-all': 0.364, 'cp5-power': 0.0, 'ev1-soc': 67.0, 'ev2-soc': 100, 'bat-all-power': 0.0, 'bat-all-soc': 9}, 'module_update_completed': True}
2023-04-12 09:33:32,138 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.1.99'}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter 2', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 5}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component4
{'name': 'SolarEdge Wechselrichter 3', 'type': 'inverter', 'id': 4, 'configuration': {'modbus_id': 8}}
2023-04-12 09:33:32,138 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'SolarEdge Wechselrichter 1', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2023-04-12 09:33:32,138 - {control.data:321} - {INFO:MainThread} - 

2023-04-12 09:33:32,138 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-12 09:33:32,138 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-12 09:33:32,139 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.INSTANT_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-12 09:33:32,139 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [19.7, 20.7, 22.0]A verbleibende Ströme, 16712.0W verbleibende Leistung
2023-04-12 09:33:32,139 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 10A
2023-04-12 09:33:32,139 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-12 09:33:32,139 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-12 09:33:32,139 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-12 09:33:32,139 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-04-12 09:33:32,139 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-04-12 09:33:32,139 - {control.algorithm.algorithm:46} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-04-12 09:33:32,140 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-12 09:33:32,140 - {control.process:115} - {INFO:MainThread} - LP5: set current 10 A, state CHARGING_ALLOWED
2023-04-12 09:33:32,143 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 09:33:32,143 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-12 09:33:32,182 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.1.101:80 "POST /connect.php HTTP/1.1" 200 20
2023-04-12 09:33:32,183 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: OK Value:10 accepted
2023-04-12 09:33:32,183 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-12 09:33:32,222 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-12 09:33:40,234 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 09:33:40,235 - {root:61} - {INFO:MainThread} - # ***Start*** 
Ich brauche hier bitte den ganzen Log im Modus Details von "kein Auto angesteckt" bis Zoe hat Strom, aber will nicht laden.
Gesperrt