openWB Forum

Code: Alles auswählen

2023-04-12 20:08:50,363 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-12 20:08:50,422 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72256298>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x72256178>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72256508>}
2023-04-12 20:08:50,423 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x72256f10>}
2023-04-12 20:08:50,424 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-12 20:08:50,425 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:50,428 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:50,433 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-12 20:08:50,463 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4080], Scale -1
2023-04-12 20:08:50,472 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66562992], Scale 0
2023-04-12 20:08:50,558 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [92, 91, 87], Scale -2
2023-04-12 20:08:50,564 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [4142], Scale -1
2023-04-12 20:08:50,565 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [0.92, 0.91, 0.87]
2023-04-12 20:08:50,565 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[0.92, 0.91, 0.87], power=-408.0, exported=66562992.0, dc_power=-414.20000000000005)
2023-04-12 20:08:50,725 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[754, -38, -813], currents=[3.2782608695652176, -0.16521739130434782, -3.534782608695652], power_factors=[0.0, 0.0, 0.0], imported=2857030, exported=1798680, power=-148, frequency=49.97)
2023-04-12 20:08:50,726 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-12 20:08:50,880 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:08:50,882 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-12 20:08:51,040 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681322920.7526293, power=-633, imported=156650.85958932887, exported=190.60319953663478)
2023-04-12 20:08:51,040 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00285761, power1: -633, power2: -950
2023-04-12 20:08:51,041 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: -2.26179
2023-04-12 20:08:51,041 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 2.26179 Wh, new state: SimCounterState(timestamp=1681322931.0400074, power=-950, imported=156650.85958932887, exported=192.86499391012717)
2023-04-12 20:08:51,042 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=192.86499391012717, power=-950, soc=98)
2023-04-12 20:08:51,044 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-12 20:08:51,045 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=192.86499391012717, power=-950, soc=98)
2023-04-12 20:08:51,049 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-12 20:08:51,051 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:08:51,051 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:08:51,053 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-12 20:08:51,060 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-408.0, exported=66562992.0, dc_power=None)
2023-04-12 20:08:51,060 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-408.0, exported=66562992.0, dc_power=None)
2023-04-12 20:08:51,066 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:51,068 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:51,109 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-12 20:08:51,110 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[754, -38, -813], currents=[3.2782608695652176, -0.16521739130434782, -3.534782608695652], power_factors=[0.0, 0.0, 0.0], imported=2857030, exported=1798680, power=-148, frequency=49.97)
2023-04-12 20:08:51,243 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: -950W
2023-04-12 20:08:51,245 - {control.bat_all:177} - {DEBUG:MainThread} - Ladeleistungs-Reserve (200W) subtrahieren: -1150
2023-04-12 20:08:51,246 - {control.bat_all:150} - {INFO:MainThread} - -1150W verbliebende Speicher-Leistung
2023-04-12 20:08:51,250 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [28.72, 32.17, 35.53]A
2023-04-12 20:08:51,253 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 63148W
2023-04-12 20:08:51,258 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-12 20:08:51,262 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 10A, Lademodus pv_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 0, Priorität: False, max. Ist-Strom: 0.0
2023-04-12 20:08:51,265 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-12 20:08:51,271 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=98, daily_exported=134.84, daily_imported=0.0, imported=156650.86, exported=192.86, fault_state=0, fault_str='Kein Fehler.', power=-950))
2023-04-12 20:08:51,273 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=98, daily_exported=134.84, daily_imported=0.0, imported=156650.86, exported=190.6, power=-633), set=Set(charging_power_left=-1150, switch_on_soc_reached=True))
2023-04-12 20:08:51,275 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=58622.07, daily_exported=0, power=0, imported=7671462.65, exported=0))
2023-04-12 20:08:51,276 - {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=58622.07, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5305198.73, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[239.54, 236.8, 238.38]), 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='instant_charging', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=58651.85000000056, imported_since_plugged=58651.85000000056, range_charged=345.01088235294446, time_charged='0:04', timestamp_start_charging='04/12/2023, 20:04:32'), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/12/2023, 20:04:22', required_power=0.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x710f6820>), 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-12 20:08:51,276 - {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.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=[236.82, 238.01, 239.76]), 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 0x710ae868>), 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-12 20:08:51,278 - {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 20:08:51,279 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[754, -38, -813], currents=[3.28, -0.17, -3.53], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.97, daily_exported=1300, daily_imported=230, imported=2857030, exported=1798680, fault_state=0, fault_str='Kein Fehler.', power=-148), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=63148, raw_currents_left=[28.72, 32.17, 35.53], surplus_power_left=0, state_str=''))
2023-04-12 20:08:51,279 - {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=1223.0, invalid_home_consumption=0, daily_yield_home_consumption=600.8))
2023-04-12 20:08:51,280 - {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=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=6, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-12 20:08:51,280 - {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=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=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=3), 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 20:08:51,281 - {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-12 20:08:51,282 - {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-12 20:08:51,283 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-12 20:08:51,283 - {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 20:08:51,283 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=200, monthly_exported=0, yearly_exported=0, exported=725900, fault_state=0, fault_str='Kein Fehler.', power=-13))
2023-04-12 20:08:51,284 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=1480.0, monthly_exported=0, yearly_exported=0, exported=66562992.0, fault_state=0, fault_str='Kein Fehler.', power=-408.0))
2023-04-12 20:08:51,284 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=1680.0, monthly_exported=0, yearly_exported=0, exported=67288892.0, power=-428.0))
2023-04-12 20:08:51,284 - {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-12 12:48:27 +0200 [6e1e8d6e]', 'current_branch': 'master', 'current_branch_commit': '2023-04-12 12:48:27 +0200 [6e1e8d6e]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681322921, 'time': '20:08:41', 'grid': 0.0, 'house-power': 1.061, 'charging-all': 0.0, 'pv-all': 0.442, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': -0.739, 'bat-all-soc': 98}, 'module_update_completed': True}
2023-04-12 20:08:51,285 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-12 20:08:51,285 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-12 20:08:51,285 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-12 20:08:51,285 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-12 20:08:51,286 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-12 20:08:51,286 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-12 20:08:51,288 - {control.data:321} - {INFO:MainThread} - 

2023-04-12 20:08:51,288 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-12 20:08:51,289 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-12 20:08:51,291 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-12 20:08:51,295 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-12 20:08:51,298 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-12 20:08:51,299 - {control.algorithm.filter_chargepoints:47} - {INFO:MainThread} - LP 5: Keine Zuteilung des Mindeststroms, daher keine weitere Berücksichtigung
2023-04-12 20:08:51,299 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-04-12 20:08:51,299 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-04-12 20:08:51,300 - {control.algorithm.algorithm:46} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-04-12 20:08:51,300 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-12 20:08:51,307 - {control.chargepoint:637} - {DEBUG:MainThread} - Lp 5: Ladung aktiv halten 40s
2023-04-12 20:08:51,308 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:51,311 - {control.phase_switch:36} - {DEBUG:MainThread} - Thread zur Phasenumschaltung an LP5 gestartet.
2023-04-12 20:08:51,313 - {control.chargepoint:641} - {DEBUG:MainThread} - start phase switch phases_to_use 1control_parameter phases 0
2023-04-12 20:08:51,314 - {control.chargepoint:356} - {INFO:MainThread} - LP 5: Umschaltung von 3 auf 1 Phase.
2023-04-12 20:08:51,317 - {control.process:115} - {INFO:MainThread} - LP5: set current 0 A, state PERFORMING_PHASE_SWITCH
2023-04-12 20:08:51,322 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:51,325 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:08:51,345 - {control.counter:174} - {INFO:MainThread} - 7360W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-12 20:08:51,573 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-12 20:09:00,614 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 20:09:00,615 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-12 20:09:00,673 - {modules.devices.solax.device:55} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solax.counter.SolaxCounter object at 0x72256298>, 'component2': <modules.devices.solax.inverter.SolaxInverter object at 0x72256178>, 'component1': <modules.devices.solax.bat.SolaxBat object at 0x72256508>}
2023-04-12 20:09:00,676 - {modules.devices.solaredge.device:100} - {DEBUG:device1} - Start device reading {'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x72256f10>}
2023-04-12 20:09:00,677 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Zähler']
2023-04-12 20:09:00,678 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:00,679 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:00,685 - {modules.common.component_context:24} - {DEBUG:device1} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-12 20:09:00,758 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [3890], Scale -1
2023-04-12 20:09:00,767 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [66562992], Scale 0
2023-04-12 20:09:00,812 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [90, 91, 85], Scale -2
2023-04-12 20:09:00,900 - {modules.devices.solaredge.scale:16} - {DEBUG:device1} - Registers [3959], Scale -1
2023-04-12 20:09:00,901 - {modules.common.component_state:95} - {DEBUG:device1} - currents sign wrong [0.9, 0.91, 0.85]
2023-04-12 20:09:00,901 - {modules.common.store._api:26} - {DEBUG:device1} - Raw data InverterState(currents=[0.9, 0.91, 0.85], power=-389.0, exported=66562992.0, dc_power=-395.90000000000003)
2023-04-12 20:09:01,118 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[230.0, 230.0, 230.0], powers=[764, -34, -732], currents=[3.3217391304347825, -0.14782608695652175, -3.1826086956521737], power_factors=[0.0, 0.0, 0.0], imported=2857040, exported=1798690, power=0, frequency=49.95)
2023-04-12 20:09:01,121 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Wechselrichter']
2023-04-12 20:09:01,323 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:09:01,324 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Solax Speicher']
2023-04-12 20:09:01,526 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681322931.0400074, power=-950, imported=156650.85958932887, exported=192.86499391012717)
2023-04-12 20:09:01,527 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00291295, power1: -950, power2: -774
2023-04-12 20:09:01,528 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: -2.51096
2023-04-12 20:09:01,528 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 2.51096 Wh, new state: SimCounterState(timestamp=1681322941.5266206, power=-774, imported=156650.85958932887, exported=195.375955199533)
2023-04-12 20:09:01,529 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=156650.85958932887, exported=195.375955199533, power=-774, soc=98)
2023-04-12 20:09:01,535 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['Solax Speicher']
2023-04-12 20:09:01,537 - {modules.common.store._api:30} - {INFO:component1} - Saving BatState(imported=156650.85958932887, exported=195.375955199533, power=-774, soc=98)
2023-04-12 20:09:01,548 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['Solax Wechselrichter']
2023-04-12 20:09:01,554 - {modules.common.store._api:26} - {DEBUG:component2} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:09:01,555 - {modules.common.store._api:30} - {INFO:component2} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-13, exported=725900, dc_power=None)
2023-04-12 20:09:01,561 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter']
2023-04-12 20:09:01,568 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-389.0, exported=66562992.0, dc_power=None)
2023-04-12 20:09:01,569 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-389.0, exported=66562992.0, dc_power=None)
2023-04-12 20:09:01,573 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:01,579 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:01,638 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Solax Zähler']
2023-04-12 20:09:01,639 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[230.0, 230.0, 230.0], powers=[764, -34, -732], currents=[3.3217391304347825, -0.14782608695652175, -3.1826086956521737], power_factors=[0.0, 0.0, 0.0], imported=2857040, exported=1798690, power=0, frequency=49.95)
2023-04-12 20:09:01,736 - {control.bat_all:172} - {DEBUG:MainThread} -  Verbleibende Speicher-Leistung: -774W
2023-04-12 20:09:01,736 - {control.bat_all:177} - {DEBUG:MainThread} - Ladeleistungs-Reserve (200W) subtrahieren: -974
2023-04-12 20:09:01,737 - {control.bat_all:150} - {INFO:MainThread} - -974W verbliebende Speicher-Leistung
2023-04-12 20:09:01,741 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [28.68, 32.15, 35.18]A
2023-04-12 20:09:01,741 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 63000W
2023-04-12 20:09:01,744 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-12 20:09:01,745 - {control.chargepoint:701} - {DEBUG:MainThread} - Phasenzahl Lademodus: 1
2023-04-12 20:09:01,748 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 10A, Lademodus pv_charging, Submodus: Chargemode.INSTANT_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 0.0
2023-04-12 20:09:01,750 - {control.chargepoint:356} - {INFO:MainThread} - LP 4: Keine Ladung, da kein Auto angesteckt ist.
2023-04-12 20:09:01,755 - {control.data:334} - {INFO:MainThread} - bat1
BatData(get=Get(soc=98, daily_exported=134.84, daily_imported=0.0, imported=156650.86, exported=195.38, fault_state=0, fault_str='Kein Fehler.', power=-774))
2023-04-12 20:09:01,756 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=98, daily_exported=134.84, daily_imported=0.0, imported=156650.86, exported=192.86, power=-950), set=Set(charging_power_left=-974, switch_on_soc_reached=True))
2023-04-12 20:09:01,756 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=58622.07, daily_exported=0, power=0, imported=7671462.65, exported=0))
2023-04-12 20:09:01,757 - {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=58622.07, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=5305198.73, phases_in_use=0, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[239.5, 236.6, 238.19]), 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='instant_charging', imported_at_mode_switch=5246546.88, imported_at_plugtime=5246546.88, imported_since_mode_switch=58651.85000000056, imported_since_plugged=58651.85000000056, range_charged=345.01088235294446, time_charged='0:04', timestamp_start_charging='04/12/2023, 20:04:32'), manual_lock=False, phases_to_use=0, plug_state_prev=True, plug_time='04/12/2023, 20:04:22', required_power=2300.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x75b13880>), 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-12 20:09:01,757 - {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.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=[236.69, 237.89, 239.71]), 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 0x710b0e50>), 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-12 20:09:01,760 - {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 20:09:01,762 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=63000), get=Get(powers=[764, -34, -732], currents=[3.32, -0.15, -3.18], voltages=[230.0, 230.0, 230.0], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=49.95, daily_exported=1300, daily_imported=230, imported=2857040, exported=1798690, fault_state=0, fault_str='Kein Fehler.', power=0), set=Set(reserved_surplus=7360, released_surplus=0, raw_power_left=63000, raw_currents_left=[28.68, 32.15, 35.18], surplus_power_left=0, state_str=''))
2023-04-12 20:09:01,763 - {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=1176.0, invalid_home_consumption=0, daily_yield_home_consumption=600.8))
2023-04-12 20:09:01,763 - {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=30, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=6, limit=Limit(selected='none', amount=1000, soc=50))))
2023-04-12 20:09:01,764 - {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=10, required_currents=[0.0, 0.0, 10], phases=1, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch='04/12/2023, 20:08:51', submode=<Chargemode.INSTANT_CHARGING: 'instant_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=2), 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 20:09:01,764 - {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-12 20:09:01,766 - {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-12 20:09:01,766 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-12 20:09:01,766 - {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 20:09:01,767 - {control.data:334} - {INFO:MainThread} - pv2
PvData(config=Config(max_ac_out=6000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=200, monthly_exported=0, yearly_exported=0, exported=725900, fault_state=0, fault_str='Kein Fehler.', power=-13))
2023-04-12 20:09:01,767 - {control.data:334} - {INFO:MainThread} - pv3
PvData(config=Config(max_ac_out=17000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=1480.0, monthly_exported=0, yearly_exported=0, exported=66562992.0, fault_state=0, fault_str='Kein Fehler.', power=-389.0))
2023-04-12 20:09:01,767 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=1680.0, monthly_exported=0, yearly_exported=0, exported=67288892.0, power=-421.0))
2023-04-12 20:09:01,768 - {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-12 12:48:27 +0200 [6e1e8d6e]', 'current_branch': 'master', 'current_branch_commit': '2023-04-12 12:48:27 +0200 [6e1e8d6e]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'datastore_version': 8, 'lastlivevaluesJson': {'timestamp': 1681322931, 'time': '20:08:51', 'grid': -0.148, 'house-power': 1.223, 'charging-all': 0.0, 'pv-all': 0.428, 'cp5-power': 0.0, 'cp4-power': 0.0, 'bat-all-power': -0.633, 'bat-all-soc': 98}, 'module_update_completed': True}
2023-04-12 20:09:01,768 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Solax', 'type': 'solax', 'id': 0, 'configuration': {'modbus_id': 1, 'ip_address': '192.168.0.132'}}
2023-04-12 20:09:01,768 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Solax Zähler', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-12 20:09:01,768 - {control.data:349} - {INFO:MainThread} - component2
{'name': 'Solax Wechselrichter', 'type': 'inverter', 'id': 2, 'configuration': {}}
2023-04-12 20:09:01,769 - {control.data:349} - {INFO:MainThread} - component1
{'name': 'Solax Speicher', 'type': 'bat', 'id': 1, 'configuration': {}}
2023-04-12 20:09:01,771 - {control.data:347} - {INFO:MainThread} - device1
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 1, 'configuration': {'port': 502, 'ip_address': '192.168.0.207'}}
2023-04-12 20:09:01,773 - {control.data:349} - {INFO:MainThread} - component3
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 3, 'configuration': {'modbus_id': 1}}
2023-04-12 20:09:01,774 - {control.data:321} - {INFO:MainThread} - 

2023-04-12 20:09:01,775 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-12 20:09:01,777 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-12 20:09:01,780 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.INSTANT_CHARGING - False, Zähler 0
2023-04-12 20:09:01,781 - {control.counter:157} - {DEBUG:MainThread} - Zähler 0: [28.68, 32.15, 29.18]A verbleibende Ströme, 61620W verbleibende Leistung
2023-04-12 20:09:01,781 - {control.algorithm.common:87} - {INFO:MainThread} - LP5: Stromstärke 6A
2023-04-12 20:09:01,784 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-12 20:09:01,787 - {control.algorithm.filter_chargepoints:118} - {DEBUG:MainThread} - Geordnete Ladepunkte [5]
2023-04-12 20:09:01,788 - {control.algorithm.filter_chargepoints:51} - {INFO:MainThread} - LP 5: Lädt nicht, daher keine weitere Berücksichtigung
2023-04-12 20:09:01,791 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-04-12 20:09:01,791 - {control.counter:441} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-04-12 20:09:01,792 - {control.algorithm.algorithm:46} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-04-12 20:09:01,792 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-12 20:09:01,799 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:01,800 - {control.cp_interruption:29} - {DEBUG:MainThread} - Thread zur CP-Unterbrechung an LP5 gestartet.
2023-04-12 20:09:01,807 - {control.chargepoint:356} - {INFO:MainThread} - LP 5: Control-Pilot-Unterbrechung für 4s.
2023-04-12 20:09:01,809 - {control.chargepoint:676} - {ERROR:MainThread} - Fehler in der Ladepunkt-Klasse von 5
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/control/chargepoint.py", line 617, in initiate_phase_switch
    raise ValueError(str(self.data.set.phases_to_use)+" ist keine gültige Phasenzahl (1/3).")
ValueError: 0 ist keine gültige Phasenzahl (1/3).
2023-04-12 20:09:01,811 - {control.process:115} - {INFO:MainThread} - LP5: set current 0 A, state PERFORMING_PHASE_SWITCH
2023-04-12 20:09:01,823 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:01,824 - {modules.common.component_context:24} - {DEBUG:cp4} - Update Komponente ['Ladepunkt']
2023-04-12 20:09:01,835 - {control.counter:174} - {INFO:MainThread} - 7360W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-12 20:09:02,048 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-12 20:09:10,078 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 20:09:10,079 - {root:61} - {INFO:MainThread} - # ***Start*** 
 

Code: Alles auswählen

atreboot.sh started
LAN/WLAN...
watchdog for atreboot.sh on pid 456 started, waiting for 600s
RTNETLINK answers: Network is unreachable
my primary interface: ens192
my primary IP: "192.168.1.100"
apt configuration already up to date
install required packages with 'apt-get'...
OK:1 http://security.debian.org/debian-security bullseye-security InRelease
OK:2 http://deb.debian.org/debian bullseye InRelease
Holen:3 http://deb.debian.org/debian bullseye-updates InRelease [44,1 kB]
Es wurden 44,1 kB in 0 s geholt (191 kB/s).
Paketlisten werden gelesen…
Paketlisten werden gelesen…
Abhängigkeitsbaum wird aufgebaut…
Statusinformationen werden eingelesen…
bc ist schon die neueste Version (1.07.1-2+b2).
jq ist schon die neueste Version (1.6-2.1).
mosquitto ist schon die neueste Version (2.0.11-1).
mosquitto-clients ist schon die neueste Version (2.0.11-1).
libapache2-mod-php ist schon die neueste Version (2:7.4+76).
php ist schon die neueste Version (2:7.4+76).
php-curl ist schon die neueste Version (2:7.4+76).
php-gd ist schon die neueste Version (2:7.4+76).
php-json ist schon die neueste Version (2:7.4+76).
php-xml ist schon die neueste Version (2:7.4+76).
python3-pip ist schon die neueste Version (20.3.4-4+deb11u1).
socat ist schon die neueste Version (1.7.4.1-3).
sshpass ist schon die neueste Version (1.09-1+b1).
ssl-cert ist schon die neueste Version (1.1.0+nmu1).
vim ist schon die neueste Version (2:8.2.2434-3+deb11u1).
apache2 ist schon die neueste Version (2.4.56-1~deb11u1).
git ist schon die neueste Version (1:2.30.2-1+deb11u2).
sudo ist schon die neueste Version (1.9.5p2-3+deb11u1).
0 aktualisiert, 0 neu installiert, 0 zu entfernen und 22 nicht aktualisiert.
done
openwb.cron already up to date
openwb2.service already up to date
openwbRemoteSupport.service already up to date
no restore pending, normal startup
cleaning obsolete python cache folders...
python cache cleanup done
apache default site...
...ok
checking required apache modules...
headers (enabled by site administrator)
headers already enabled
ssl (enabled by site administrator)
ssl already enabled
proxy_wstunnel (enabled by site administrator)
proxy_wstunnel already enabled
check mosquitto installation...
mosquitto.conf already up to date
mosquitto openwb.conf already up to date
mosquitto_local.conf already up to date
mosquitto openwb_local.conf already up to date
mosquitto done
install required python packages with 'pip3'...
Requirement already satisfied: jq==1.1.3 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 1)) (1.1.3)
Requirement already satisfied: paho_mqtt==1.6.1 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 2)) (1.6.1)
Requirement already satisfied: pymodbus==2.5.2 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 3)) (2.5.2)
Requirement already satisfied: pytest==6.2.5 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 4)) (6.2.5)
Requirement already satisfied: requests_mock==1.9.3 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 5)) (1.9.3)
Requirement already satisfied: lxml==4.9.1 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 6)) (4.9.1)
Requirement already satisfied: aiohttp==3.7.4 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 7)) (3.7.4)
Requirement already satisfied: schedule==1.1.0 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 8)) (1.1.0)
Requirement already satisfied: PyJWT==2.6.0 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 9)) (2.6.0)
Requirement already satisfied: ipparser==0.3.8 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 10)) (0.3.8)
Requirement already satisfied: bs4==0.0.1 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 11)) (0.0.1)
Requirement already satisfied: pkce==1.0.3 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 12)) (1.0.3)
Requirement already satisfied: skodaconnect==1.3.4 in /home/openwb/.local/lib/python3.9/site-packages (from -r /var/www/html/openWB/requirements.txt (line 13)) (1.3.4)
Requirement already satisfied: chardet<4.0,>=2.0 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (3.0.4)
Requirement already satisfied: async-timeout<4.0,>=3.0 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (3.0.1)
Requirement already satisfied: multidict<7.0,>=4.5 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (6.0.4)
Requirement already satisfied: typing-extensions>=3.6.5 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (4.4.0)
Requirement already satisfied: yarl<2.0,>=1.0 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (1.8.2)
Requirement already satisfied: attrs>=17.3.0 in /home/openwb/.local/lib/python3.9/site-packages (from aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (22.2.0)
Requirement already satisfied: beautifulsoup4 in /home/openwb/.local/lib/python3.9/site-packages (from bs4==0.0.1->-r /var/www/html/openWB/requirements.txt (line 11)) (4.11.2)
Requirement already satisfied: dnspython in /home/openwb/.local/lib/python3.9/site-packages (from ipparser==0.3.8->-r /var/www/html/openWB/requirements.txt (line 10)) (2.3.0)
Requirement already satisfied: pyserial>=3.4 in /home/openwb/.local/lib/python3.9/site-packages (from pymodbus==2.5.2->-r /var/www/html/openWB/requirements.txt (line 3)) (3.5)
Requirement already satisfied: six>=1.15.0 in /usr/lib/python3/dist-packages (from pymodbus==2.5.2->-r /var/www/html/openWB/requirements.txt (line 3)) (1.16.0)
Requirement already satisfied: pluggy<2.0,>=0.12 in /home/openwb/.local/lib/python3.9/site-packages (from pytest==6.2.5->-r /var/www/html/openWB/requirements.txt (line 4)) (1.0.0)
Requirement already satisfied: toml in /home/openwb/.local/lib/python3.9/site-packages (from pytest==6.2.5->-r /var/www/html/openWB/requirements.txt (line 4)) (0.10.2)
Requirement already satisfied: iniconfig in /home/openwb/.local/lib/python3.9/site-packages (from pytest==6.2.5->-r /var/www/html/openWB/requirements.txt (line 4)) (2.0.0)
Requirement already satisfied: packaging in /home/openwb/.local/lib/python3.9/site-packages (from pytest==6.2.5->-r /var/www/html/openWB/requirements.txt (line 4)) (23.0)
Requirement already satisfied: py>=1.8.2 in /home/openwb/.local/lib/python3.9/site-packages (from pytest==6.2.5->-r /var/www/html/openWB/requirements.txt (line 4)) (1.11.0)
Requirement already satisfied: requests<3,>=2.3 in /usr/lib/python3/dist-packages (from requests_mock==1.9.3->-r /var/www/html/openWB/requirements.txt (line 5)) (2.25.1)
Requirement already satisfied: cryptography in /home/openwb/.local/lib/python3.9/site-packages (from skodaconnect==1.3.4->-r /var/www/html/openWB/requirements.txt (line 13)) (40.0.1)
Requirement already satisfied: idna>=2.0 in /usr/lib/python3/dist-packages (from yarl<2.0,>=1.0->aiohttp==3.7.4->-r /var/www/html/openWB/requirements.txt (line 7)) (2.10)
Requirement already satisfied: soupsieve>1.2 in /home/openwb/.local/lib/python3.9/site-packages (from beautifulsoup4->bs4==0.0.1->-r /var/www/html/openWB/requirements.txt (line 11)) (2.3.2.post1)
Requirement already satisfied: cffi>=1.12 in /home/openwb/.local/lib/python3.9/site-packages (from cryptography->skodaconnect==1.3.4->-r /var/www/html/openWB/requirements.txt (line 13)) (1.15.1)
Requirement already satisfied: pycparser in /home/openwb/.local/lib/python3.9/site-packages (from cffi>=1.12->cryptography->skodaconnect==1.3.4->-r /var/www/html/openWB/requirements.txt (line 13)) (2.21)
done
load versions...
chgrp: Zugriff auf '/var/www/html/openWB/data/restore/*' nicht möglich: Datei oder Verzeichnis nicht gefunden
chmod: Zugriff auf '/var/www/html/openWB/data/restore/*' nicht möglich: Datei oder Verzeichnis nicht gefunden
2023-04-12 12:53:23: boot done :-)
2023-04-12 12:53:23,313 - {root:117} - {DEBUG:MainThread} - Start openWB2.service
2023-04-12 12:53:23,313 - {helpermodules.update_config:325} - {DEBUG:MainThread} - Broker-Konfiguration aktualisieren
2023-04-12 12:53:24,343 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/chargepoint/5/set/plug_state_prev
2023-04-12 12:53:24,344 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/chargepoint/5/get/power_factors
2023-04-12 12:53:24,345 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/counter/0/set/reserved_surplus
2023-04-12 12:53:24,345 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/counter/0/set/released_surplus
2023-04-12 12:53:24,353 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/vehicle/set/vehicle_update_completed
2023-04-12 12:53:24,359 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/command_completed
2023-04-12 12:53:24,359 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_51f461c6/messages/1681197565207
2023-04-12 12:53:24,359 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_51f461c6/messages/1681197566123
2023-04-12 12:53:24,359 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_51f461c6/messages/1681197586161
2023-04-12 12:53:24,360 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_ee326b5f/messages/1681216000429
2023-04-12 12:53:24,360 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_ee326b5f/messages/1681216001118
2023-04-12 12:53:24,360 - {helpermodules.update_config:353} - {DEBUG:MainThread} - Ungültiges Topic zum Startzeitpunkt: openWB/command/mqttjs_1e882110/messages/1681296786286
2023-04-12 12:53:26,898 - {modules.common.component_context:24} - {DEBUG:Thread-5} - Update Komponente ['Ladepunkt']
2023-04-12 12:53:26,899 - {urllib3.connectionpool:227} - {DEBUG:Thread-5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-12 12:53:26,919 - {urllib3.connectionpool:452} - {DEBUG:Thread-5} - http://192.168.1.101:80 "POST /connect.php HTTP/1.1" 200 19
2023-04-12 12:53:26,919 - {modules.common.req:11} - {DEBUG:Thread-5} - Get-Response: OK Value:1 accepted
2023-04-12 12:53:26,934 - {helpermodules.subdata:655} - {DEBUG:Thread-5} - skipping mqtt bridge message on startup
2023-04-12 12:53:26,935 - {helpermodules.setdata:43} - {DEBUG:Thread-6} - Subdata initialization completed. Starting setdata loop to broker.
2023-04-12 12:53:27,069 - {modules.devices.solaredge.device:74} - {DEBUG:Thread-5} - Synergy Units: 1
2023-04-12 12:53:27,069 - {modules.devices.solaredge.device:94} - {DEBUG:Thread-5} - SolarEdge Zähler: internal meter id: 1, synergy units: 1
2023-04-12 12:53:27,075 - {modules.devices.solaredge.device:74} - {DEBUG:Thread-5} - Synergy Units: 1
2023-04-12 12:53:27,150 - {helpermodules.subdata:677} - {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 641, 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-12 12:53:27,198 - {helpermodules.subdata:677} - {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 641, 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-12 12:53:27,206 - {modules.devices.solaredge.device:74} - {DEBUG:Thread-5} - Synergy Units: 1
2023-04-12 12:53:27,206 - {modules.devices.solaredge.device:94} - {DEBUG:Thread-5} - SolarEdge Zähler: internal meter id: 1, synergy units: 1
2023-04-12 12:53:33,165 - {helpermodules.command:110} - {DEBUG:Thread-7} - Befehl: {'command': 'systemFetchVersions', 'data': {}}, Connection-ID: mqttjs_1e882110
2023-04-12 12:53:33,165 - {helpermodules.command:581} - {INFO:Thread-7} - Fetch versions requested
2023-04-12 12:53:33,165 - {helpermodules.messaging:42} - {DEBUG:Thread-7} - pub_message: message: 'Versionsliste wird aktualisiert...' type: 'MessageType.INFO' target: 'MessageTarget.USER'
2023-04-12 12:53:33,165 - {helpermodules.messaging:62} - {DEBUG:Thread-7} - Befehl erfolgreich ausgeführt: Versionsliste wird aktualisiert...
2023-04-12 12:53:33,865 - {helpermodules.messaging:42} - {DEBUG:Thread-7} - pub_message: message: 'Versionsliste erfolgreich aktualisiert.' type: 'MessageType.SUCCESS' target: 'MessageTarget.USER'
2023-04-12 12:53:33,865 - {helpermodules.messaging:62} - {DEBUG:Thread-7} - Befehl erfolgreich ausgeführt: Versionsliste erfolgreich aktualisiert.
2023-04-12 12:53:40,909 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-12 12:53:40,910 - {root:61} - {INFO:MainThread} - # ***Start*** 

Code: Alles auswählen

2023-04-14 08:01:16,919 - {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-14 08:01:16,919 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-14 08:01:16,921 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-14 08:01:16,921 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-14 08:01:16,921 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-14 08:01:16,926 - {modules.common.utils.component_parser:24} - {ERROR:MainThread} - Keine aktuellen Werte für Gerät SolarEdge
2023-04-14 08:53:30,195 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x7f88b65cd7f0>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x7f88b4d7a670>, 'component3': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f88b4d7aaf0>, 'component4': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f88b4d7aa60>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x7f88b4d7d2e0>}
2023-04-14 08:53:30,196 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-14 08:53:30,197 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.1.101:80
2023-04-14 08:53:30,214 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.1.101:80 "GET /connect.php HTTP/1.1" 200 354
2023-04-14 08:53:30,215 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: {"date":"2023:04:14-06:53:30","timestamp":1681455210,"powers":[2482.1,4.4,6.6],"power_all":2484.2,"currents":[11.151,0.03,0.035],"imported":1476893,"exported":2075,"plug_state":true,"charge_state":true,"phases_actual":1,"phases_target":1,"phases_in_use":1,"offered_current":12.4,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"479411"}
2023-04-14 08:53:30,215 - {modules.common.store._api:26} - {DEBUG:cp5} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[11.151, 0.03, 0.035], power_factors=[0.0, 0.0, 0.0], imported=1476893, exported=2075, power=2484.2, phases_in_use=1, charge_state=True, plug_state=True, rfid=None)
2023-04-14 08:53:30,819 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-04-14 08:53:30,872 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [287, -5219, 2635, 2870], Scale 0
2023-04-14 08:53:30,879 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [225, 0, 0], Scale -1
2023-04-14 08:53:30,889 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23265, 23927, 23876, -24503, -24665, -24136, -24709], Scale -2
2023-04-14 08:53:30,896 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4993], Scale -2
2023-04-14 08:53:30,915 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [9955, -9997, -9998], Scale -2
2023-04-14 08:53:30,929 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [44059528, 19695450, 21239744, 17894898, 20127824, 14810987, 11658185, 8429214], Scale 0
2023-04-14 08:53:30,929 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[232.65, 239.27, 238.76], powers=[5219.0, -2635.0, -2870.0], currents=[22.5, 0.0, 0.0], power_factors=[0.9954999999999999, -0.9997, -0.9998], imported=20127824.0, exported=44059528.0, power=-287.0, frequency=49.93)
2023-04-14 08:53:30,931 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-04-14 08:53:30,953 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681455190.4666543, power=4999.0, imported=55983.939316018994, exported=48709.73208035074)
2023-04-14 08:53:30,953 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00569085, power1: 4999, power2: 5001
2023-04-14 08:53:30,953 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 28.4543
2023-04-14 08:53:30,954 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 28.4543 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681455210.9537158, power=5001.0, imported=56012.39356810309, exported=48709.73208035074)
2023-04-14 08:53:30,954 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=56012.39356810309, exported=48709.73208035074, power=5001.0, soc=80.99199676513672)
2023-04-14 08:53:30,956 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-14 08:53:31,036 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [28980], Scale -1
2023-04-14 08:53:31,132 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [31549996], Scale 0
2023-04-14 08:53:31,191 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [12148, 65535, 65535], Scale -3
2023-04-14 08:53:31,239 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [29421], Scale -1
2023-04-14 08:53:31,240 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [12.148, 0, 0]
2023-04-14 08:53:31,240 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[12.148, 0, 0], power=-2898.0, exported=31549996.0, dc_power=-2942.1000000000004)
2023-04-14 08:53:31,240 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-14 08:53:31,287 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [29671], Scale -1
2023-04-14 08:53:31,366 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23587208], Scale 0
2023-04-14 08:53:31,435 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [1245, 65535, 65535], Scale -2
2023-04-14 08:53:31,545 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [3011], Scale 0
2023-04-14 08:53:31,545 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [12.450000000000001, 0, 0]
2023-04-14 08:53:31,545 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[12.450000000000001, 0, 0], power=-2967.1000000000004, exported=23587208.0, dc_power=-3011.0)
2023-04-14 08:53:31,546 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-14 08:53:31,571 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-21150], Scale -1
2023-04-14 08:53:31,593 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [35870436], Scale 0
2023-04-14 08:53:31,620 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [9234, 65535, 65535], Scale -3
2023-04-14 08:53:31,626 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-21472], Scale -1
2023-04-14 08:53:31,626 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[9.234, 0, 0], power=2115.0, exported=35870436.0, dc_power=2147.2000000000003)
2023-04-14 08:53:31,628 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-04-14 08:53:31,628 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=56012.39356810309, exported=48709.73208035074, power=5001.0, soc=80.99199676513672)
2023-04-14 08:53:31,632 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter 1']
2023-04-14 08:53:31,632 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-2886.0, exported=35877738.66, dc_power=None)
2023-04-14 08:53:31,632 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-2886.0, exported=35877738.66, dc_power=None)
2023-04-14 08:53:31,632 - {modules.common.component_context:24} - {DEBUG:component3} - Update Komponente ['SolarEdge Wechselrichter 2']
2023-04-14 08:53:31,632 - {modules.common.store._api:26} - {DEBUG:component3} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-2898.0, exported=31549996.0, dc_power=None)
2023-04-14 08:53:31,632 - {modules.common.store._api:30} - {INFO:component3} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-2898.0, exported=31549996.0, dc_power=None)
2023-04-14 08:53:31,633 - {modules.common.component_context:24} - {DEBUG:component4} - Update Komponente ['SolarEdge Wechselrichter 3']
2023-04-14 08:53:31,633 - {modules.common.store._api:26} - {DEBUG:component4} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-2967.1000000000004, exported=23587208.0, dc_power=None)
2023-04-14 08:53:31,633 - {modules.common.store._api:30} - {INFO:component4} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-2967.1000000000004, exported=23587208.0, dc_power=None)
2023-04-14 08:53:31,633 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-14 08:53:31,636 - {modules.common.store._api:30} - {INFO:cp5} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[11.151, 0.03, 0.035], power_factors=[0.0, 0.0, 0.0], imported=1476893, exported=2075, power=2484.2, phases_in_use=1, charge_state=True, plug_state=True, rfid=None)
2023-04-14 08:53:31,641 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-04-14 08:53:31,641 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[232.65, 239.27, 238.76], powers=[5219.0, -2635.0, -2870.0], currents=[22.5, 0.0, 0.0], power_factors=[0.9954999999999999, -0.9997, -0.9998], imported=20127824.0, exported=44059528.0, power=-287.0, frequency=49.93)
2023-04-14 08:53:31,651 - {control.bat_all:164} - {INFO:MainThread} - -50W verbleibende Speicher-Leistung
2023-04-14 08:53:31,651 - {control.counter:126} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [20.65, 32.03, 32.04]A
2023-04-14 08:53:31,652 - {control.counter:149} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 26771.2W
2023-04-14 08:53:31,652 - {control.chargepoint:718} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-04-14 08:53:31,652 - {control.chargepoint:701} - {DEBUG:MainThread} - Phasenzahl Lademodus: 1
2023-04-14 08:53:31,652 - {control.chargepoint:897} - {INFO:MainThread} - LP 5, EV: Renault ZOE (EV-Nr.1): Theoretisch benötigter Strom 10A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 11.15
2023-04-14 08:53:31,652 - {control.data:334} - {INFO:MainThread} - bat2
BatData(get=Get(soc=80, daily_exported=4241.1, daily_imported=6193.1, imported=56012.39, exported=48709.73, fault_state=0, fault_str='Kein Fehler.', power=5001.0))
2023-04-14 08:53:31,652 - {control.data:305} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=80, daily_exported=4241.1, daily_imported=6193.1, imported=55983.94, exported=48709.73, power=4999.0), set=Set(charging_power_left=-50, switch_on_soc_reached=True))
2023-04-14 08:53:31,652 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=479, daily_exported=1, power=2484.2, imported=1476893, exported=2075))
2023-04-14 08:53:31,653 - {control.data:334} - {INFO:MainThread} - cp5
ChargepointData(get=Get(charge_state=True, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=36.0), currents=[11.15, 0.03, 0.04], daily_imported=479, daily_exported=1, exported=2075, fault_str='Kein Fehler.', fault_state=0, imported=1476893, phases_in_use=1, plug_state=True, power=2484.2, 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=12.47, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='pv_charging', imported_at_mode_switch=1476234, imported_at_plugtime=1476234, imported_since_mode_switch=644, imported_since_plugged=644, range_charged=3.788235294117647, time_charged='0:15', timestamp_start_charging='04/14/2023, 08:38:12'), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='04/13/2023, 23:28:35', required_power=2300.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x7f88b44654f0>), 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-14 08:53:31,653 - {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-14 08:53:31,653 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[32, 32, 32], max_total_power=24000), get=Get(powers=[5219.0, -2635.0, -2870.0], currents=[22.5, 0.0, 0.0], voltages=[232.65, 239.27, 238.76], power_factors=[1.0, -1.0, -1.0], unbalanced_load=0, frequency=49.93, daily_exported=472.0, daily_imported=225.0, imported=20127824.0, exported=44059528.0, fault_state=0, fault_str='Kein Fehler.', power=-287.0), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=26771.2, raw_currents_left=[20.65, 32.03, 32.04], surplus_power_left=0, state_str=''))
2023-04-14 08:53:31,653 - {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': 

Code: Alles auswählen

2023-04-14 09:18:14,486 - {control.algorithm.algorithm:27} - {INFO:MainThread} - # Algorithmus
2023-04-14 09:18:14,487 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Mindestrom setzen**
2023-04-14 09:18:14,497 - {control.algorithm.algorithm:35} - {INFO:MainThread} - **Sollstrom setzen**
2023-04-14 09:18:14,508 - {control.counter:186} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-04-14 09:18:14,510 - {control.counter:442} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-04-14 09:18:14,511 - {control.algorithm.algorithm:46} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-04-14 09:18:14,512 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-04-14 09:18:14,522 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-14 09:18:14,540 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.110.145:80
2023-04-14 09:18:14,569 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.110.145:80 "GET /setCurrent?current=0 HTTP/1.1" 200 29
2023-04-14 09:18:14,577 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: S0_set current to given value
2023-04-14 09:18:14,580 - {control.counter:174} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-04-14 09:18:14,864 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-04-14 09:18:20,024 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-04-14 09:18:20,025 - {root:61} - {INFO:MainThread} - # ***Start*** 
2023-04-14 09:18:20,079 - {modules.devices.carlo_gavazzi.device:47} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.carlo_gavazzi.counter.CarloGavazziCounter object at 0x7228e6d0>}
2023-04-14 09:18:20,080 - {modules.common.component_context:51} - {DEBUG:device4} - Update Komponenten ['PV1_Süd_Json-WR']
2023-04-14 09:18:20,080 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['Carlo Gavazzi EVU-Punkt']
2023-04-14 09:18:20,081 - {modules.common.component_context:51} - {DEBUG:device5} - Update Komponenten ['PV2_Dach_MQTT']
2023-04-14 09:18:20,084 - {modules.common.component_context:51} - {DEBUG:device6} - Update Komponenten ['PV3_Garage_Json-WR']
2023-04-14 09:18:20,091 - {urllib3.connectionpool:227} - {DEBUG:device4} - Starting new HTTP connection (1): 192.168.110.151:80
2023-04-14 09:18:20,091 - {modules.devices.mqtt.device:47} - {DEBUG:device5} - MQTT-Module müssen nicht ausgelesen werden.
2023-04-14 09:18:20,091 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-14 09:18:20,100 - {urllib3.connectionpool:227} - {DEBUG:device6} - Starting new HTTP connection (1): 192.168.110.152:80
2023-04-14 09:18:20,113 - {urllib3.connectionpool:227} - {DEBUG:cp5} - Starting new HTTP connection (1): 192.168.110.145:80
2023-04-14 09:18:20,154 - {urllib3.connectionpool:452} - {DEBUG:cp5} - http://192.168.110.145:80 "GET /getParameters HTTP/1.1" 200 414
2023-04-14 09:18:20,157 - {modules.common.req:11} - {DEBUG:cp5} - Get-Response: {"type":"parameters","list":[{"vehicleState":1,"evseState":false,"maxCurrent":20,"actualCurrent":0,"actualCurrentMA":0,"actualPower":0,"duration":1855000,"alwaysActive":true,"lastActionUser":"vehicle","lastActionUID":"vehicle","energy":0.67,"mileage":3.3,"meterReading":3280.68,"currentP1":0,"currentP2":0,"currentP3":0,"voltageP1":234.5727,"voltageP2":235.2957,"voltageP3":233.8571,"useMeter":true,"RFIDUID":""}]}
2023-04-14 09:18:20,158 - {modules.common.store._api:26} - {DEBUG:cp5} - Raw data ChargepointState(voltages=[234.5727, 235.2957, 233.8571], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=3280680.0, exported=0, power=0, phases_in_use=1, charge_state=False, plug_state=False, rfid=None)
2023-04-14 09:18:20,189 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1681456692.5960987, power=108.80000000000001, imported=3896799.972177094, exported=1834542.134028329)
2023-04-14 09:18:20,190 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00210931, power1: 108.8, power2: 113.4
2023-04-14 09:18:20,191 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0.234344
2023-04-14 09:18:20,191 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0.234344 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1681456700.1896074, power=113.39999999999999, imported=3896800.2065212103, exported=1834542.134028329)
2023-04-14 09:18:20,194 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[234.5, 234.9, 234.1], powers=[-82.2, 74.5, 121.1], currents=[-0.705, 0.359, 2.272], power_factors=[0.0, 0.0, 0.0], imported=3896800.2065212103, exported=1834542.134028329, power=113.39999999999999, frequency=50.0)
2023-04-14 09:18:20,261 - {urllib3.connectionpool:452} - {DEBUG:device6} - http://192.168.110.152:80 "GET /cm?cmnd=status%208 HTTP/1.1" 200 None
2023-04-14 09:18:20,266 - {modules.common.req:11} - {DEBUG:device6} - Get-Response: {"StatusSNS":{"Time":"2023-04-14T08:18:19","ENERGY":{"TotalStartTime":"2023-03-29T09:15:00","Total":31.155,"Yesterday":4.336,"Today":0.104,"Power":83,"ApparentPower":91,"ReactivePower":38,"Factor":0.91,"Voltage":232,"Current":0.393}}}
2023-04-14 09:18:21,793 - {urllib3.connectionpool:452} - {DEBUG:device4} - http://192.168.110.151:80 "GET /cm?cmnd=status%208 HTTP/1.1" 200 None
2023-04-14 09:18:21,795 - {modules.common.store._api:26} - {DEBUG:device6} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-83.0, exported=31155.0, dc_power=None)
2023-04-14 09:18:21,799 - {modules.common.req:11} - {DEBUG:device4} - Get-Response: {"StatusSNS":{"Time":"2023-04-14T08:18:20","ENERGY":{"TotalStartTime":"2021-08-15T19:55:58","Total":925.857,"Yesterday":2.273,"Today":0.037,"Power":38,"ApparentPower":43,"ReactivePower":21,"Factor":0.88,"Voltage":236,"Current":0.183}}}
2023-04-14 09:18:23,341 - {modules.common.store._api:26} - {DEBUG:device4} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-38.0, exported=925857.0, dc_power=None)
2023-04-14 09:18:23,349 - {modules.loadvars:75} - {ERROR:MainThread} - Fehler im loadvars-Modul bei Element {'type': 'cp', 'id': 11}
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/modules/loadvars.py", line 62, in _update_values_of_level
    chargepoint = data.data.cp_data[f'{type_to_topic_mapping(element["type"])}{element["id"]}']
KeyError: 'cp11'
2023-04-14 09:18:23,352 - {modules.common.component_context:24} - {DEBUG:cp5} - Update Komponente ['Ladepunkt']
2023-04-14 09:18:23,354 - {modules.common.store._api:30} - {INFO:cp5} - Saving ChargepointState(voltages=[234.5727, 235.2957, 233.8571], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=3280680.0, exported=0, power=0, phases_in_use=1, charge_state=False, plug_state=False, rfid=None)
2023-04-14 09:18:23,355 - {modules.common.component_context:24} - {DEBUG:component10} - Update Komponente ['PV1_Süd_Json-WR']
2023-04-14 09:18:23,361 - {modules.common.component_context:24} - {DEBUG:component12} - Update Komponente ['PV2_Dach_MQTT']
2023-04-14 09:18:23,362 - {modules.common.store._api:26} - {DEBUG:component10} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-38.0, exported=925857.0, dc_power=None)
2023-04-14 09:18:23,363 - {modules.common.component_context:24} - {DEBUG:component13} - Update Komponente ['PV3_Garage_Json-WR']
2023-04-14 09:18:23,370 - {modules.common.store._api:26} - {DEBUG:component13} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-83.0, exported=31155.0, dc_power=None)
2023-04-14 09:18:23,371 - {modules.common.store._api:30} - {INFO:component13} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-83.0, exported=31155.0, dc_power=None)
2023-04-14 09:18:23,367 - {modules.common.store._api:30} - {INFO:component10} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-38.0, exported=925857.0, dc_power=None)
2023-04-14 09:18:23,464 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['Carlo Gavazzi EVU-Punkt']
2023-04-14 09:18:23,465 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[234.5, 234.9, 234.1], powers=[-82.2, 74.5, 121.1], currents=[-0.705, 0.359, 2.272], power_factors=[0.0, 0.0, 0.0], imported=3896800.2065212103, exported=1834542.134028329, power=113.39999999999999, frequency=50.0)
2023-04-14 09:18:23,631 - {control.counter:96} - {ERROR:MainThread} - Fehler in der Zähler-Klasse von 0
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/control/counter.py", line 89, in setup_counter
    self._set_loadmanagement_state()
  File "/var/www/html/openWB/packages/control/counter.py", line 106, in _set_loadmanagement_state
    data.data.cp_data[cp].data.set.loadmanagement_available = True
KeyError: 'cp11'
2023-04-14 09:18:23,655 - {control.chargepoint:356} - {INFO:MainThread} - LP 5: Keine Ladung, da kein Auto angesteckt ist.
2023-04-14 09:18:23,662 - {control.counter_all:121} - {ERROR:MainThread} - Fehler in der allgemeinen Zähler-Klasse
Traceback (most recent call last):
  File "/var/www/html/openWB/packages/control/counter_all.py", line 92, in set_home_consumption
    home_consumption, elements = self._calc_home_consumption()
  File "/var/www/html/openWB/packages/control/counter_all.py", line 128, in _calc_home_consumption
    power += data.data.cp_data[f"cp{element['id']}"].data.get.power
KeyError: 'cp11'
2023-04-14 09:18:23,670 - {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-14 09:18:23,671 - {control.data:306} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0.0, daily_exported=0, power=0, imported=3280680.0, exported=0))
2023-04-14 09:18:23,672 - {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=90), currents=[0, 0, 0], daily_imported=0.0, daily_exported=0, exported=0, fault_str='Kein Fehler.', fault_state=0, imported=3280680.0, phases_in_use=1, plug_state=False, power=0, rfid_timestamp=None, rfid=None, state_str='Keine Ladung, da kein Auto angesteckt ist.', voltages=[234.57, 235.3, 233.86]), set=Set(change_ev_permitted=[True, ''], 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=1, plug_state_prev=False, plug_time=None, required_power=0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x71098538>), config=Config(connection_module={'type': 'smartwb', 'name': 'smartWB / EVSE-Wifi (>= v1.x.x/v2.x.x)', 'configuration': {'ip_address': '192.168.110.145', 'timeout': 2}}, power_module={}, ev=1, name='smartWB WLAN 20A', type='smartwb', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=False, control_pilot_interruption_hw=True, id=5))
2023-04-14 09:18:23,674 - {control.data:334} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={'0': AutolockPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['07:00', '16:00'], name='Standard Autolock-Plan')}, 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-14 09:18:23,676 - {control.data:334} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[35, 35, 35], max_total_power=25000), get=Get(powers=[-82.2, 74.5, 121.1], currents=[-0.7, 0.36, 2.27], voltages=[234.5, 234.9, 234.1], power_factors=[0.0, 0.0, 0.0], unbalanced_load=0, frequency=50.0, daily_exported=248.4334760652, daily_imported=10450.6575062713, imported=3896800.2065212103, exported=1834542.134028329, fault_state=0, fault_str='Kein Fehler.', power=113.39999999999999), set=Set(reserved_surplus=0, released_surplus=0, raw_power_left=0, raw_currents_left=[0.0, 0.0, 0.0], surplus_power_left=0, state_str=''))
2023-04-14 09:18:23,678 - {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': 5, 'type': 'cp', 'children': []}, {'id': 11, 'type': 'cp', 'children': []}, {'id': 10, 'type': 'inverter', 'children': []}, {'id': 12, 'type': 'inverter', 'children': []}, {'id': 13, 'type': 'inverter', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=404.8, invalid_home_consumption=0, daily_yield_home_consumption=46074.2304461331))
2023-04-14 09:18:23,681 - {control.data:334} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=False, plans={'5': TimeChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['03:45', '06:30'], name='Zeitladen-Standard', current=16, limit=Limit(selected='none', amount=1000, soc=70))}), chargemode=Chargemode(selected='instant_charging', pv_charging=PvCharging(min_soc_current=12, min_current=0, feed_in_limit=False, min_soc=0, max_soc=95), scheduled_charging=ScheduledCharging(plans={'3': ScheduledChargingPlan(active=False, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=16, name='Zielladen-Standard', limit=ScheduledLimit(selected='soc', amount=20000, soc_limit=100, soc_scheduled=85), time='06:30')}), instant_charging=InstantCharging(current=20, limit=Limit(selected='none', amount=15000, soc=90))))
2023-04-14 09:18:23,682 - {control.data:334} - {INFO:MainThread} - ct1
ChargeTemplateData(name='Ladeprofil i3_Mama', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=False, plans={'4': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2022-11-20', '2022-11-20'], weekly=[False, False, False, False, False, False, False]), time=['06:45', '07:15'], name='Morgensladen', current=12, limit=Limit(selected='none', amount=1000, soc=90))}), chargemode=Chargemode(selected='scheduled_charging', pv_charging=PvCharging(min_soc_current=12, min_current=0, feed_in_limit=False, min_soc=0, max_soc=95), scheduled_charging=ScheduledCharging(plans={'1': ScheduledChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), current=14, name='Zielladen', limit=ScheduledLimit(selected='soc', amount=4000, soc_limit=95, soc_scheduled=85), time='06:00')}), instant_charging=InstantCharging(current=20, limit=Limit(selected='none', amount=6000, soc=90))))
2023-04-14 09:18:23,685 - {control.data:334} - {INFO:MainThread} - ct2
ChargeTemplateData(name='Ladeprofil Tesla_Papa', disable_after_unplug=False, prio=True, load_default=False, time_charging=TimeCharging(active=True, plans={'6': TimeChargingPlan(active=True, frequency=Frequency(selected='daily', once=['2021-11-01', '2021-11-05'], weekly=[False, False, False, False, False, False, False]), time=['03:45', '06:30'], name='Morgensladen_Tesla', current=16, limit=Limit(selected='none', amount=1000, soc=50))}), chargemode=Chargemode(selected='standby', pv_charging=PvCharging(min_soc_current=12, min_current=0, feed_in_limit=False, min_soc=0, max_soc=95), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=20000, soc=100))))
2023-04-14 09:18:23,686 - {control.data:334} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=20, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=20, battery_capacity=82, nominal_difference=2, 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=1, prio=True, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-04-14 09:18:23,687 - {control.data:334} - {INFO:MainThread} - ev1
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='i3_1p', max_current_multi_phases=16, 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=20, min_current=6, max_current_single_phase=32, battery_capacity=16, nominal_difference=2, 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=1, prio=True, 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=1, ev_template=1, name='i3_60Ah_1p_Mama', tag_id=[], get=Get(soc=90, soc_timestamp='04/14/2023, 09:08:25', force_soc_update=False, range=84.0, fault_state=0, fault_str='Kein Fehler.'))
2023-04-14 09:18:23,692 - {control.data:334} - {INFO:MainThread} - ev2
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='i3_1p', max_current_multi_phases=16, 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=20, min_current=6, max_current_single_phase=32, battery_capacity=16, nominal_difference=2, 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=1, prio=True, 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=3, name='Tesla_Papa', tag_id=[], get=Get(soc=88, soc_timestamp='04/08/2023, 18:06:45', force_soc_update=False, range=89.0, fault_state=0, fault_str='Kein Fehler.'))
2023-04-14 09:18:23,694 - {control.data:334} - {INFO:MainThread} - ev3
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='i3_3p', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=18, min_current=6, max_current_single_phase=32, battery_capacity=40, nominal_difference=2, 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=1, prio=True, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=0), charge_template=0, ev_template=2, name='i3_120Ah_3p', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=False, range=0, fault_state=0, fault_str=''))
2023-04-14 09:18:23,696 - {control.data:334} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=20, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17, min_current=6, max_current_single_phase=20, battery_capacity=82, nominal_difference=2, keep_charge_active_duration=40)
2023-04-14 09:18:23,698 - {control.data:334} - {INFO:MainThread} - et1
EvTemplateData(name='i3_60Ah_1p', max_current_multi_phases=16, 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=20, min_current=6, max_current_single_phase=32, battery_capacity=16, nominal_difference=2, keep_charge_active_duration=40)
2023-04-14 09:18:23,699 - {control.data:334} - {INFO:MainThread} - et2
EvTemplateData(name='i3_120Ah_3p', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=19.9, min_current=6, max_current_single_phase=32, battery_capacity=40, nominal_difference=2, keep_charge_active_duration=40)
2023-04-14 09:18:23,699 - {control.data:334} - {INFO:MainThread} - et3
EvTemplateData(name='Tesla_long_range', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=19, min_current=6, max_current_single_phase=32, battery_capacity=78, nominal_difference=2, keep_charge_active_duration=40)
2023-04-14 09:18:23,700 - {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=[0, 230], feed_in_yield=0, phase_switch_delay=7, phases_to_use=3, rundown_power=1000, rundown_soc=50, switch_off_delay=20, switch_off_soc=40, switch_off_threshold=1000, switch_on_delay=5, switch_on_soc=60, switch_on_threshold=900), scheduled_charging=ScheduledCharging(phases_to_use=0), standby=Standby(phases_to_use=3), stop=Stop(phases_to_use=1), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=20, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=False, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.52, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-04-14 09:18:23,702 - {control.data:315} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-04-14 09:18:23,704 - {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-14 09:18:23,705 - {control.data:318} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=False), get=Get(daily_exported=0, monthly_exported=0, yearly_exported=0, exported=0, power=0))
2023-04-14 09:18:23,708 - {control.data:334} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.110.51', 'dataprotection_acknowledged': False, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.102.0', 'lastlivevaluesJson': {'timestamp': 1681456694, 'time': '09:18:14', 'grid': 0.109, 'house-power': 0.405, 'charging-all': 0.0, 'cp5-power': 0.0, 'ev1-soc': 90}, 'current_commit': '2023-04-13 16:41:56 +0200 [9c4e3d7a8]', 'current_missing_commits': [], 'current_branch': 'master', 'current_branch_commit': '2023-04-13 16:41:56 +0200 [9c4e3d7a8]', 'datastore_version': 8, 'module_update_completed': True}
2023-04-14 09:18:23,708 - {control.data:347} - {INFO:MainThread} - device0
{'name': 'Carlo Gavazzi EVU', 'type': 'carlo_gavazzi', 'id': 0, 'configuration': {'ip_address': '192.168.110.11'}}
2023-04-14 09:18:23,709 - {control.data:349} - {INFO:MainThread} - component0
{'name': 'Carlo Gavazzi EVU-Punkt', 'type': 'counter', 'id': 0, 'configuration': {}}
2023-04-14 09:18:23,710 - {control.data:347} - {INFO:MainThread} - device4
{'name': 'PV1_Süd', 'type': 'json', 'id': 4, 'configuration': {'url': 'http://192.168.110.151/cm?cmnd=status%208'}}
2023-04-14 09:18:23,710 - {control.data:349} - {INFO:MainThread} - component10
{'name': 'PV1_Süd_Json-WR', 'type': 'inverter', 'id': 10, 'configuration': {'jq_power': '.StatusSNS.ENERGY.Power', 'jq_exported': '(.StatusSNS.ENERGY.Total)*1000'}}
2023-04-14 09:18:23,711 - {control.data:347} - {INFO:MainThread} - device5
{'name': 'PV2_Dach', 'type': 'mqtt', 'id': 5, 'configuration': {}}
2023-04-14 09:18:23,711 - {control.data:349} - {INFO:MainThread} - component12
{'name': 'PV2_Dach_MQTT', 'type': 'inverter', 'id': 12, 'configuration': {}}
2023-04-14 09:18:23,712 - {control.data:347} - {INFO:MainThread} - device6
{'name': 'PV3_Garage', 'type': 'json', 'id': 6, 'configuration': {'url': 'http://192.168.110.152/cm?cmnd=status%208'}}
2023-04-14 09:18:23,712 - {control.data:349} - {INFO:MainThread} - component13
{'name': 'PV3_Garage_Json-WR', 'type': 'inverter', 'id': 13, 'configuration': {'jq_power': '.StatusSNS.ENERGY.Power', 'jq_exported': '(.StatusSNS.ENERGY.Total)*1000'}}
2023-04-14 09:18:23,713 - {control.data:321} - {INFO:MainThread} -