Obwohl in der Einstellung zum PV-Laden explizit nur 1p eingestellt ist, wurde die Ladung nach dem Anstecken des Fahrzeugs mit 3p gestartet und auch durchgezogen.
Hab dann kurz auf "Stop" gestellt und anschließend erneut den Modus auf PV-Laden gestellt und dann wurde auf einmal die Ladung normal mit 1p gestartet.
Hardware: openWB Pro und Standalone mit Stand Master 2023-07-05 09:19:58 +0200 [39e119495]
Hier der Auszug vom Mainlog, als mit 3p die Ladung begonnen wurde.
Code: Alles auswählen
2023-07-05 14:47:50,826 - {root:64} - {INFO:MainThread} - # ***Start***
2023-07-05 14:47:50,886 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x72408eb0>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x724081a8>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x72401a00>}
2023-07-05 14:47:50,888 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:47:50,897 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:47:50,902 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:47:50,914 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "GET /connect.php HTTP/1.1" 200 322
2023-07-05 14:47:50,917 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: {"date":"2023:07:05-12:47:50","timestamp":1688561270,"powers":[0,0,0],"power_all":0,"currents":[0,0,0],"imported":30758,"exported":12,"plug_state":true,"charge_state":false,"phases_actual":0,"phases_target":3,"phases_in_use":1,"offered_current":0,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"804295"}
2023-07-05 14:47:50,918 - {modules.common.store._api:26} - {DEBUG:cp3} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=30758, exported=12, power=0, phases_in_use=1, charge_state=False, plug_state=True, rfid=None)
2023-07-05 14:47:50,959 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [1468, 420, 548, 499], Scale 0
2023-07-05 14:47:50,979 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [26, 25, 26], Scale -1
2023-07-05 14:47:50,999 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23474, 23479, 23663, 0, 0, 0, 0], Scale -2
2023-07-05 14:47:51,070 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4997], Scale -2
2023-07-05 14:47:51,099 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-6800, -9060, -7979], Scale -2
2023-07-05 14:47:51,121 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4494596, 1330048, 3315331, 2661923, 4156572, 4425447, 900142, 1643691], Scale 0
2023-07-05 14:47:51,121 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[234.74, 234.79, 236.63], powers=[-420.0, -548.0, -499.0], currents=[-2.6, -2.5, -2.6], power_factors=[-0.68, -0.9060000000000001, -0.7979], imported=4156572.0, exported=4494596.0, power=-1468.0, frequency=49.97)
2023-07-05 14:47:51,123 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:47:51,140 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [17360], Scale -1
2023-07-05 14:47:51,160 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [13656979], Scale 0
2023-07-05 14:47:51,179 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [259, 260, 258], Scale -2
2023-07-05 14:47:51,200 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [17624], Scale -1
2023-07-05 14:47:51,200 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [2.59, 2.6, 2.58]
2023-07-05 14:47:51,201 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[2.59, 2.6, 2.58], power=-1736.0, exported=13656979.0, dc_power=-1762.4)
2023-07-05 14:47:51,202 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:47:51,300 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1688561261.1796448, power=0.0, imported=273.2772363344542, exported=169.8480559347779)
2023-07-05 14:47:51,300 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00281124, power1: 0, power2: 0
2023-07-05 14:47:51,301 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-07-05 14:47:51,301 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1688561271.3001215, power=0.0, imported=273.2772363344542, exported=169.8480559347779)
2023-07-05 14:47:51,302 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=273.2772363344542, exported=169.8480559347779, power=0.0, soc=100.0)
2023-07-05 14:47:51,305 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:47:51,307 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=273.2772363344542, exported=169.8480559347779, power=0.0, soc=100.0)
2023-07-05 14:47:51,342 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:47:51,343 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1736.0, exported=13657082.43, dc_power=None)
2023-07-05 14:47:51,344 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:47:51,344 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1736.0, exported=13657082.43, dc_power=None)
2023-07-05 14:47:51,345 - {modules.common.store._api:30} - {INFO:cp3} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0], power_factors=[0.0, 0.0, 0.0], imported=30758, exported=12, power=0, phases_in_use=1, charge_state=False, plug_state=True, rfid=None)
2023-07-05 14:47:51,401 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:47:51,403 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[234.74, 234.79, 236.63], powers=[-420.0, -548.0, -499.0], currents=[-2.6, -2.5, -2.6], power_factors=[-0.68, -0.9060000000000001, -0.7979], imported=4156572.0, exported=4494596.0, power=-1468.0, frequency=49.97)
2023-07-05 14:47:51,530 - {control.bat_all:200} - {DEBUG:MainThread} - Verbleibende Speicher-Leistung: 0.0W
2023-07-05 14:47:51,531 - {control.bat_all:164} - {INFO:MainThread} - 0.0W verbleibende Speicher-Leistung
2023-07-05 14:47:51,533 - {control.counter:138} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [72.6, 72.5, 72.6]A
2023-07-05 14:47:51,533 - {control.counter:161} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 49468.0W
2023-07-05 14:47:51,543 - {control.chargepoint.chargepoint:661} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-07-05 14:47:51,546 - {control.chargepoint.chargepoint:853} - {INFO:MainThread} - LP 3, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 0
2023-07-05 14:47:51,553 - {control.data:337} - {INFO:MainThread} - bat2
BatData(get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=169.85, fault_state=0, fault_str='Kein Fehler.', power=0.0))
2023-07-05 14:47:51,560 - {control.data:307} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=169.85, power=0.0), set=Set(charging_power_left=0.0, switch_on_soc_reached=True))
2023-07-05 14:47:51,562 - {control.data:308} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=30758, daily_exported=12, power=0, imported=30758, exported=12))
2023-07-05 14:47:51,564 - {control.data:337} - {INFO:MainThread} - cp3
ChargepointData(get=Get(charge_state=False, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=0), currents=[0, 0, 0], daily_imported=30758, daily_exported=12, exported=12, fault_str='Kein Fehler.', fault_state=0, imported=30758, phases_in_use=1, plug_state=True, power=0, rfid_timestamp=None, rfid=None, state_str=None, voltages=[0.0, 0.0, 0.0]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=0, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=30758, imported_at_plugtime=30758, 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=True, plug_time='07/05/2023, 14:47:21', required_power=1380.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x71b67298>), config=Config(configuration={'ip_address': '192.168.178.227', 'duo_num': 1}, ev=0, name='openWB Pro', type='openwb_pro', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=3))
2023-07-05 14:47:51,565 - {control.data:337} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=20, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-07-05 14:47:51,570 - {control.data:337} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[70, 70, 70], max_total_power=48000), get=Get(powers=[-420.0, -548.0, -499.0], currents=[-2.6, -2.5, -2.6], voltages=[234.74, 234.79, 236.63], power_factors=[-0.68, -0.91, -0.8], unbalanced_load=0, frequency=49.97, daily_exported=1332.0, daily_imported=15.0, imported=4156572.0, exported=4494596.0, fault_state=0, fault_str='Kein Fehler.', power=-1468.0), set=Set(error_counter=0, reserved_surplus=1400, released_surplus=0, raw_power_left=49468.0, raw_currents_left=[72.6, 72.5, 72.6], surplus_power_left=0, state_str=''))
2023-07-05 14:47:51,571 - {control.data:312} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=268.0, invalid_home_consumption=0, daily_yield_home_consumption=0, disengageable_smarthome_power=0))
2023-07-05 14:47:51,575 - {control.data:337} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=16, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=80))))
2023-07-05 14:47:51,577 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 0.0, 0.0], phases=1, prio=False, timestamp_switch_on_off='07/05/2023, 14:47:21', timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=6), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-05 14:47:51,578 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-05 14:47:51,579 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=0, control_range=[0, 230], feed_in_yield=5000, phase_switch_delay=8, phases_to_use=1, rundown_power=0, rundown_soc=100, switch_off_delay=300, switch_off_soc=0, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=0, switch_on_threshold=1400), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.3, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-05 14:47:51,580 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-05 14:47:51,581 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-05 14:47:51,581 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x72408358>), led=Led(active=False), rfid=Rfid(active=True))
2023-07-05 14:47:51,585 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=10000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657082.43, fault_state=0, fault_str='Kein Fehler.', power=-1736.0))
2023-07-05 14:47:51,586 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657082.43, power=-1736.0))
2023-07-05 14:47:51,587 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '1000', 'current_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_branch': 'master', 'current_branch_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 14, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1688561261, 'time': '14:47:41', 'grid': -1.463, 'house-power': 0.259, 'charging-all': 0.0, 'pv-all': 1.722, 'cp3-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-07-05 14:47:51,588 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.178.224'}}
2023-07-05 14:47:51,588 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2023-07-05 14:47:51,589 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2023-07-05 14:47:51,589 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2023-07-05 14:47:51,589 - {control.data:324} - {INFO:MainThread} -
2023-07-05 14:47:51,590 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-05 14:47:51,594 - {control.chargepoint.chargepoint:271} - {INFO:MainThread} - LP 3: Einschaltschwelle von 1400W für die Dauer der Einschaltverzögerung überschritten.
2023-07-05 14:47:51,597 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-05 14:47:51,600 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - False, Zähler 0
2023-07-05 14:47:51,602 - {control.counter:169} - {DEBUG:MainThread} - Zähler 0: [66.6, 72.5, 72.6]A verbleibende Ströme, 48088.0W verbleibende Leistung
2023-07-05 14:47:51,603 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 6A
2023-07-05 14:47:51,604 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-05 14:47:51,608 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-07-05 14:47:51,612 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-07-05 14:47:51,615 - {control.algorithm.algorithm:44} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-07-05 14:47:51,620 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-05 14:47:51,626 - {control.process:115} - {INFO:MainThread} - LP3: set current 6 A, state CHARGING_ALLOWED
2023-07-05 14:47:51,635 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:47:51,654 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:47:51,679 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "POST /connect.php HTTP/1.1" 200 19
2023-07-05 14:47:51,683 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: OK Value:6 accepted
2023-07-05 14:47:51,687 - {control.counter:186} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 0W freigegebene EVU-Leistung
2023-07-05 14:47:51,889 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-05 14:47:51,920 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:47:55,960 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:48:00,975 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-07-05 14:48:00,976 - {root:64} - {INFO:MainThread} - # ***Start***
2023-07-05 14:48:01,033 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x72408eb0>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x724081a8>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x72401a00>}
2023-07-05 14:48:01,034 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:01,042 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:48:01,044 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:48:01,059 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "GET /connect.php HTTP/1.1" 200 343
2023-07-05 14:48:01,062 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: {"date":"2023:07:05-12:48:01","timestamp":1688561281,"powers":[1380.1,1390.4,1406],"power_all":4176.5,"currents":[0,0,0.548],"imported":30760,"exported":12,"plug_state":true,"charge_state":true,"phases_actual":3,"phases_target":3,"phases_in_use":1,"offered_current":6,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"804295"}
2023-07-05 14:48:01,063 - {modules.common.store._api:26} - {DEBUG:cp3} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0.548], power_factors=[0.0, 0.0, 0.0], imported=30760, exported=12, power=4176.5, phases_in_use=1, charge_state=True, plug_state=True, rfid=None)
2023-07-05 14:48:01,070 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-2726, -981, -836, -909], Scale 0
2023-07-05 14:48:01,089 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [25, 25, 26], Scale -1
2023-07-05 14:48:01,120 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23483, 23486, 23692, 0, 0, 0, 0], Scale -2
2023-07-05 14:48:01,139 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4997], Scale -2
2023-07-05 14:48:01,160 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-6840, -9100, -8000], Scale -2
2023-07-05 14:48:01,204 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4494599, 1330049, 3315332, 2661924, 4156572, 4425447, 900142, 1643691], Scale 0
2023-07-05 14:48:01,205 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[234.83, 234.86, 236.92000000000002], powers=[981.0, 836.0, 909.0], currents=[2.5, 2.5, 2.6], power_factors=[-0.684, -0.91, -0.8], imported=4156572.0, exported=4494599.0, power=2726.0, frequency=49.97)
2023-07-05 14:48:01,208 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:48:01,229 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [17450], Scale -1
2023-07-05 14:48:01,249 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [13656984], Scale 0
2023-07-05 14:48:01,271 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [259, 263, 262], Scale -2
2023-07-05 14:48:01,351 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [17715], Scale -1
2023-07-05 14:48:01,352 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [2.59, 2.63, 2.62]
2023-07-05 14:48:01,352 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[2.59, 2.63, 2.62], power=-1745.0, exported=13656984.0, dc_power=-1771.5)
2023-07-05 14:48:01,354 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:48:01,410 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1688561271.3001215, power=0.0, imported=273.2772363344542, exported=169.8480559347779)
2023-07-05 14:48:01,411 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00280833, power1: 0, power2: 0
2023-07-05 14:48:01,411 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: 0
2023-07-05 14:48:01,412 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 0 Wh, new state: SimCounterState(timestamp=1688561281.4101274, power=0.0, imported=273.2772363344542, exported=169.8480559347779)
2023-07-05 14:48:01,413 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=273.2772363344542, exported=169.8480559347779, power=0.0, soc=100.0)
2023-07-05 14:48:01,418 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:48:01,419 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=273.2772363344542, exported=169.8480559347779, power=0.0, soc=100.0)
2023-07-05 14:48:01,475 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:48:01,477 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1745.0, exported=13657087.43, dc_power=None)
2023-07-05 14:48:01,478 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:01,479 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1745.0, exported=13657087.43, dc_power=None)
2023-07-05 14:48:01,480 - {modules.common.store._api:30} - {INFO:cp3} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[0, 0, 0.548], power_factors=[0.0, 0.0, 0.0], imported=30760, exported=12, power=4176.5, phases_in_use=1, charge_state=True, plug_state=True, rfid=None)
2023-07-05 14:48:01,561 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:48:01,562 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[234.83, 234.86, 236.92000000000002], powers=[981.0, 836.0, 909.0], currents=[2.5, 2.5, 2.6], power_factors=[-0.684, -0.91, -0.8], imported=4156572.0, exported=4494599.0, power=2726.0, frequency=49.97)
2023-07-05 14:48:01,705 - {control.bat_all:200} - {DEBUG:MainThread} - Verbleibende Speicher-Leistung: 0.0W
2023-07-05 14:48:01,706 - {control.bat_all:164} - {INFO:MainThread} - 0.0W verbleibende Speicher-Leistung
2023-07-05 14:48:01,708 - {control.counter:138} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [67.5, 67.5, 67.95]A
2023-07-05 14:48:01,708 - {control.counter:161} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 49450.5W
2023-07-05 14:48:01,710 - {control.chargepoint.chargepoint:661} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-07-05 14:48:01,713 - {control.chargepoint.chargepoint:853} - {INFO:MainThread} - LP 3, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 0.55
2023-07-05 14:48:01,716 - {control.data:337} - {INFO:MainThread} - bat2
BatData(get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=169.85, fault_state=0, fault_str='Kein Fehler.', power=0.0))
2023-07-05 14:48:01,717 - {control.data:307} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=169.85, power=0.0), set=Set(charging_power_left=0.0, switch_on_soc_reached=True))
2023-07-05 14:48:01,718 - {control.data:308} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=30758, daily_exported=12, power=4176.5, imported=30760, exported=12))
2023-07-05 14:48:01,720 - {control.data:337} - {INFO:MainThread} - cp3
ChargepointData(get=Get(charge_state=True, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=0), currents=[0, 0, 0.55], daily_imported=30758, daily_exported=12, exported=12, fault_str='Kein Fehler.', fault_state=0, imported=30760, phases_in_use=1, plug_state=True, power=4176.5, rfid_timestamp=None, rfid=None, state_str=None, voltages=[0.0, 0.0, 0.0]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='_', imported_at_mode_switch=30758, imported_at_plugtime=30758, 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=True, plug_time='07/05/2023, 14:47:21', required_power=1380.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x71b216e8>), config=Config(configuration={'ip_address': '192.168.178.227', 'duo_num': 1}, ev=0, name='openWB Pro', type='openwb_pro', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=3))
2023-07-05 14:48:01,721 - {control.data:337} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=20, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-07-05 14:48:01,722 - {control.data:337} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[70, 70, 70], max_total_power=48000), get=Get(powers=[981.0, 836.0, 909.0], currents=[2.5, 2.5, 2.6], voltages=[234.83, 234.86, 236.92], power_factors=[-0.68, -0.91, -0.8], unbalanced_load=0, frequency=49.97, daily_exported=1332.0, daily_imported=15.0, imported=4156572.0, exported=4494599.0, fault_state=0, fault_str='Kein Fehler.', power=2726.0), set=Set(error_counter=0, reserved_surplus=0, released_surplus=0, raw_power_left=49450.5, raw_currents_left=[67.5, 67.5, 67.95], surplus_power_left=0, state_str=''))
2023-07-05 14:48:01,725 - {control.data:312} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=294.5, invalid_home_consumption=0, daily_yield_home_consumption=0, disengageable_smarthome_power=0))
2023-07-05 14:48:01,730 - {control.data:337} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=16, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=80))))
2023-07-05 14:48:01,732 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 0.0, 0.0], phases=1, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=4), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-05 14:48:01,733 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-05 14:48:01,734 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=0, control_range=[0, 230], feed_in_yield=5000, phase_switch_delay=8, phases_to_use=1, rundown_power=0, rundown_soc=100, switch_off_delay=300, switch_off_soc=0, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=0, switch_on_threshold=1400), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.3, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-05 14:48:01,736 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-05 14:48:01,737 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-05 14:48:01,739 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x71b29910>), led=Led(active=False), rfid=Rfid(active=True))
2023-07-05 14:48:01,740 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=10000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657087.43, fault_state=0, fault_str='Kein Fehler.', power=-1745.0))
2023-07-05 14:48:01,741 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657087.43, power=-1745.0))
2023-07-05 14:48:01,744 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '1000', 'current_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_branch': 'master', 'current_branch_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 14, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1688561271, 'time': '14:47:51', 'grid': -1.468, 'house-power': 0.268, 'charging-all': 0.0, 'pv-all': 1.736, 'cp3-power': 0.0, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-07-05 14:48:01,745 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.178.224'}}
2023-07-05 14:48:01,746 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2023-07-05 14:48:01,748 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2023-07-05 14:48:01,750 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2023-07-05 14:48:01,752 - {control.data:324} - {INFO:MainThread} -
2023-07-05 14:48:01,752 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-05 14:48:01,756 - {control.counter:198} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: -2611.0W
2023-07-05 14:48:01,757 - {control.counter:361} - {DEBUG:MainThread} - LP3 Switch-Off-Threshold prüfen: 2611.0W, Schwelle: 50W, freigegebener Überschuss 0W, Einspeisegrenze 0W
2023-07-05 14:48:01,762 - {control.chargepoint.chargepoint:271} - {INFO:MainThread} - LP 3: Ladevorgang wird nach Ablauf der Abschaltverzögerung 300s gestoppt.
2023-07-05 14:48:01,764 - {control.chargepoint.chargepoint:271} - {INFO:MainThread} - LP 3: Ladevorgang wird nach Ablauf der Abschaltverzögerung 300s gestoppt.
2023-07-05 14:48:01,766 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-05 14:48:01,771 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - False, Zähler 0
2023-07-05 14:48:01,773 - {control.counter:169} - {DEBUG:MainThread} - Zähler 0: [61.5, 67.5, 67.95]A verbleibende Ströme, 48070.5W verbleibende Leistung
2023-07-05 14:48:01,775 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 6A
2023-07-05 14:48:01,778 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-05 14:48:01,782 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-07-05 14:48:01,783 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-07-05 14:48:01,784 - {control.algorithm.algorithm:44} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-07-05 14:48:01,785 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-05 14:48:01,787 - {control.chargelog:52} - {DEBUG:MainThread} - imported_since_mode_switch 2 counter 30760
2023-07-05 14:48:01,796 - {control.process:115} - {INFO:MainThread} - LP3: set current 6 A, state SWITCH_OFF_DELAY
2023-07-05 14:48:01,802 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:01,808 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:48:01,823 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "POST /connect.php HTTP/1.1" 200 19
2023-07-05 14:48:01,826 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: OK Value:6 accepted
2023-07-05 14:48:01,830 - {control.counter:186} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 1380.0W freigegebene EVU-Leistung
2023-07-05 14:48:02,013 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-05 14:48:02,039 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:48:05,078 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:48:10,092 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})
2023-07-05 14:48:10,093 - {root:64} - {INFO:MainThread} - # ***Start***
2023-07-05 14:48:10,153 - {modules.devices.solaredge.device:100} - {DEBUG:device0} - Start device reading {'component0': <modules.devices.solaredge.counter.SolaredgeCounter object at 0x72408eb0>, 'component1': <modules.devices.solaredge.inverter.SolaredgeInverter object at 0x724081a8>, 'component2': <modules.devices.solaredge.bat.SolaredgeBat object at 0x72401a00>}
2023-07-05 14:48:10,155 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:10,161 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:48:10,164 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:48:10,175 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "GET /connect.php HTTP/1.1" 200 353
2023-07-05 14:48:10,177 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: {"date":"2023:07:05-12:48:10","timestamp":1688561290,"powers":[1380.4,1390.4,1417.8],"power_all":4188.7,"currents":[5.964,6.001,6.059],"imported":30769,"exported":12,"plug_state":true,"charge_state":true,"phases_actual":3,"phases_target":3,"phases_in_use":3,"offered_current":6,"evse_signaling":"basic","v2g_ready":0,"vehicle_id":null,"serial":"804295"}
2023-07-05 14:48:10,178 - {modules.common.store._api:26} - {DEBUG:cp3} - Raw data ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[5.964, 6.001, 6.059], power_factors=[0.0, 0.0, 0.0], imported=30769, exported=12, power=4188.7, phases_in_use=3, charge_state=True, plug_state=True, rfid=None)
2023-07-05 14:48:10,197 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [-517, -248, -99, -168], Scale 0
2023-07-05 14:48:10,218 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [50, 41, 45], Scale -1
2023-07-05 14:48:10,238 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [23441, 23435, 23647, 0, 0, 0, 0], Scale -2
2023-07-05 14:48:10,257 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4997], Scale -2
2023-07-05 14:48:10,278 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4889, 4740, 4790], Scale -2
2023-07-05 14:48:10,298 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [4494600, 1330049, 3315332, 2661925, 4156579, 4425449, 900144, 1643693], Scale 0
2023-07-05 14:48:10,298 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data CounterState(voltages=[234.41, 234.35, 236.47], powers=[248.0, 99.0, 168.0], currents=[5.0, 4.1000000000000005, 4.5], power_factors=[0.4889, 0.474, 0.479], imported=4156579.0, exported=4494600.0, power=517.0, frequency=49.97)
2023-07-05 14:48:10,300 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:48:10,378 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [3913], Scale 0
2023-07-05 14:48:10,408 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [13656990], Scale 0
2023-07-05 14:48:10,428 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [582, 584, 582], Scale -2
2023-07-05 14:48:10,452 - {modules.devices.solaredge.scale:16} - {DEBUG:device0} - Registers [3972], Scale 0
2023-07-05 14:48:10,452 - {modules.common.component_state:95} - {DEBUG:device0} - currents sign wrong [5.82, 5.84, 5.82]
2023-07-05 14:48:10,453 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data InverterState(currents=[5.82, 5.84, 5.82], power=-3913.0, exported=13656990.0, dc_power=-3972.0)
2023-07-05 14:48:10,458 - {modules.common.component_context:24} - {DEBUG:device0} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:48:10,523 - {modules.common.simcount._simcount:38} - {DEBUG:device0} - Previous state: SimCounterState(timestamp=1688561281.4101274, power=0.0, imported=273.2772363344542, exported=169.8480559347779)
2023-07-05 14:48:10,523 - {modules.common.simcount._calculate:13} - {DEBUG:device0} - time passed: 0.00253142, power1: 0, power2: -2219
2023-07-05 14:48:10,524 - {modules.common.simcount._calculate:29} - {DEBUG:device0} - power did not change sign. Total energy: -2.80861
2023-07-05 14:48:10,524 - {modules.common.simcount._simcount:47} - {DEBUG:device0} - imported: 0 Wh, exported: 2.80861 Wh, new state: SimCounterState(timestamp=1688561290.5232332, power=-2219.0, imported=273.2772363344542, exported=172.65666450593642)
2023-07-05 14:48:10,525 - {modules.common.store._api:26} - {DEBUG:device0} - Raw data BatState(imported=273.2772363344542, exported=172.65666450593642, power=-2219.0, soc=100.0)
2023-07-05 14:48:10,529 - {modules.common.component_context:24} - {DEBUG:component2} - Update Komponente ['SolarEdge Speicher']
2023-07-05 14:48:10,530 - {modules.common.store._api:30} - {INFO:component2} - Saving BatState(imported=273.2772363344542, exported=172.65666450593642, power=-2219.0, soc=100.0)
2023-07-05 14:48:10,567 - {modules.common.component_context:24} - {DEBUG:component1} - Update Komponente ['SolarEdge Wechselrichter']
2023-07-05 14:48:10,569 - {modules.common.store._api:26} - {DEBUG:component1} - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=-1694.0, exported=13657090.62, dc_power=None)
2023-07-05 14:48:10,569 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:10,570 - {modules.common.store._api:30} - {INFO:component1} - Saving InverterState(currents=[0.0, 0.0, 0.0], power=-1694.0, exported=13657090.62, dc_power=None)
2023-07-05 14:48:10,570 - {modules.common.store._api:30} - {INFO:cp3} - Saving ChargepointState(voltages=[0.0, 0.0, 0.0], currents=[5.964, 6.001, 6.059], power_factors=[0.0, 0.0, 0.0], imported=30769, exported=12, power=4188.7, phases_in_use=3, charge_state=True, plug_state=True, rfid=None)
2023-07-05 14:48:10,634 - {modules.common.component_context:24} - {DEBUG:component0} - Update Komponente ['SolarEdge Zähler']
2023-07-05 14:48:10,634 - {modules.common.store._api:30} - {INFO:component0} - Saving CounterState(voltages=[234.41, 234.35, 236.47], powers=[248.0, 99.0, 168.0], currents=[5.0, 4.1000000000000005, 4.5], power_factors=[0.4889, 0.474, 0.479], imported=4156579.0, exported=4494600.0, power=517.0, frequency=49.97)
2023-07-05 14:48:10,765 - {control.bat_all:200} - {DEBUG:MainThread} - Verbleibende Speicher-Leistung: -2219.0W
2023-07-05 14:48:10,766 - {control.bat_all:164} - {INFO:MainThread} - -2219.0W verbleibende Speicher-Leistung
2023-07-05 14:48:10,767 - {control.counter:138} - {INFO:MainThread} - Verbleibende Ströme an Zähler 0: [70.96, 71.9, 71.56]A
2023-07-05 14:48:10,768 - {control.counter:161} - {INFO:MainThread} - Verbleibende Leistung an Zähler 0: 51671.7W
2023-07-05 14:48:10,770 - {control.chargepoint.chargepoint:661} - {DEBUG:MainThread} - EV-Phasenzahl beschränkt die nutzbaren Phasen auf 3
2023-07-05 14:48:10,773 - {control.chargepoint.chargepoint:853} - {INFO:MainThread} - LP 3, EV: Standard-Fahrzeug (EV-Nr.0): Theoretisch benötigter Strom 6A, Lademodus pv_charging, Submodus: Chargemode.PV_CHARGING, Phasen: 1, Priorität: False, max. Ist-Strom: 6.06
2023-07-05 14:48:10,775 - {control.data:337} - {INFO:MainThread} - bat2
BatData(get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=172.66, fault_state=0, fault_str='Kein Fehler.', power=-2219.0))
2023-07-05 14:48:10,777 - {control.data:307} - {INFO:MainThread} - bat_all_data
BatAllData(config=Config(configured=True), get=Get(soc=100, daily_exported=169.85, daily_imported=273.28, imported=273.28, exported=172.66, power=-2219.0), set=Set(charging_power_left=-2219.0, switch_on_soc_reached=True))
2023-07-05 14:48:10,778 - {control.data:308} - {INFO:MainThread} - cp_all_data
AllChargepointData(get=AllGet(daily_imported=30758, daily_exported=12, power=4188.7, imported=30769, exported=12))
2023-07-05 14:48:10,779 - {control.data:337} - {INFO:MainThread} - cp3
ChargepointData(get=Get(charge_state=True, connected_vehicle=ConnectedVehicle(config=ConnectedConfig(average_consumption=17, charge_template=0, chargemode='stop', current_plan=0, ev_template=0, priority=False, time_charging_in_use=False), info=ConnectedInfo(id=0, name='Ladepunkt'), soc=0), currents=[5.96, 6.0, 6.06], daily_imported=30758, daily_exported=12, exported=12, fault_str='Kein Fehler.', fault_state=0, imported=30769, phases_in_use=3, plug_state=True, power=4188.7, rfid_timestamp=None, rfid=None, state_str=None, voltages=[0.0, 0.0, 0.0]), set=Set(change_ev_permitted=[True, ''], charging_ev=0, charging_ev_prev=0, current=6, energy_to_charge=0, loadmanagement_available=True, log=Log(chargemode_log_entry='pv_charging', imported_at_mode_switch=30758, imported_at_plugtime=30758, imported_since_mode_switch=2, imported_since_plugged=2, range_charged=0.011764705882352941, time_charged='0:00', timestamp_start_charging='07/05/2023, 14:48:01'), manual_lock=False, phases_to_use=1, plug_state_prev=True, plug_time='07/05/2023, 14:47:21', required_power=1380.0, rfid=None, target_current=0, charging_ev_data=<control.ev.Ev object at 0x71b29730>), config=Config(configuration={'ip_address': '192.168.178.227', 'duo_num': 1}, ev=0, name='openWB Pro', type='openwb_pro', template=0, connected_phases=3, phase_1=1, auto_phase_switch_hw=True, control_pilot_interruption_hw=True, id=3))
2023-07-05 14:48:10,779 - {control.data:337} - {INFO:MainThread} - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), id=0, max_current_multi_phases=16, max_current_single_phase=20, name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[])
2023-07-05 14:48:10,785 - {control.data:337} - {INFO:MainThread} - counter0
CounterData(config=Config(max_currents=[70, 70, 70], max_total_power=48000), get=Get(powers=[248.0, 99.0, 168.0], currents=[5.0, 4.1, 4.5], voltages=[234.41, 234.35, 236.47], power_factors=[0.49, 0.47, 0.48], unbalanced_load=0, frequency=49.97, daily_exported=1332.0, daily_imported=15.0, imported=4156579.0, exported=4494600.0, fault_state=0, fault_str='Kein Fehler.', power=517.0), set=Set(error_counter=0, reserved_surplus=0, released_surplus=1380.0, raw_power_left=51671.7, raw_currents_left=[70.96, 71.9, 71.56], surplus_power_left=0, state_str=''))
2023-07-05 14:48:10,787 - {control.data:312} - {INFO:MainThread} - counter_all_data
CounterAllData(config=Config(reserve_for_not_charging=True), get=Get(hierarchy=[{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 3, 'type': 'cp', 'children': []}]}]), set=Set(loadmanagement_active=False, home_consumption=241.30000000000018, invalid_home_consumption=0, daily_yield_home_consumption=0, disengageable_smarthome_power=0))
2023-07-05 14:48:10,791 - {control.data:337} - {INFO:MainThread} - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='pv_charging', pv_charging=PvCharging(min_soc_current=16, min_current=0, feed_in_limit=False, min_soc=0, max_soc=101), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=16, limit=Limit(selected='none', amount=1000, soc=80))))
2023-07-05 14:48:10,794 - {control.data:337} - {INFO:MainThread} - ev0
EvData(set=Set(ev_template=EvTemplate(data=EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40), et_num=0), soc_error_counter=0), control_parameter=ControlParameter(required_current=6, required_currents=[6, 0.0, 0.0], phases=1, prio=False, timestamp_switch_on_off='07/05/2023, 14:48:01', timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode=<Chargemode.PV_CHARGING: 'pv_charging'>, chargemode=<Chargemode.PV_CHARGING: 'pv_charging'>, used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None, state=5), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=True, range=0, fault_state=0, fault_str=''))
2023-07-05 14:48:10,795 - {control.data:337} - {INFO:MainThread} - et0
EvTemplateData(name='Standard-Fahrzeug-Vorlage', max_current_multi_phases=16, max_phases=3, phase_switch_pause=2, prevent_phase_switch=False, prevent_charge_stop=False, control_pilot_interruption=False, control_pilot_interruption_duration=4, average_consump=17000, min_current=6, max_current_single_phase=20, battery_capacity=60000, nominal_difference=1, keep_charge_active_duration=40)
2023-07-05 14:48:10,796 - {control.data:316} - {INFO:MainThread} - general_data
GeneralData(chargemode_config=ChargemodeConfig(instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=0, control_range=[0, 230], feed_in_yield=5000, phase_switch_delay=8, phases_to_use=1, rundown_power=0, rundown_soc=100, switch_off_delay=300, switch_off_soc=0, switch_off_threshold=50, switch_on_delay=30, switch_on_soc=0, switch_on_threshold=1400), scheduled_charging=ScheduledCharging(phases_to_use=0), time_charging=TimeCharging(phases_to_use=3), unbalanced_load_limit=18, unbalanced_load=False), control_interval=10, extern_display_mode='local', extern=False, external_buttons_hw=False, grid_protection_active=False, grid_protection_configured=True, grid_protection_random_stop=0, grid_protection_timestamp='', mqtt_bridge=False, price_kwh=0.3, range_unit='km', ripple_control_receiver=RippleControlReceiver(configured=False, r1_active=False, r2_active=False))
2023-07-05 14:48:10,796 - {control.data:317} - {INFO:MainThread} - general_data-display
local
2023-07-05 14:48:10,796 - {control.data:318} - {INFO:MainThread} - graph_data
GraphData(config=Config(duration=120))
2023-07-05 14:48:10,804 - {control.data:319} - {INFO:MainThread} - optional_data
OptionalData(et=Et(active=False, config=EtConfig(max_price=0, provider={}), get=EtGet(price=0, price_list=[])), int_display=InternalDisplay(active=False, on_if_plugged_in=True, pin_active=False, pin_code='0000', standby=60, theme=<modules.display_themes.cards.config.CardsDisplayTheme object at 0x71b292b0>), led=Led(active=False), rfid=Rfid(active=True))
2023-07-05 14:48:10,806 - {control.data:337} - {INFO:MainThread} - pv1
PvData(config=Config(max_ac_out=10000), get=Get(currents=[0.0, 0.0, 0.0], daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657090.62, fault_state=0, fault_str='Kein Fehler.', power=-1694.0))
2023-07-05 14:48:10,806 - {control.data:321} - {INFO:MainThread} - pv_all_data
PvAllData(config=Config(configured=True), get=Get(daily_exported=2097.43, monthly_exported=0, yearly_exported=0, exported=13657090.62, power=-1694.0))
2023-07-05 14:48:10,807 - {control.data:337} - {INFO:MainThread} - system
{'update_in_progress': False, 'perform_update': False, 'ip_address': '1000', 'current_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_branch': 'master', 'current_branch_commit': '2023-07-05 09:19:58 +0200 [39e119495]', 'current_missing_commits': [], 'boot_done': True, 'datastore_version': 14, 'dataprotection_acknowledged': True, 'usage_terms_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '2.0.0', 'lastlivevaluesJson': {'timestamp': 1688561281, 'time': '14:48:01', 'grid': 2.726, 'house-power': 0.294, 'charging-all': 4.176, 'pv-all': 1.745, 'cp3-power': 4.176, 'bat-all-power': 0.0, 'bat-all-soc': 100}, 'module_update_completed': True}
2023-07-05 14:48:10,809 - {control.data:350} - {INFO:MainThread} - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.178.224'}}
2023-07-05 14:48:10,815 - {control.data:352} - {INFO:MainThread} - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2023-07-05 14:48:10,816 - {control.data:352} - {INFO:MainThread} - component1
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2023-07-05 14:48:10,817 - {control.data:352} - {INFO:MainThread} - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2023-07-05 14:48:10,819 - {control.data:324} - {INFO:MainThread} -
2023-07-05 14:48:10,820 - {control.algorithm.algorithm:25} - {INFO:MainThread} - # Algorithmus
2023-07-05 14:48:10,827 - {control.counter:198} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: -2621.0W
2023-07-05 14:48:10,828 - {control.counter:361} - {DEBUG:MainThread} - LP3 Switch-Off-Threshold prüfen: 1241.0W, Schwelle: 50W, freigegebener Überschuss 1380.0W, Einspeisegrenze 0W
2023-07-05 14:48:10,830 - {control.chargepoint.chargepoint:271} - {INFO:MainThread} - LP 3: Ladevorgang wird nach Ablauf der Abschaltverzögerung 300s gestoppt.
2023-07-05 14:48:10,831 - {control.algorithm.algorithm:31} - {INFO:MainThread} - **Mindestrom setzen**
2023-07-05 14:48:10,840 - {control.algorithm.min_current:18} - {INFO:MainThread} - Mode-Tuple Chargemode.PV_CHARGING - Chargemode.PV_CHARGING - False, Zähler 0
2023-07-05 14:48:10,842 - {control.counter:169} - {DEBUG:MainThread} - Zähler 0: [64.96, 71.9, 71.56]A verbleibende Ströme, 50291.7W verbleibende Leistung
2023-07-05 14:48:10,852 - {control.algorithm.common:87} - {INFO:MainThread} - LP3: Stromstärke 6A
2023-07-05 14:48:10,854 - {control.algorithm.algorithm:33} - {INFO:MainThread} - **Sollstrom setzen**
2023-07-05 14:48:10,857 - {control.counter:211} - {INFO:MainThread} - Überschuss zur PV-geführten Ladung: 0W
2023-07-05 14:48:10,859 - {control.counter:470} - {DEBUG:MainThread} - Zähler 0: Begrenzung der verbleibenden Leistung auf 0W
2023-07-05 14:48:10,861 - {control.algorithm.algorithm:44} - {INFO:MainThread} - **Keine Leistung für PV-geführtes Laden übrig.**
2023-07-05 14:48:10,862 - {control.process:23} - {INFO:MainThread} - # Ladung starten.
2023-07-05 14:48:10,869 - {control.chargelog:52} - {DEBUG:MainThread} - imported_since_mode_switch 11 counter 30769
2023-07-05 14:48:10,872 - {control.process:115} - {INFO:MainThread} - LP3: set current 6 A, state SWITCH_OFF_DELAY
2023-07-05 14:48:10,883 - {modules.common.component_context:24} - {DEBUG:cp3} - Update Komponente ['Ladepunkt']
2023-07-05 14:48:10,893 - {urllib3.connectionpool:227} - {DEBUG:cp3} - Starting new HTTP connection (1): 192.168.178.227:80
2023-07-05 14:48:10,909 - {urllib3.connectionpool:452} - {DEBUG:cp3} - http://192.168.178.227:80 "POST /connect.php HTTP/1.1" 200 19
2023-07-05 14:48:10,913 - {modules.common.req:11} - {DEBUG:cp3} - Get-Response: OK Value:6 accepted
2023-07-05 14:48:10,919 - {control.counter:186} - {INFO:MainThread} - 0W reservierte EVU-Leistung, 1380.0W freigegebene EVU-Leistung
2023-07-05 14:48:11,116 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=update, args=(), kwargs={})
2023-07-05 14:48:11,140 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:48:15,200 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=smarthome_handler, args=(), kwargs={})
2023-07-05 14:48:20,214 - {schedule:660} - {DEBUG:MainThread} - Running job Job(interval=1, unit=minutes, do=handler10Sec, args=(), kwargs={})