Feedback Alpha 4

[Ihaglc]

Sieht jetzt besser aus, wenn der Speicher entladen wird, d. h. wenn PV=0, stimmen die Werte.
Heute beim Aufladen des Speichers erscheinen unsinnig hohe PV Spitzen, die den Hausverbrauch mit hochziehen.

2022-10-31 10:08:37 +0100 [0880c9e5]
Sieht jetzt besser aus, die Spitzen sind weg, aber nun erscheint während der Dunkelheit plötzlich PV Leistung und der Hausverbrauch wird um die PV Leistung höher angezeigt??

[LenaK]

Bitte das Debuglevel auf Details stellen und einen Auszug aus dem main.log schicken, wenn der Fehler wieder auftritt.

[Ihaglc]

Kommt gerade wieder vor

debug_PV_2.txt

(2.29 MiB) 75-mal heruntergeladen

und es geht weiter

Code: Alles auswählen

2022-11-01 19:54:38,525 - {control.algorithm:45} - DEBUG - # Algorithmus-Start
2022-11-01 19:54:38,525 - {control.algorithm:47} - INFO - EVU-Punkt: Leistung[W] -4.0, Ströme[A] [1.7, -0.3, -0.7]
2022-11-01 19:54:38,525 - {control.algorithm:85} - INFO - ## Überschuss-Ladung über Mindeststrom bei PV-Laden zurücknehmen.
2022-11-01 19:54:38,525 - {control.algorithm:205} - DEBUG - ## Ladung muss nicht wegen aktiven Lastmanagements gestoppt werden.
2022-11-01 19:54:38,526 - {control.algorithm:574} - INFO - ## Zuteilung des Überschusses
2022-11-01 19:54:38,526 - {control.algorithm:610} - INFO - ## Zuteilung beendet, da kein Ladepunkt mehr auf Zuteilung wartet.
2022-11-01 19:54:38,526 - {control.algorithm:870} - INFO - ## Übrigen Überschuss verteilen.
2022-11-01 19:54:38,528 - {control.process:22} - DEBUG - # Ladung starten.
2022-11-01 19:54:38,529 - {control.pv:433} - DEBUG - 119.0W EVU-Überschuss, der für die Regelung verfügbar ist, davon 0W für die Einschaltverzögerung reservierte Leistung.
2022-11-01 19:54:38,529 - {control.counter:458} - DEBUG - 32000W verbleibende EVU-Bezugs-Leistung
2022-11-01 19:54:47,858 - {root:63} - INFO - # ***Start*** 
2022-11-01 19:54:47,873 - {modules.solaredge.device:99} - DEBUG - Start device reading {'component0': <modules.solaredge.counter.SolaredgeCounter object at 0xb5c81490>, 'component1': <modules.solaredge.inverter.SolaredgeInverter object at 0xb5d09bb0>, 'component2': <modules.solaredge.bat.SolaredgeBat object at 0xb4f5afa0>}
2022-11-01 19:54:47,878 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Zähler']
2022-11-01 19:54:47,940 - {modules.solaredge.scale:16} - DEBUG - Registers [-1, -186, 76, 108], Scale 0
2022-11-01 19:54:47,960 - {modules.solaredge.scale:16} - DEBUG - Registers [16, 3, 7], Scale -1
2022-11-01 19:54:47,980 - {modules.solaredge.scale:16} - DEBUG - Registers [23568, 23662, 23710, 0, 0, 0, 0], Scale -2
2022-11-01 19:54:48,000 - {modules.solaredge.scale:16} - DEBUG - Registers [5002], Scale -2
2022-11-01 19:54:48,070 - {modules.solaredge.scale:16} - DEBUG - Registers [4769, -8600, -5799], Scale -2
2022-11-01 19:54:48,101 - {modules.solaredge.scale:16} - DEBUG - Registers [6576264, 2063894, 3897622, 3924617, 2790763, 4475931, 1040617, 584084], Scale 0
2022-11-01 19:54:48,102 - {soc.modules.common.store._api:26} - DEBUG - Raw data CounterState(voltages=[235.68, 236.62, 237.1], powers=[186.0, -76.0, -108.0], currents=[1.6, -0.30000000000000004, -0.7000000000000001], power_factors=[0.4769, -0.86, -0.5799], imported=2790763.0, exported=6576264.0, power=1.0, frequency=50.02)
2022-11-01 19:54:48,104 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Wechselrichter']
2022-11-01 19:54:48,132 - {modules.solaredge.scale:16} - DEBUG - Registers [5640], Scale -1
2022-11-01 19:54:48,150 - {modules.solaredge.scale:16} - DEBUG - Registers [14973625], Scale 0
2022-11-01 19:54:48,170 - {modules.solaredge.scale:16} - DEBUG - Registers [95, 100, 96], Scale -2
2022-11-01 19:54:48,170 - {soc.modules.common.store._api:26} - DEBUG - Raw data InverterState(currents=[-0.9500000000000001, -1.0, -0.96], power=-564.0, exported=14973625.0)
2022-11-01 19:54:48,172 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Speicher']
2022-11-01 19:54:48,210 - {modules.common.simcount._simcount:38} - DEBUG - Previous state: SimCounterState(timestamp=1667328878.3732102, power=-653.0, imported=47020.91980249083, exported=46393.733620838895)
2022-11-01 19:54:48,210 - {modules.common.simcount._calculate:13} - DEBUG - time passed: 0.00273245, power1: -653, power2: -651
2022-11-01 19:54:48,210 - {modules.common.simcount._calculate:29} - DEBUG - power did not change sign. Total energy: -1.78156
2022-11-01 19:54:48,211 - {modules.common.simcount._simcount:47} - DEBUG - imported: 0 Wh, exported: 1.78156 Wh, new state: SimCounterState(timestamp=1667328888.2100432, power=-651.0, imported=47020.91980249083, exported=46395.51518059337)
2022-11-01 19:54:48,211 - {soc.modules.common.store._api:26} - DEBUG - Raw data BatState(imported=47020.91980249083, exported=46395.51518059337, power=-651.0, soc=70.0)
2022-11-01 19:54:48,218 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Speicher']
2022-11-01 19:54:48,218 - {soc.modules.common.store._api:30} - DEBUG - Saving BatState(imported=47020.91980249083, exported=46395.51518059337, power=-651.0, soc=70.0)
2022-11-01 19:54:48,247 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Wechselrichter']
2022-11-01 19:54:48,247 - {soc.modules.common.store._api:26} - DEBUG - Raw data InverterState(currents=[0.0, 0.0, 0.0], power=87.0, exported=14927229.48)
2022-11-01 19:54:48,248 - {soc.modules.common.store._api:30} - DEBUG - Saving InverterState(currents=[0.0, 0.0, 0.0], power=87.0, exported=14927229.48)
2022-11-01 19:54:48,252 - {helpermodules.setdata:278} - ERROR - Payload ungültig: Topic openWB/set/pv/1/get/power, Payload 87.0 liegt in keinem der angegebenen Wertebereiche.
2022-11-01 19:54:48,267 - {soc.modules.common.component_context:24} - DEBUG - Update Komponente ['SolarEdge Zähler']
2022-11-01 19:54:48,268 - {soc.modules.common.store._api:30} - DEBUG - Saving CounterState(voltages=[235.68, 236.62, 237.1], powers=[186.0, -76.0, -108.0], currents=[1.6, -0.30000000000000004, -0.7000000000000001], power_factors=[0.4769, -0.86, -0.5799], imported=2790763.0, exported=6576264.0, power=1.0, frequency=50.02)
2022-11-01 19:54:48,316 - {control.counter:439} - DEBUG - 31999.0W EVU-Leistung, die noch bezogen werden kann.
2022-11-01 19:54:48,317 - {control.pv:89} - DEBUG - 0W EVU-Überschuss, der für die Regelung verfügbar ist, davon 0W für die Einschaltverzögerung reservierte Leistung.
2022-11-01 19:54:48,317 - {control.bat:118} - INFO - -653.0W verbliebende Speicher-Leistung
2022-11-01 19:54:48,318 - {control.data:294} - DEBUG - all
{'get': {'power': -653.0, 'imported': 47020.92, 'exported': 46393.73, 'daily_exported': 3498.26, 'daily_imported': 10914.48, 'soc': 70}, 'config': {'configured': True}, 'set': {'charging_power_left': -653.0, 'switch_on_soc_reached': True}}
2022-11-01 19:54:48,319 - {control.data:294} - DEBUG - bat2
{'get': {'daily_imported': 10914.48, 'daily_exported': 3498.26, 'fault_str': 'Kein Fehler.', 'fault_state': 0, 'power': -651.0, 'soc': 70, 'imported': 47020.92, 'exported': 46395.52}}
2022-11-01 19:54:48,319 - {control.data:267} - DEBUG - cp_all_data
AllChargepointData(get=AllGet(daily_imported=0, daily_exported=0, power=0, imported=0, exported=0))
2022-11-01 19:54:48,319 - {control.data:294} - DEBUG - cpt0
CpTemplateData(autolock=Autolock(active=False, plans={}, wait_for_charging_end=False), name='Standard Ladepunkt-Vorlage', rfid_enabling=False, valid_tags=[], id=0)
2022-11-01 19:54:48,319 - {control.data:294} - DEBUG - all
{'set': {'loadmanagement_active': False, 'home_consumption': 1840.0, 'invalid_home_consumption': 0, 'daily_yield_home_consumption': 1294.5199999999968}, 'get': {'hierarchy': [{'id': 0, 'type': 'counter', 'children': [{'id': 1, 'type': 'inverter', 'children': [{'id': 2, 'type': 'bat', 'children': []}]}, {'id': 2, 'type': 'bat', 'children': []}]}]}}
2022-11-01 19:54:48,319 - {control.data:294} - DEBUG - counter0
{'set': {'consumption_left': 31999.0, 'currents_used': [1.6, -0.3, -0.7]}, 'get': {'daily_exported': 11657.0, 'daily_imported': 4054.0, 'fault_str': 'Kein Fehler.', 'fault_state': 0, 'voltages': [235.68, 236.62, 237.1], 'currents': [1.6, -0.3, -0.7], 'powers': [186.0, -76.0, -108.0], 'power_factors': [0.48, -0.86, -0.58], 'imported': 2790763.0, 'exported': 6576264.0, 'power': 1.0, 'frequency': 50.02}, 'config': {'max_currents': [50, 50, 50], 'max_total_power': 32000}}
2022-11-01 19:54:48,322 - {control.data:294} - DEBUG - ct0
ChargeTemplateData(name='Standard-Ladeprofil-Vorlage', disable_after_unplug=False, prio=False, load_default=False, time_charging=TimeCharging(active=False, plans={}), chargemode=Chargemode(selected='stop', pv_charging=PvCharging(min_soc_current=10, min_current=0, feed_in_limit=False, min_soc=0, max_soc=100), scheduled_charging=ScheduledCharging(plans={}), instant_charging=InstantCharging(current=10, limit=Limit(selected='none', amount=1000, soc=50))))
2022-11-01 19:54:48,322 - {control.data:294} - DEBUG - 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=17, min_current=6, max_current_one_phase=32, battery_capacity=82, nominal_difference=2, soc=Soc(request_interval_charging=5, request_interval_not_charging=720, request_only_plugged=False)), et_num=0)), control_parameter=ControlParameter(required_current=0, phases=0, prio=False, timestamp_switch_on_off=None, timestamp_auto_phase_switch=None, timestamp_perform_phase_switch=None, submode='stop', chargemode='stop', used_amount_instant_charging=0, imported_at_plan_start=0, current_plan=None), charge_template=0, ev_template=0, name='Standard-Fahrzeug', tag_id=[], get=Get(soc=0, soc_timestamp='', force_soc_update=False, range=0))
2022-11-01 19:54:48,322 - {control.data:294} - DEBUG - 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=17, min_current=6, max_current_one_phase=32, battery_capacity=82, nominal_difference=2, soc=Soc(request_interval_charging=5, request_interval_not_charging=720, request_only_plugged=False))
2022-11-01 19:54:48,323 - {control.data:275} - DEBUG - general_data
GeneralData(chargemode_config=ChargemodeConfig(individual_mode=True, instant_charging=InstantCharging(phases_to_use=3), pv_charging=PvCharging(bat_prio=False, charging_power_reserve=300, control_range=[0, 230], feed_in_yield=7000, phase_switch_delay=7, phases_to_use=1, rundown_power=5000, rundown_soc=50, switch_off_delay=60, switch_off_soc=45, switch_off_threshold=7000, switch_on_delay=120, switch_on_soc=80, switch_on_threshold=1400), 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=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))
2022-11-01 19:54:48,323 - {control.data:294} - DEBUG - graph
{'config': {'duration': 120}}
2022-11-01 19:54:48,323 - {control.data:294} - DEBUG - optional
{'et': {'get': {}, 'active': False, 'config': {'max_price': 0, 'provider': {}}}, 'int_display': {'active': False, 'on_if_plugged_in': True, 'pin_active': False, 'pin_code': '0000', 'standby': 60, 'theme': 'cards'}, 'led': {'active': False}, 'active': False, 'max_current': 16, 'rfid': {'active': False}}
2022-11-01 19:54:48,323 - {control.data:294} - DEBUG - all
{'set': {'overhang_power_left': 0, 'available_power': 0, 'reserved_evu_overhang': 0, 'released_evu_overhang': 0}, 'get': {'power': -1188.0, 'exported': 14927229.27, 'daily_exported': 16315.74, 'monthly_exported': 0, 'yearly_exported': 0}, 'config': {'configured': True}}
2022-11-01 19:54:48,323 - {control.data:294} - DEBUG - pv1
{'get': {'daily_exported': 16315.74, 'monthly_exported': 0, 'yearly_exported': 0, 'fault_str': 'Kein Fehler.', 'fault_state': 0, 'power': -1188.0, 'exported': 14927229.48, 'currents': [0.0, 0.0, 0.0]}, 'config': {'max_ac_out': 7200}}
2022-11-01 19:54:48,325 - {control.data:294} - DEBUG - system
{'update_in_progress': False, 'perform_update': False, 'boot_done': True, 'ip_address': '192.168.2.129', 'current_commit': '2022-10-31 15:40:46 +0100 [87234ee1]', 'current_branch': 'master', 'current_branch_commit': '2022-10-31 15:40:46 +0100 [87234ee1]', 'current_missing_commits': [], 'dataprotection_acknowledged': True, 'debug_level': 10, 'release_train': 'master', 'version': '1.99.003', 'datastore_version': 2, 'lastlivevaluesJson': {'timestamp': 1667328878, 'time': '19:54:38', 'grid': -0.004, 'house-power': 1.837, 'charging-all': 0.0, 'pv-all': 1.188, 'bat-all-power': -0.68, 'bat-all-soc': 71}, 'module_update_completed': True}
2022-11-01 19:54:48,326 - {control.data:307} - DEBUG - device0
{'name': 'SolarEdge', 'type': 'solaredge', 'id': 0, 'configuration': {'port': 502, 'ip_address': '192.168.2.134'}}
2022-11-01 19:54:48,326 - {control.data:309} - DEBUG - component0
{'name': 'SolarEdge Zähler', 'type': 'counter', 'id': 0, 'configuration': {'modbus_id': 1, 'meter_id': 1}}
2022-11-01 19:54:48,326 - {control.data:309} - DEBUG - component1
{'name': 'SolarEdge Wechselrichter', 'type': 'inverter', 'id': 1, 'configuration': {'modbus_id': 1}}
2022-11-01 19:54:48,326 - {control.data:309} - DEBUG - component2
{'name': 'SolarEdge Speicher', 'type': 'bat', 'id': 2, 'configuration': {'modbus_id': 1}}
2022-11-01 19:54:48,326 - {control.data:281} - DEBUG - 

[LenaK]

Die Rohwerte, die per Modbus ausgelesen werden, schwanken bereits so stark. Möglicherweise ist das eine Folge der parallelen Abfrage durch 1.9 und 2.0.
Du könntest ein zeitgleichen Logauszug von 1.9 und 2.0 posten, dann kann man sehen, ob beide Systeme dieselben Werte per Modbus erhalten.

[Ihaglc]

Ok, habe hier mal zum Vergleichen die Logs ( während in OWB 2.0 PV angezeigt wird ) ein paar Minuten aufgezeichnet.
Als txt, da sonst zu groß zum Scrollen

OWB__1_9.txt

(63.89 KiB) 87-mal heruntergeladen

OWB__2_0.txt

(158.47 KiB) 58-mal heruntergeladen

[Ihaglc]

Leider ist das Spitzenproblem mit 2022-11-02 13:35:30 +0100 [bc52d84b] wieder zurückgekommen...

[LenaK]

Ok, habe hier mal zum Vergleichen die Logs ( während in OWB 2.0 PV angezeigt wird ) ein paar Minuten aufgezeichnet.
Als txt, da sonst zu groß zum Scrollen2022-11-02 17_48_38-Start.png2022-11-02 18_01_27-Start.pngOWB__1_9.txtOWB__2_0.txt

Die Schwankungen sind auch in 1.9 vorhanden, die Werte sind in den beiden Logs vergleichbar. Der nächtliche PV-Ertrag sollte mit PR 594 verschwinden, dieser muss allerdings erst noch geprüft werden.

[LenaK]

Leider ist das Spitzenproblem mit 2022-11-02 13:35:30 +0100 [bc52d84b] wieder zurückgekommen...

Ohne Logs kann ich leider nicht die Ursache finden. Am besten wieder von 1.9 und 2.0

[Ihaglc]

Hier an den Screenshots kann man schön sehen, dass die Peeks verschwinden, wenn PV nicht mehr vorhanden.

Kann leider nur die logs von OWB2.0 ziehen, als schon keine Peeks mehr vorhanden sind ( Daten wurden schon überschrieben )
Wenn nicht ausreichend, muss ich es morgen noch mal versuchen.

[LenaK]

Versuche bitte heute nochmal, Logs mit Peaks zu posten, damit ich die Werte vergleichen kann.