HM-800 speist plötzlich nur noch statisch 100W ein. Kein DPL mehr

[dk7td]

Hallo zusammen,

ich habe hier einen HM-800 über OpenDTU-OnBattery geregelt, ein Shelly Pro 3EM liefert die geforderte Leistung. Läuft bisher super in Verbindung mit einem oder zwei Zendure SolarFlow Hub1200.

Seit gestern beobachte ich einen komischen Effekt: plötzlich wird der Hoymiles statisch auf ca. 100W eingestellt und der Dynamic Power Limiter funktioniert nicht mehr. Erst mit einem Neustart der OpenDTU läuft wieder alles normal.

Ich habe eine OpenDTU Fusion im Einsatz, die bisher perfekt lief.

Hatte sowas schon jemand oder gibt es eine Idee, was hier faul sein könnte?

Danke&Grüße
Didi

[schlimmchen]

Du hast vermutlich 100W als "Base Load" (Grundlast) im DPL eingestellt und die Verbindung zum PowerMeter ist ausgefallen. Wenn das wieder passiert, schau doch mal bitte in die Web-Konsole (Verbose Logging im DPL einschalten) und zeig uns einen Auszug des DPL Logs während das Problem besteht.

Ich behaupte, meine Vermutung mit dem Ausfall des PowerMeters ist wahrscheinlich zutreffend. Warum es da zu einem Problem kommt, können wir vielleicht ebenfalls in der Konsole lesen.

[dk7td]

Ah! Sehr guter Hinweis! Danke für die schnelle Antwort!
Dann schalte ich das gleich mal ein und werde den Auszug posten, sofern es nochmals auftritt.
Ich muß mal im Shelly schauen, ob ich dort was sehen kann. Der hängt extra im LAN, damit die Verbindung stabil ist, und die OpenDTU steht keine 2m neben dem Repeater.

Schaltet das System denn nicht auf die dynamische Regelung zurück, sobald die Verbindung wieder besteht? Interessanterweise geht es ja nach einem Reboot wieder.

Danke!

[schlimmchen]

Schaltet das System denn nicht auf die dynamische Regelung zurück, sobald die Verbindung wieder besteht?

Ja, das sollte eigentlich so sein. Du kannst die DTU weiterhin erreichen während das Problem besteht?

Shelly am LAN ist natürlich top. DTU 2m neben dem AP/Repeater kann auch problematisch sein. Wie alt ist deine Anlage? Ist das ein neues Problem oder hast du das schon immer?

[dk7td]

DTU kann ich ständig erreichen, kann auch die prozentuale oder absolute WR-Leistung setzen. Auch den Neustart habe ich aus dem Menü ausgelöst.

Das Problem trat gestern zum ersten Mal auf. Die Fusion läuft seit August 2024 klaglos.

Sobald wieder genug im Akku ist und die Einspeisung startet, kann ich auf den nächsten möglichen Aussetzer warten. Melde mich dann wieder mit dem Log.

Achja: vergangenen Mittwoch habe ich meine Fritz!Box 7590 AX auf Fritz!OS 8.02 aktualisiert. Nicht daß damit irgendein Bug reingekommen ist.

[schlimmchen]

Hm. Dann musst du bitte einmal scharf nachdenken, was sich gestern geändert hat 😉

[dk7td]

Keine bewußte Änderung an irgendeiner der Komponenten 🤷🏻‍♂️

[dk7td]

Das sind jetzt die aktuellen Settings:

[Snusme83]

Servus, wurde am Router was verändert in Bezug auf Wifi? Funkkanal 1 selber festgesetzt, anstatt die Fritzbox die Kanäle selber festlegen zu lassen war bei mir ein Problem beim Volkszähler!

[dk7td]

Servus! Da habe ich selbst nichts dran geändert. Sollte alles auf Automatik sein.

[Snusme83]

Ok, wenn selber nichts geändert, auf welchem Funkkanal (vergeben von der FRITZ!Box) gibt es Probleme?

[dk7td]

Das kann ich leider nicht beantworten. In der Fritz!Box sehe ich nicht, welcher Kanal an welches Endgerät vergeben ist. Die Kanalverteilung sieht so aus:

[Wox1]

Hallo, hast Du ein 24V System? - Bei mir ist es auch ähnlich. halbes Jahr lief alles gut, plötzlich passieren dann diese merkwürdigen Dinge wie bei Dir. Ich habe dann bei mir in Home Assistant (Bei mir regelt derzeit noch HA) die maximale Leistung des Hoymiles auf 400 Watt gestellt. Seit dem habe ich die Probleme nicht mehr. Nun meine Vermutung das es sich hier um das Problem mit Hoymiles an 24V System handelt. Ich werde jetzt auf jeden Fall auf 48V umstellen. Ich selber habe OpenDTUon Battery noch nicht in Betreib, aber vielleicht kann man dort auch die maximale Ausgangsleistung vom Hoymiles eingeben. Wenn ja stelle die mal auf 400 Watt und las es mal laufen.

[dk7td]

Nein, ich habe hier einen SolarFlow PVHub 1200 von Zendure. Der gibt um die 47 Volt raus. Damit sollte das kein Problem sein:

Aber danke für den Hinweis!

Die maximale Ausgangsleistung habe ich eingegeben - siehe Screenshot oben.

Natürlich läuft die ganze Sache heute völlig problemlos. War ja irgendwie zu erwarten ... mal sehen, ob es so bleibt.

[dk7td]

Hallo zusammen!
Leider haben sich meine Probleme nicht gebessert inzwischen. Ich habe die Datenübertragung vom Stromzähler von Shelly auf MQTT umgestellt (vzlogger liefert Daten per MQTT, die OpenDTU entgegennimmt), aber ich habe immer wieder Aussetzer, die sich so äußern, daß nur noch die Grundlast eingespeist wird. Wenn ich anschließend die OpenDTU neu starte, ist alles wieder wunderbar - auch über lange Zeiträume. Das bedeutet für mich, daß der MQTT-Datenstrom weiterhin verfügbar ist, und nur die OpenDTU sich irgendwie "ausklinkt" und nach dem Neustart wieder synchronisiert und alles wieder läuft.
Mir ist außerdem nicht klar, warum da nach einem solchen Aussetzer nicht automatisch wieder auf die MQTT-Daten aufgesetzt wird.

Wo kann ich hier am besten Ursachenforschung betreiben. Das Hauptproblem ist, daß der Fehler sporadisch auftritt. Manchmal täglich, manchmal eine Weile nicht. Also kein wirkliches System erkennbar.

Danke Euch!

[dk7td]

Serielle Verbindung sollte kein großes Problem darstellen, aber wie logge ich das sinnvoll. Kann PuTTY sowas? Mein kleiner Windows-„Server“ läuft hier eh mit. Bin für jeden Tip dankbar.

#1561 ist interessant. Das muß ich mal beobachten.

Danke!

[schlimmchen]

RTFM 😉

Das muß ich mal beobachten.

Ja, bitte. Und wenn du betroffen bist, melde ich sehr gerne im Issue. Das ist nämlich zwar unumstritten, dass das auftritt, und ich kenne auch einen Workaround, aber die Ursache nicht... Da könnte ich Hilfe gebrauchen.

[dk7td]

Super - vielen Dank!
Ich hab das jetzt mal eingerichtet und lasse den seriellen Log mitlaufen. Mal sehen was passiert.

Zuallererst habe ich nur diese eine Meldung auf der seriellen Konsole gesehen:

E (525) esp_core_dump_flash: No core dump partition found!

Dann habe ich einen manuellen Neustart auf der OpenDTU ausgelöst und es kam das hier:

[156588][E][WiFiSTA.cpp:357] disconnect(): disconnect failed!
[156597][E][WiFiSTA.cpp:305] begin(): config failed
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0xc (RTC_SW_CPU_RST),boot:0xb (SPI_FAST_FLASH_BOOT)
Saved PC:0x4216271a
SPIWP:0xee
mode:DOUT, clock div:2
load:0x3fce3808,len:0x4bc
load:0x403c9700,len:0xbd8
load:0x403cc700,len:0x2a0c
SHA-256 comparison failed:
Calculated: ca4adcc736b98868c479048883edac1969cfd9dde0951723205cf1625628f181
Expected: 27accf466d6a3ffbdd2fe4a9dcdf2a85d67a20eb4b1f2dced8b0c8a88771aee2
Attempting to boot anyway...
entry 0x403c98d0
E (525) esp_core_dump_flash: No core dump partition found!
E (525) esp_core_dump_flash: No core dump partition found!

Hoffe, das ist plausibel und es wird dann auch was geloggt, wenn ein Fehler auftritt.

[dk7td]

Was bedeutet "Software reset CPU" genau? Gibt es da eine Art Watchdog?

Ja, davon ist auszugehen. Aber dann mach ich mir jetzt keine Arbeit, den Log zu durchforsten. Das ist ja keine einfache Sache da etwas zu entdecken...
Kannst du das einfangen per serieller Verbindung?

Es gab keinen Reset. Die OpenDTU ist einfach so "ausgestiegen" und hat nur noch ihren fixen Wert eingespeist. Wenn ich dann manuell einen Neustart auslöse, ist alles ok. Es ist eben schwierig, den genauen Zeitpunkt abzufangen und dann zu diesem auch noch das passende Log greifbar zu haben.

Jedenfalls ist das ganze ziemlich frustrierend, da man ständig ein Auge auf das System haben muß, um ggf. einen Neustart auslösen zu können. Vielleicht könnte man eine Neustart-Option implementieren, die über einen einstellbaren Timeout ausgelöst wird, sobald auf eine fixe Einspeisung gewechselt wurde? Also quasi eine Art Watchdog, wenn die Verbindung zum Stromzähler verlorengegangen zu sein scheint. Ein (manueller) Neustart hat das bei mir bisher immer beheben können.

Bist du von #1561 betroffen?

Dazu habe ich im entsprechenden Issue geantwortet. Scheint hiermit aber nichts zu tun zu haben.
Schön wäre es natürlich, wenn man das Konsolen-Log über die serielle Schnittstelle ausgeben könnte, dann könnte man es dort einfach mitschreiben, ohne das Browserfenster offenlassen zu müssen.

[dk7td]

Jetzt ist er heute bereits zum dritten Mal ausgestiegen 🙁

[dk7td]

Moin!
Was ich bisher nicht verstehe: es ist ja ok, daß bei kurzzeitigem Verlust der Daten vom Stromzähler auf den eingestellten Grundlast-Wert gewechselt wird. Aber dann sollte auch wieder zurückgeschaltet werden auf die dynamische Regelung, sobald die Verbindung wieder da ist.
Mein Zähler liefert die Daten per MQTT, diese sind nachweislich ständig verfügbar, und der Aussetzer der Verbindung dauert nur wenige Sekunden, wenn überhaupt. Trotzdem verbleibt OpenDTU auf der Grundlast.

[Snusme83]

Das ist dein Zähler, oder?

Scheinbar kann der die Momentanleistung auf dem Display anzeigen. Wieso er es bei dir nicht tut weiß ich nicht. Ich könnte es mir nur so erklären, dass du die PIN nicht im Stromzähler eingegeben hast vom Netzanbieter.

Was die Probleme waren bei mir hab ich deutlich erklärt:

• Inkompatiblität des ESP32 mit bestimmten Funkkanälen im Wifi der FRITZ!Box.
• Infrarotschnittstelle defekt

[Snusme83]

Was hast denn für einen IR-Lesekopf?
An welchem Mikrocontroller hängt dieser?

[dk7td]

Exakt dieser Zähler. PIN wurde natürlich eingegeben, sonst liefert der die sekündlichen Leistungswerte gar nicht. Der Zähler läuft seit Anfang 2023 ohne Probleme. Im unteren Fwld wird nichts angezeigt. Möglicherweise könnte man das mit „Anblinken“ umschalten, aber ich habe keine Lust, den funktionierenden Lesekopf abzunehmen oder zu verschieben.

Das ist ein USB-Lesekopf von ELV, der an einem Raspberry Pi 4B hängt und von vzlogger ausgewertet wird. Auch das läuft seit Anfang 2023 ohne Probleme.

Es hat ja bis vor Kurzem auch völlig problemlos und ohne Aussetzer funktioniert. Ich kann allerdings nicht mehr nachvollziehen, bis zu welcher OpenDTU-OnBattery-Version. Irgendwann gingen die Aussetzer los und ich weiß nicht warum. Ich habe hier nichts geändert an meiner Konfiguration - bis auf Updates von OpenDTU.

[spcqike]

Das werden jetzt ja langsam wilde Spekulationen hier ...

sry aber mit den Informationen kann man da nur spekulieren ;) und, möglich wäre es gewesen. Dass dem nicht so ist, hast du ja dargelegt.

Leider zeigt der log nicht den Fehler Moment. Eigentlich zeigt er nichts, oder? Außer, dass du dort regelmäßig powermeter werte bekommst und die Regelung läuft

[dk7td]

Leider zeigt der log nicht den Fehler Moment. Eigentlich zeigt er nichts, oder? Außer, dass du dort regelmäßig powermeter werte bekommst und die Regelung läuft

Korrekt - das sollte einfach mal ein Logauszug davon sein, daß die Regelung grundsätzlich sauber läuft. Ich dachte, daß man da vielleicht schon irgendwelche potentiellen Fehler oder Unstimmigkeiten sehen kann, die eine Ursache sein könnten.

Diese Regelung läuft auch nach einem Aussetzer problemlos weiter, wenn man die OpenDTU neu startet. Daher auch meine Idee, einen Watchdog zu implementieren, der nach einer wählbaren Anzahl von Sekunden Grundeinspeisung einen Neustart auslöst. Das scheint ja - zumindest in meinem Falle - zu helfen, denn anschließend funktioniert die Regelung SOFORT wieder sauber.

[dk7td]

Was mir gerade noch aufgefallen ist: es wird definitiv nicht die von mir eingestellte Grundlast von 150W eingespeist, sondern Werte etwas über 80W. Heute waren es beim ersten Aussetzer so um die 80W, beim zweiten Mal so um die 87W und beim dritten Mal nur so um die 48W. In allen drei Fällen lief es nach einem Neustart wieder sauber an. Ggf. braucht es manchmal auch einen zweiten Neustart.

DPL ist wie folgt eingestellt. Die -30W Netzbezug (also 30W Einspeisung) sind gewollt, das ist ein anderes Thema, das hier nicht hinpaßt.

Ich habe absolut keine Idee, wie ich hier weiterkommen kann.

[spcqike]

Das versuche ich ja schon recht lange. Da der Fehler nur sporadisch auftritt und das Konsolenlog im Browser leider auch mal hängenbleibt, ist das nicht so einfach.

kannst du denn nicht, wenn der Fehler da ist, den Kosolenlog öffnen? du schreibst ja, dass du sporadisch Fehler hast, die du durch einen Neustart beheben kannst.

Heute waren es beim ersten Aussetzer so um die 80W, beim zweiten Mal so um die 87W und beim dritten Mal nur so um die 48W. In allen drei Fällen lief es nach einem Neustart wieder sauber an. Ggf. braucht es manchmal auch einen zweiten Neustart.

Kannst du einfach vorher die Konsole öffnen und einen oder mehrere DPL Zyklen durchlaufen lassen? evnetuell steht da ja drin, warum der DPL meint, nicht regeln zu müssen oder zu können.

Nachtrag:
und sonst: haltet euch beide mal zusammen :) das Ganze muss ja nicht persönlich werden oder ausarten 😄
ich kann @Snusme83 schon verstehen. wir sind alle nicht allwissend und versuchen bestmöglich zu helfen. Es gibt und gab halt schon viele Fehlerquellen, auf die man erstmal kommen muss :D wo niemand dran denkt, dass das überhaupt wichtig sein könnte.

ich kann dich, @dk7td, aber auch verstehen. die Setups sind einmalig. und führend manchmal ein Eigenleben.

mein Setup ist davon nicht ausgenommen.
Ich habe bspw. seit Monaten sporadisch und nicht reproduzierbar Probleme mit der Verbindung vom CMT. der HMS-2000 wird manchmal nicht erreicht. Warum? Keine Ahnung. mal gehts für Wochen gut. mal bricht es quasi stündlich ab.
die letzten Tage sind auch bei mir wieder so, dass entweder die Kommunikation nicht mehr läuft, oder sogar die openDTU abstürzt und neustartet (früher mit DEV Board, seit Ende letzten Jahres mit Fusionboard)
Gefunden hab ich das Problem noch nicht. und, ich scheine der einzige zu sein, dem es so geht.

Da ich noch keinen Akku habe und der DPL aktuell so oder so nicht aktiv ist, ist mir das grade nicht wichtig. :D aber, ich kenne die Probleme mit nicht auffindbaren Problemen.

[dk7td]

Danke für Deine Antwort!

Das versuche ich ja schon recht lange. Da der Fehler nur sporadisch auftritt und das Konsolenlog im Browser leider auch mal hängenbleibt, ist das nicht so einfach.

kannst du denn nicht, wenn der Fehler da ist, den Kosolenlog öffnen? du schreibst ja, dass du sporadisch Fehler hast, die du durch einen Neustart beheben kannst.

Natürlich kann ich das. Ich war mir nur nicht sicher, ob das dann noch viel bringt. Ich habe bisher immer versucht, den Zeitpunkt des Aussteigens mit zu erfassen.
Mache ich beim nächsten mal gerne und werde es hier posten.

Heute waren es beim ersten Aussetzer so um die 80W, beim zweiten Mal so um die 87W und beim dritten Mal nur so um die 48W. In allen drei Fällen lief es nach einem Neustart wieder sauber an. Ggf. braucht es manchmal auch einen zweiten Neustart.

Kannst du einfach vorher die Konsole öffnen und einen oder mehrere DPL Zyklen durchlaufen lassen? evnetuell steht da ja drin, warum der DPL meint, nicht regeln zu müssen oder zu können.

Du meinst bei aktivem Fehlerbild und vor dem Neustart? Das mache ich.

Danke!

[dk7td]

War ja klar, daß es heute keinen Fehler gibt ... Murphy!
Sobald ich was habe, stelle ich die Logs hier rein.

[Snusme83]

Damit unterstellst Du schon wieder, daß ich offenbar "zu blöd" bin, wie schon mehrfach unterschwellig. Das macht so langsam keinen Spaß mehr!

Nein, das mache ich eben nicht!

Was ich lediglich damit sagen wollte ist:

An der neuen Firmware 2025.02.10 der oDTUoB kann es nicht liegen, weil sonst hätte ich und andere das selbe Problem wie du. Habe ich aber nicht.
Dann muss es eben an was anderem (Konfiguration, Aufbau, Mikrocontroller, FRITZ!Box, Repeater, oder weiß der Kuckuck was) liegen und das versuchen wir ja herauszufinden!

Hab vorerst keine Idee mehr. Vielleicht kann ja jemand anhand den Logs was rauslesen!🤷🏻‍♂️

[dk7td]

Danke auf alle Fälle. Sobald es ein Log zu zeigen gibt, seht Ihr es hier. Mittlerweile schreibt auch die serielle Konsole alles mit. Hab die OpenDTU nochmal komplett neu geflasht inkl. erase.

Der Stromzähler merkt sich übrigens die Watt-Anzeige nicht über einen Stromausfall hinweg und muß dann erneut per PIN freigeschaltet werden. Steht zumindest in der Hersteller-Dokumentation.

[dk7td]

Hallo zusammen!

Den Zeitpunkt des Umschaltens auf eine statische Umschaltung hab ich leider verpaßt, aber hier ist ein Logauszug des aktuellen Zustandes. Vielleicht kann einer der Experten etwas damit anfangen. Vielen Dank schonmal an Euch alle!

Log

Fetch inverter: 114190550241
14:05:49.691 > Queue size - NRF: 3 CMT: 0
14:05:49.748 > RX Period End
14:05:49.795 > All missing
14:05:49.841 > Nothing received, resend whole request
14:05:49.888 > TX AlarmData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 A8 00 00 00 00 00 00 00 00 1A 66 94 
14:05:49.991 > Websocket: [/livedata][3] disconnect
14:05:50.041 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:50.115 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 106.00, total: 106.00
14:05:50.164 > [DPL] targeting -30 W, base load is 150 W, power meter reads 106.0 W (valid)
14:05:50.208 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:50.257 > [DPL] requesting 235 W from 1 solar-powered inverter currently producing 99 W (diff 136 W, hysteresis 10 W)
14:05:50.400 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:50.566 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 136 W AC
14:05:50.810 > [DPL inverter 114190550241]:
14:05:50.859 >     solar-powered, producing 99 W
14:05:50.904 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:50.950 >     sending commands enabled, reachable, eligible
14:05:50.996 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:51.042 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:51.104 >     MPPTs AC power: a: 50 W b: 49 W
14:05:51.153 > RX Period End
14:05:51.426 > All missing
14:05:51.564 > Nothing received, resend whole request
14:05:51.622 > TX AlarmData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 A8 00 00 00 00 00 00 00 00 1A 66 94 
14:05:51.834 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:51.888 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 120.00, total: 120.00
14:05:52.039 > [DPL] targeting -30 W, base load is 150 W, power meter reads 120.0 W (valid)
14:05:52.111 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:52.161 > [DPL] requesting 249 W from 1 solar-powered inverter currently producing 99 W (diff 150 W, hysteresis 10 W)
14:05:52.208 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:52.449 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 150 W AC
14:05:52.501 > [DPL inverter 114190550241]:
14:05:52.566 >     solar-powered, producing 99 W
14:05:52.628 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:52.960 >     sending commands enabled, reachable, eligible
14:05:53.008 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:53.054 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:53.104 >     MPPTs AC power: a: 50 W b: 49 W
14:05:53.267 > RX Period End
14:05:53.339 > All missing
14:05:53.472 > Nothing received, resend count exeeded
14:05:53.524 > TX SystemConfigPara Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 A8 00 00 00 00 00 00 00 00 0E 72 80 
14:05:53.580 > RX Period End
14:05:53.635 > All missing
14:05:53.688 > Nothing received, resend whole request
14:05:53.731 > TX SystemConfigPara Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 A8 00 00 00 00 00 00 00 00 0E 72 80 
14:05:53.780 > RX Period End
14:05:53.897 > All missing
14:05:53.947 > Nothing received, resend whole request
14:05:53.997 > TX SystemConfigPara Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 A8 00 00 00 00 00 00 00 00 0E 72 80 
14:05:54.053 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:54.108 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 153.00, total: 153.00
14:05:54.295 > RX Period End
14:05:54.349 > All missing
14:05:54.570 > Nothing received, resend whole request
14:05:54.701 > TX SystemConfigPara Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 A8 00 00 00 00 00 00 00 00 0E 72 80 
14:05:54.752 > [DPL] targeting -30 W, base load is 150 W, power meter reads 153.0 W (valid)
14:05:54.803 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:54.860 > [DPL] requesting 282 W from 1 solar-powered inverter currently producing 99 W (diff 183 W, hysteresis 10 W)
14:05:54.910 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:55.040 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 183 W AC
14:05:55.107 > [DPL inverter 114190550241]:
14:05:55.152 >     solar-powered, producing 99 W
14:05:55.201 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:55.318 >     sending commands enabled, reachable, eligible
14:05:55.366 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:55.420 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:55.521 >     MPPTs AC power: a: 50 W b: 49 W
14:05:55.566 > RX Period End
14:05:55.617 > All missing
14:05:55.828 > Nothing received, resend whole request
14:05:55.879 > TX SystemConfigPara Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 A8 00 00 00 00 00 00 00 00 0E 72 80 
14:05:55.923 > RX Period End
14:05:55.970 > All missing
14:05:56.020 > Nothing received, resend count exeeded
14:05:56.079 > TX RealTimeRunData Channel: 3 --> 15 90 55 02 41 80 18 83 32 80 0B 00 67 BF 11 AD 00 00 00 00 00 00 00 00 90 42 87 
14:05:56.123 > Interrupt received
14:05:56.173 > RX Channel: 40 --> 95 90 55 02 41 90 55 02 41 01 00 01 01 D0 00 72 02 0F 01 CD 00 70 02 06 00 08 8B | -80 dBm
14:05:56.218 > Interrupt received
14:05:56.264 > RX Channel: 75 --> 95 90 55 02 41 90 55 02 41 02 04 52 00 07 B8 FB 01 2F 01 30 08 C6 13 87 03 E3 20 | -80 dBm
14:05:56.311 > Interrupt received
14:05:56.358 > RX Channel: 3 --> 95 90 55 02 41 90 55 02 41 83 00 01 00 2C 03 E8 00 D9 00 11 5A 1D 5F | -30 dBm
14:05:56.410 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:56.544 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 128.00, total: 128.00
14:05:56.593 > RX Period End
14:05:56.636 > Success
14:05:56.683 > [DPL] targeting -30 W, base load is 150 W, power meter reads 128.0 W (valid)
14:05:56.730 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:56.789 > [DPL] requesting 257 W from 1 solar-powered inverter currently producing 99 W (diff 158 W, hysteresis 10 W)
14:05:56.835 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:56.884 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 158 W AC
14:05:56.953 > [DPL inverter 114190550241]:
14:05:57.006 >     solar-powered, producing 99 W
14:05:57.063 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:57.123 >     sending commands enabled, reachable, eligible
14:05:57.172 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:57.221 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:57.266 >     MPPTs AC power: a: 50 W b: 49 W
14:05:57.313 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:57.357 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 135.00, total: 135.00
14:05:57.408 > [DPL] targeting -30 W, base load is 150 W, power meter reads 135.0 W (valid)
14:05:57.564 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:57.774 > [DPL] requesting 264 W from 1 solar-powered inverter currently producing 99 W (diff 165 W, hysteresis 10 W)
14:05:57.825 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:57.871 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 165 W AC
14:05:57.919 > [DPL inverter 114190550241]:
14:05:57.963 >     solar-powered, producing 99 W
14:05:58.008 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:58.058 >     sending commands enabled, reachable, eligible
14:05:58.116 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:58.161 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:58.207 >     MPPTs AC power: a: 50 W b: 49 W
14:05:58.259 > Fetch inverter: 114184847551
14:05:58.387 > Request SystemConfigPara
14:05:58.443 > Queue size - NRF: 3 CMT: 0
14:05:58.568 > TX RealTimeRunData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 B2 00 00 00 00 00 00 00 00 A0 CE 86 
14:05:58.797 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:05:58.843 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 128.00, total: 128.00
14:05:58.889 > RX Period End
14:05:58.936 > All missing
14:05:58.986 > Nothing received, resend whole request
14:05:59.049 > TX RealTimeRunData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 B2 00 00 00 00 00 00 00 00 A0 CE 86 
14:05:59.113 > [DPL] targeting -30 W, base load is 150 W, power meter reads 128.0 W (valid)
14:05:59.166 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:05:59.214 > [DPL] requesting 257 W from 1 solar-powered inverter currently producing 99 W (diff 158 W, hysteresis 10 W)
14:05:59.265 > [DPL] will cover 99 W using 1 solar-powered inverter
14:05:59.321 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 158 W AC
14:05:59.365 > [DPL inverter 114190550241]:
14:05:59.416 >     solar-powered, producing 99 W
14:05:59.690 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:05:59.737 >     sending commands enabled, reachable, eligible
14:05:59.786 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:05:59.829 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:05:59.889 >     MPPTs AC power: a: 50 W b: 49 W
14:06:00.047 > RX Period End
14:06:00.119 > All missing
14:06:00.170 > Nothing received, resend whole request
14:06:00.226 > TX RealTimeRunData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 B2 00 00 00 00 00 00 00 00 A0 CE 86 
14:06:00.278 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:00.347 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 131.00, total: 131.00
14:06:00.435 > RX Period End
14:06:00.491 > All missing
14:06:00.543 > Nothing received, resend whole request
14:06:00.594 > TX RealTimeRunData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 B2 00 00 00 00 00 00 00 00 A0 CE 86 
14:06:00.845 > [DPL] targeting -30 W, base load is 150 W, power meter reads 131.0 W (valid)
14:06:00.902 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:00.949 > [DPL] requesting 260 W from 1 solar-powered inverter currently producing 99 W (diff 161 W, hysteresis 10 W)
14:06:01.050 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:01.112 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 161 W AC
14:06:01.160 > [DPL inverter 114190550241]:
14:06:01.207 >     solar-powered, producing 99 W
14:06:01.258 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:01.317 >     sending commands enabled, reachable, eligible
14:06:01.372 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:01.429 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:01.489 >     MPPTs AC power: a: 50 W b: 49 W
14:06:01.537 > RX Period End
14:06:01.595 > All missing
14:06:01.642 > Nothing received, resend whole request
14:06:01.686 > TX RealTimeRunData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 B2 00 00 00 00 00 00 00 00 A0 CE 86 
14:06:01.732 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:01.778 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 116.00, total: 116.00
14:06:01.825 > RX Period End
14:06:01.872 > All missing
14:06:01.921 > Nothing received, resend count exeeded
14:06:02.052 > TX AlarmData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 B2 00 00 00 00 00 00 00 00 7A D5 5D 
14:06:02.118 > [DPL] targeting -30 W, base load is 150 W, power meter reads 116.0 W (valid)
14:06:02.199 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:02.279 > [DPL] requesting 245 W from 1 solar-powered inverter currently producing 99 W (diff 146 W, hysteresis 10 W)
14:06:02.357 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:02.485 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 146 W AC
14:06:02.533 > [DPL inverter 114190550241]:
14:06:02.591 >     solar-powered, producing 99 W
14:06:02.637 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:02.682 >     sending commands enabled, reachable, eligible
14:06:02.729 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:02.779 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:02.894 >     MPPTs AC power: a: 50 W b: 49 W
14:06:02.946 > [DPL] the system is stable, the last power limit is still valid
14:06:02.990 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:03.043 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 136.00, total: 136.00
14:06:03.112 > RX Period End
14:06:03.161 > All missing
14:06:03.319 > Nothing received, resend whole request
14:06:03.382 > TX AlarmData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 B2 00 00 00 00 00 00 00 00 7A D5 5D 
14:06:03.509 > [DPL] targeting -30 W, base load is 150 W, power meter reads 136.0 W (valid)
14:06:03.563 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:03.610 > [DPL] requesting 265 W from 1 solar-powered inverter currently producing 99 W (diff 166 W, hysteresis 10 W)
14:06:03.712 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:03.760 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 166 W AC
14:06:03.811 > [DPL inverter 114190550241]:
14:06:03.869 >     solar-powered, producing 99 W
14:06:03.917 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:03.966 >     sending commands enabled, reachable, eligible
14:06:04.052 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:04.117 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:04.163 >     MPPTs AC power: a: 50 W b: 49 W
14:06:04.212 > RX Period End
14:06:04.326 > All missing
14:06:04.533 > Nothing received, resend whole request
14:06:04.580 > TX AlarmData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 B2 00 00 00 00 00 00 00 00 7A D5 5D 
14:06:04.627 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:04.672 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 130.00, total: 130.00
14:06:04.719 > [DPL] targeting -30 W, base load is 150 W, power meter reads 130.0 W (valid)
14:06:04.784 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:04.941 > [DPL] requesting 259 W from 1 solar-powered inverter currently producing 99 W (diff 160 W, hysteresis 10 W)
14:06:05.056 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:05.114 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 160 W AC
14:06:05.351 > [DPL inverter 114190550241]:
14:06:05.405 >     solar-powered, producing 99 W
14:06:05.448 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:05.494 >     sending commands enabled, reachable, eligible
14:06:05.543 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:05.589 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:05.635 >     MPPTs AC power: a: 50 W b: 49 W
14:06:05.683 > Fetch inverter: 114190550241
14:06:05.727 > Queue size - NRF: 3 CMT: 0
14:06:05.772 > RX Period End
14:06:05.825 > All missing
14:06:05.879 > Nothing received, resend whole request
14:06:05.924 > TX AlarmData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 B2 00 00 00 00 00 00 00 00 7A D5 5D 
14:06:05.972 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:06.023 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 135.00, total: 135.00
14:06:06.079 > [DPL] targeting -30 W, base load is 150 W, power meter reads 135.0 W (valid)
14:06:06.135 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:06.190 > [DPL] requesting 264 W from 1 solar-powered inverter currently producing 99 W (diff 165 W, hysteresis 10 W)
14:06:06.377 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:06.421 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 165 W AC
14:06:06.471 > [DPL inverter 114190550241]:
14:06:06.567 >     solar-powered, producing 99 W
14:06:06.804 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:06.854 >     sending commands enabled, reachable, eligible
14:06:06.900 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:06.952 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:07.057 >     MPPTs AC power: a: 50 W b: 49 W
14:06:07.113 > RX Period End
14:06:07.166 > All missing
14:06:07.231 > Nothing received, resend whole request
14:06:07.321 > TX AlarmData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 B2 00 00 00 00 00 00 00 00 7A D5 5D 
14:06:07.376 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:07.429 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 131.00, total: 131.00
14:06:07.478 > RX Period End
14:06:07.561 > All missing
14:06:07.614 > Nothing received, resend count exeeded
14:06:07.662 > TX SystemConfigPara Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 B2 00 00 00 00 00 00 00 00 6E C1 49 
14:06:07.707 > [DPL] targeting -30 W, base load is 150 W, power meter reads 131.0 W (valid)
14:06:07.753 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:07.801 > [DPL] requesting 260 W from 1 solar-powered inverter currently producing 99 W (diff 161 W, hysteresis 10 W)
14:06:07.859 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:07.906 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 161 W AC
14:06:07.953 > [DPL inverter 114190550241]:
14:06:08.013 >     solar-powered, producing 99 W
14:06:08.059 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:08.117 >     sending commands enabled, reachable, eligible
14:06:08.168 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:08.213 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:08.260 >     MPPTs AC power: a: 50 W b: 49 W
14:06:08.305 > RX Period End
14:06:08.352 > All missing
14:06:08.401 > Nothing received, resend whole request
14:06:08.565 > TX SystemConfigPara Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 B2 00 00 00 00 00 00 00 00 6E C1 49 
14:06:08.616 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:08.832 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 143.00, total: 143.00
14:06:08.894 > RX Period End
14:06:09.037 > All missing
14:06:09.090 > Nothing received, resend whole request
14:06:09.140 > TX SystemConfigPara Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 B2 00 00 00 00 00 00 00 00 6E C1 49 
14:06:09.243 > RX Period End
14:06:09.294 > All missing
14:06:09.352 > Nothing received, resend whole request
14:06:09.403 > TX SystemConfigPara Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 B2 00 00 00 00 00 00 00 00 6E C1 49 
14:06:09.567 > RX Period End
14:06:09.789 > All missing
14:06:09.836 > Nothing received, resend whole request
14:06:09.881 > TX SystemConfigPara Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 B2 00 00 00 00 00 00 00 00 6E C1 49 
14:06:10.061 > [DPL] targeting -30 W, base load is 150 W, power meter reads 143.0 W (valid)
14:06:10.132 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:10.265 > [DPL] requesting 272 W from 1 solar-powered inverter currently producing 99 W (diff 173 W, hysteresis 10 W)
14:06:10.324 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:10.373 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 173 W AC
14:06:10.422 > [DPL inverter 114190550241]:
14:06:10.565 >     solar-powered, producing 99 W
14:06:10.706 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:10.755 >     sending commands enabled, reachable, eligible
14:06:10.801 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:10.856 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:11.063 >     MPPTs AC power: a: 50 W b: 49 W
14:06:11.116 > RX Period End
14:06:11.289 > All missing
14:06:11.353 > Nothing received, resend count exeeded
14:06:11.403 > TX RealTimeRunData Channel: 23 --> 15 90 55 02 41 80 18 83 32 80 0B 00 67 BF 11 B7 00 00 00 00 00 00 00 00 F0 F1 4E 
14:06:11.448 > Interrupt received
14:06:11.494 > RX Channel: 75 --> 95 90 55 02 41 90 55 02 41 01 00 01 01 D0 00 6D 01 FA 01 CD 00 6C 01 F0 00 08 8B | -80 dBm
14:06:11.538 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:11.586 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 131.00, total: 131.00
14:06:11.632 > RX Period End
14:06:11.678 > Last missing
14:06:11.726 > Request retransmit: 2
14:06:11.778 > TX RequestFrame Channel: 40 --> 15 90 55 02 41 80 18 83 32 82 38 
14:06:11.904 > RX Period End
14:06:11.960 > Last missing
14:06:12.064 > Request retransmit: 2
14:06:12.121 > TX RequestFrame Channel: 61 --> 15 90 55 02 41 80 18 83 32 82 38 
14:06:12.174 > RX Period End
14:06:12.314 > Last missing
14:06:12.370 > Request retransmit: 2
14:06:12.420 > TX RequestFrame Channel: 75 --> 15 90 55 02 41 80 18 83 32 82 38 
14:06:12.527 > Interrupt received
14:06:12.570 > RX Channel: 3 --> 95 90 55 02 41 90 55 02 41 02 04 52 00 07 B8 FB 01 2F 01 30 08 CC 13 88 03 BA 7C | -80 dBm
14:06:12.623 > RX Period End
14:06:12.679 > Last missing
14:06:12.726 > Request retransmit: 3
14:06:12.793 > TX RequestFrame Channel: 3 --> 15 90 55 02 41 80 18 83 32 83 39 
14:06:12.846 > [DPL] targeting -30 W, base load is 150 W, power meter reads 131.0 W (valid)
14:06:12.895 > [DPL] inverter 114190550241 is behind power meter producing 99 W
14:06:12.941 > [DPL] requesting 260 W from 1 solar-powered inverter currently producing 99 W (diff 161 W, hysteresis 10 W)
14:06:12.985 > [DPL] will cover 99 W using 1 solar-powered inverter
14:06:13.030 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 161 W AC
14:06:13.075 > [DPL inverter 114190550241]:
14:06:13.123 >     solar-powered, producing 99 W
14:06:13.171 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:13.214 >     sending commands enabled, reachable, eligible
14:06:13.266 >     max reduction production/standby: 49/49 W, max increase: 0 W
14:06:13.329 >     target limit/output/state: -1 W (unchanged)/99 W/unchanged, 0 update timeouts
14:06:13.386 >     MPPTs AC power: a: 50 W b: 49 W
14:06:13.430 > RX Period End
14:06:13.476 > Last missing
14:06:13.521 > Request retransmit: 3
14:06:13.574 > TX RequestFrame Channel: 23 --> 15 90 55 02 41 80 18 83 32 83 39 
14:06:13.747 > Interrupt received
14:06:13.799 > RX Channel: 23 --> 95 90 55 02 41 90 55 02 41 83 00 00 00 2A 03 E8 00 D7 00 11 1E EE E1 | -80 dBm
14:06:13.847 > RX Period End
14:06:13.892 > Success
14:06:13.941 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:14.068 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 125.00, total: 125.00
14:06:14.125 > Fetch inverter: 114184847551
14:06:14.259 > Request SystemConfigPara
14:06:14.365 > Queue size - NRF: 3 CMT: 0
14:06:14.427 > TX RealTimeRunData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 BC 00 00 00 00 00 00 00 00 C0 82 A4 
14:06:14.487 > [DPL] targeting -30 W, base load is 150 W, power meter reads 125.0 W (valid)
14:06:14.563 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:14.771 > [DPL] requesting 250 W from 1 solar-powered inverter currently producing 95 W (diff 155 W, hysteresis 10 W)
14:06:14.819 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:14.866 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 155 W AC
14:06:14.911 > [DPL inverter 114190550241]:
14:06:14.968 >     solar-powered, producing 95 W
14:06:15.020 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:15.066 >     sending commands enabled, reachable, eligible
14:06:15.129 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:15.385 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:15.435 >     MPPTs AC power: a: 48 W b: 47 W
14:06:15.601 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:15.654 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 129.00, total: 129.00
14:06:15.798 > RX Period End
14:06:15.853 > All missing
14:06:15.901 > Nothing received, resend whole request
14:06:15.947 > TX RealTimeRunData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 BC 00 00 00 00 00 00 00 00 C0 82 A4 
14:06:15.991 > RX Period End
14:06:16.038 > All missing
14:06:16.082 > Nothing received, resend whole request
14:06:16.139 > TX RealTimeRunData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 BC 00 00 00 00 00 00 00 00 C0 82 A4 
14:06:16.193 > [DPL] targeting -30 W, base load is 150 W, power meter reads 129.0 W (valid)
14:06:16.239 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:16.288 > [DPL] requesting 254 W from 1 solar-powered inverter currently producing 95 W (diff 159 W, hysteresis 10 W)
14:06:16.356 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:16.405 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 159 W AC
14:06:16.452 > [DPL inverter 114190550241]:
14:06:16.499 >     solar-powered, producing 95 W
14:06:16.545 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:16.593 >     sending commands enabled, reachable, eligible
14:06:16.819 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:16.870 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:17.024 >     MPPTs AC power: a: 48 W b: 47 W
14:06:17.083 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:17.133 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 130.00, total: 130.00
14:06:17.228 > RX Period End
14:06:17.453 > All missing
14:06:17.500 > Nothing received, resend whole request
14:06:17.549 > TX RealTimeRunData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 BC 00 00 00 00 00 00 00 00 C0 82 A4 
14:06:17.592 > RX Period End
14:06:17.638 > All missing
14:06:17.686 > Nothing received, resend whole request
14:06:17.737 > TX RealTimeRunData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 BC 00 00 00 00 00 00 00 00 C0 82 A4 
14:06:17.843 > [DPL] targeting -30 W, base load is 150 W, power meter reads 130.0 W (valid)
14:06:18.047 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:18.103 > [DPL] requesting 255 W from 1 solar-powered inverter currently producing 95 W (diff 160 W, hysteresis 10 W)
14:06:18.146 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:18.192 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 160 W AC
14:06:18.237 > [DPL inverter 114190550241]:
14:06:18.284 >     solar-powered, producing 95 W
14:06:18.331 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:18.394 >     sending commands enabled, reachable, eligible
14:06:18.458 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:18.563 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:18.663 >     MPPTs AC power: a: 48 W b: 47 W
14:06:18.711 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:18.759 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 134.00, total: 134.00
14:06:18.804 > RX Period End
14:06:18.851 > All missing
14:06:18.899 > Nothing received, resend count exeeded
14:06:19.068 > TX AlarmData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 BC 00 00 00 00 00 00 00 00 1A 99 7F 
14:06:19.127 > [DPL] the system is stable, the last power limit is still valid
14:06:19.174 > [DPL] targeting -30 W, base load is 150 W, power meter reads 134.0 W (valid)
14:06:19.220 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:19.267 > [DPL] requesting 259 W from 1 solar-powered inverter currently producing 95 W (diff 164 W, hysteresis 10 W)
14:06:19.332 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:19.388 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 164 W AC
14:06:19.439 > [DPL inverter 114190550241]:
14:06:19.691 >     solar-powered, producing 95 W
14:06:19.745 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:19.791 >     sending commands enabled, reachable, eligible
14:06:19.836 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:19.883 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:19.927 >     MPPTs AC power: a: 48 W b: 47 W
14:06:19.979 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:20.097 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 126.00, total: 126.00
14:06:20.146 > RX Period End
14:06:20.193 > All missing
14:06:20.239 > Nothing received, resend whole request
14:06:20.291 > TX AlarmData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 BC 00 00 00 00 00 00 00 00 1A 99 7F 
14:06:20.359 > [DPL] targeting -30 W, base load is 150 W, power meter reads 126.0 W (valid)
14:06:20.408 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:20.456 > [DPL] requesting 251 W from 1 solar-powered inverter currently producing 95 W (diff 156 W, hysteresis 10 W)
14:06:20.566 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:20.710 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 156 W AC
14:06:20.788 > [DPL inverter 114190550241]:
14:06:20.842 >     solar-powered, producing 95 W
14:06:20.891 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:20.934 >     sending commands enabled, reachable, eligible
14:06:20.979 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:21.030 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:21.085 >     MPPTs AC power: a: 48 W b: 47 W
14:06:21.133 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:21.183 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 121.00, total: 121.00
14:06:21.294 > RX Period End
14:06:21.370 > All missing
14:06:21.427 > Nothing received, resend whole request
14:06:21.473 > TX AlarmData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 BC 00 00 00 00 00 00 00 00 1A 99 7F 
14:06:21.564 > Fetch inverter: 114190550241
14:06:21.609 > Queue size - NRF: 3 CMT: 0
14:06:21.656 > RX Period End
14:06:21.734 > All missing
14:06:21.939 > Nothing received, resend whole request
14:06:22.069 > TX AlarmData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 BC 00 00 00 00 00 00 00 00 1A 99 7F 
14:06:22.133 > [DPL] targeting -30 W, base load is 150 W, power meter reads 121.0 W (valid)
14:06:22.180 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:22.227 > [DPL] requesting 246 W from 1 solar-powered inverter currently producing 95 W (diff 151 W, hysteresis 10 W)
14:06:22.273 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:22.321 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 151 W AC
14:06:22.365 > [DPL inverter 114190550241]:
14:06:22.417 >     solar-powered, producing 95 W
14:06:22.556 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:22.613 >     sending commands enabled, reachable, eligible
14:06:22.659 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:22.705 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:22.759 >     MPPTs AC power: a: 48 W b: 47 W
14:06:22.816 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:22.863 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 126.00, total: 126.00
14:06:22.913 > RX Period End
14:06:23.071 > All missing
14:06:23.129 > Nothing received, resend whole request
14:06:23.175 > TX AlarmData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 BC 00 00 00 00 00 00 00 00 1A 99 7F 
14:06:23.226 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:23.372 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 156.00, total: 156.00
14:06:23.434 > [DPL] targeting -30 W, base load is 150 W, power meter reads 156.0 W (valid)
14:06:23.486 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:23.532 > [DPL] requesting 281 W from 1 solar-powered inverter currently producing 95 W (diff 186 W, hysteresis 10 W)
14:06:23.589 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:23.635 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 186 W AC
14:06:23.683 > [DPL inverter 114190550241]:
14:06:23.784 >     solar-powered, producing 95 W
14:06:23.991 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:24.035 >     sending commands enabled, reachable, eligible
14:06:24.079 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:24.131 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:24.192 >     MPPTs AC power: a: 48 W b: 47 W
14:06:24.397 > RX Period End
14:06:24.564 > All missing
14:06:24.608 > Nothing received, resend count exeeded
14:06:24.655 > TX SystemConfigPara Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 BC 00 00 00 00 00 00 00 00 0E 8D 6B 
14:06:24.809 > RX Period End
14:06:24.859 > All missing
14:06:25.011 > Nothing received, resend whole request
14:06:25.058 > TX SystemConfigPara Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 BC 00 00 00 00 00 00 00 00 0E 8D 6B 
14:06:25.104 > RX Period End
14:06:25.152 > All missing
14:06:25.216 > Nothing received, resend whole request
14:06:25.421 > TX SystemConfigPara Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 BC 00 00 00 00 00 00 00 00 0E 8D 6B 
14:06:25.474 > [DPL] targeting -30 W, base load is 150 W, power meter reads 156.0 W (valid)
14:06:25.527 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:25.590 > [DPL] requesting 281 W from 1 solar-powered inverter currently producing 95 W (diff 186 W, hysteresis 10 W)
14:06:25.830 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:25.876 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 186 W AC
14:06:25.922 > [DPL inverter 114190550241]:
14:06:25.968 >     solar-powered, producing 95 W
14:06:26.018 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:26.061 >     sending commands enabled, reachable, eligible
14:06:26.110 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:26.240 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:26.294 >     MPPTs AC power: a: 48 W b: 47 W
14:06:26.337 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:26.390 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 158.00, total: 158.00
14:06:26.564 > RX Period End
14:06:26.615 > All missing
14:06:26.665 > Nothing received, resend whole request
14:06:26.772 > TX SystemConfigPara Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 BC 00 00 00 00 00 00 00 00 0E 8D 6B 
14:06:26.816 > RX Period End
14:06:26.868 > All missing
14:06:27.059 > Nothing received, resend whole request
14:06:27.133 > TX SystemConfigPara Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 BC 00 00 00 00 00 00 00 00 0E 8D 6B 
14:06:27.265 > RX Period End
14:06:27.309 > All missing
14:06:27.367 > Nothing received, resend count exeeded
14:06:27.420 > TX RealTimeRunData Channel: 40 --> 15 90 55 02 41 80 18 83 32 80 0B 00 67 BF 11 C1 00 00 00 00 00 00 00 00 92 BF 14 
14:06:27.483 > Interrupt received
14:06:27.548 > RX Channel: 40 --> 95 90 55 02 41 90 55 02 41 01 00 01 01 D0 00 6D 01 FA 01 CD 00 6C 01 F0 00 08 8B | -80 dBm
14:06:27.604 > Interrupt received
14:06:27.661 > RX Channel: 23 --> 95 90 55 02 41 90 55 02 41 83 00 00 00 2A 03 E8 00 D8 00 11 12 0B 07 | -80 dBm
14:06:27.712 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:27.759 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 144.00, total: 144.00
14:06:27.879 > [DPL] targeting -30 W, base load is 150 W, power meter reads 144.0 W (valid)
14:06:27.924 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:27.970 > [DPL] requesting 269 W from 1 solar-powered inverter currently producing 95 W (diff 174 W, hysteresis 10 W)
14:06:28.017 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:28.062 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 174 W AC
14:06:28.107 > [DPL inverter 114190550241]:
14:06:28.152 >     solar-powered, producing 95 W
14:06:28.200 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:28.245 >     sending commands enabled, reachable, eligible
14:06:28.290 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:28.342 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:28.493 >     MPPTs AC power: a: 48 W b: 47 W
14:06:28.563 > RX Period End
14:06:28.611 > Middle missing
14:06:28.656 > Request retransmit: 2
14:06:28.702 > TX RequestFrame Channel: 61 --> 15 90 55 02 41 80 18 83 32 82 38 
14:06:28.757 > Interrupt received
14:06:28.815 > RX Channel: 40 --> 95 90 55 02 41 90 55 02 41 02 04 52 00 07 B8 FB 01 2F 01 30 08 CD 13 87 03 BA 72 | -80 dBm
14:06:28.872 > RX Period End
14:06:28.922 > Success
14:06:29.074 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:29.137 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 144.00, total: 144.00
14:06:29.312 > [DPL] targeting -30 W, base load is 150 W, power meter reads 144.0 W (valid)
14:06:29.368 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:29.529 > [DPL] requesting 269 W from 1 solar-powered inverter currently producing 95 W (diff 174 W, hysteresis 10 W)
14:06:29.751 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:29.793 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 174 W AC
14:06:29.840 > [DPL inverter 114190550241]:
14:06:29.888 >     solar-powered, producing 95 W
14:06:29.936 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:30.082 >     sending commands enabled, reachable, eligible
14:06:30.139 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:30.336 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:30.383 >     MPPTs AC power: a: 48 W b: 47 W
14:06:30.425 > Fetch inverter: 114184847551
14:06:30.478 > Request SystemConfigPara
14:06:30.541 > Queue size - NRF: 3 CMT: 0
14:06:30.597 > TX RealTimeRunData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 C7 00 00 00 00 00 00 00 00 32 94 3B 
14:06:30.643 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:30.692 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 180.00, total: 180.00
14:06:30.951 > [DPL] targeting -30 W, base load is 150 W, power meter reads 180.0 W (valid)
14:06:30.999 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:31.046 > [DPL] requesting 305 W from 1 solar-powered inverter currently producing 95 W (diff 210 W, hysteresis 10 W)
14:06:31.092 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:31.139 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 210 W AC
14:06:31.186 > [DPL inverter 114190550241]:
14:06:31.234 >     solar-powered, producing 95 W
14:06:31.359 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:31.565 >     sending commands enabled, reachable, eligible
14:06:31.771 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:31.822 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:31.866 >     MPPTs AC power: a: 48 W b: 47 W
14:06:31.914 > RX Period End
14:06:32.079 > All missing
14:06:32.144 > Nothing received, resend whole request
14:06:32.192 > TX RealTimeRunData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 C7 00 00 00 00 00 00 00 00 32 94 3B 
14:06:32.385 > RX Period End
14:06:32.438 > All missing
14:06:32.566 > Nothing received, resend whole request
14:06:32.719 > TX RealTimeRunData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 C7 00 00 00 00 00 00 00 00 32 94 3B 
14:06:32.800 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:32.854 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 151.00, total: 151.00
14:06:32.900 > [DPL] targeting -30 W, base load is 150 W, power meter reads 151.0 W (valid)
14:06:32.955 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:33.079 > [DPL] requesting 276 W from 1 solar-powered inverter currently producing 95 W (diff 181 W, hysteresis 10 W)
14:06:33.143 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:33.203 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 181 W AC
14:06:33.408 > [DPL inverter 114190550241]:
14:06:33.562 >     solar-powered, producing 95 W
14:06:33.613 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:33.659 >     sending commands enabled, reachable, eligible
14:06:33.707 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:33.817 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:33.879 >     MPPTs AC power: a: 48 W b: 47 W
14:06:34.022 > RX Period End
14:06:34.074 > All missing
14:06:34.140 > Nothing received, resend whole request
14:06:34.330 > TX RealTimeRunData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 C7 00 00 00 00 00 00 00 00 32 94 3B 
14:06:34.381 > RX Period End
14:06:34.434 > All missing
14:06:34.563 > Nothing received, resend whole request
14:06:34.614 > TX RealTimeRunData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 0B 00 67 BF 11 C7 00 00 00 00 00 00 00 00 32 94 3B 
14:06:34.665 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:34.843 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 152.00, total: 152.00
14:06:34.893 > [DPL] targeting -30 W, base load is 150 W, power meter reads 152.0 W (valid)
14:06:35.049 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:35.105 > [DPL] requesting 277 W from 1 solar-powered inverter currently producing 95 W (diff 182 W, hysteresis 10 W)
14:06:35.167 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:35.212 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 182 W AC
14:06:35.257 > [DPL inverter 114190550241]:
14:06:35.303 >     solar-powered, producing 95 W
14:06:35.353 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:35.456 >     sending commands enabled, reachable, eligible
14:06:35.506 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:35.566 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:35.621 >     MPPTs AC power: a: 48 W b: 47 W
14:06:35.866 > RX Period End
14:06:36.071 > All missing
14:06:36.136 > Nothing received, resend count exeeded
14:06:36.211 > TX AlarmData Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 C7 00 00 00 00 00 00 00 00 E8 8F E0 
14:06:36.256 > [DPL] the system is stable, the last power limit is still valid
14:06:36.303 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:36.351 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 146.00, total: 146.00
14:06:36.405 > RX Period End
14:06:36.459 > All missing
14:06:36.503 > Nothing received, resend whole request
14:06:36.553 > TX AlarmData Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 C7 00 00 00 00 00 00 00 00 E8 8F E0 
14:06:36.613 > [DPL] targeting -30 W, base load is 150 W, power meter reads 146.0 W (valid)
14:06:36.658 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:36.703 > [DPL] requesting 271 W from 1 solar-powered inverter currently producing 95 W (diff 176 W, hysteresis 10 W)
14:06:36.751 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:36.796 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 176 W AC
14:06:36.843 > [DPL inverter 114190550241]:
14:06:36.890 >     solar-powered, producing 95 W
14:06:36.938 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:36.981 >     sending commands enabled, reachable, eligible
14:06:37.030 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:37.079 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:37.138 >     MPPTs AC power: a: 48 W b: 47 W
14:06:37.207 > RX Period End
14:06:37.260 > All missing
14:06:37.308 > Nothing received, resend whole request
14:06:37.353 > TX AlarmData Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 C7 00 00 00 00 00 00 00 00 E8 8F E0 
14:06:37.408 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:37.567 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 176.00, total: 176.00
14:06:37.617 > [DPL] targeting -30 W, base load is 150 W, power meter reads 176.0 W (valid)
14:06:37.670 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:37.915 > [DPL] requesting 301 W from 1 solar-powered inverter currently producing 95 W (diff 206 W, hysteresis 10 W)
14:06:38.081 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:38.149 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 206 W AC
14:06:38.323 > [DPL inverter 114190550241]:
14:06:38.373 >     solar-powered, producing 95 W
14:06:38.417 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:38.462 >     sending commands enabled, reachable, eligible
14:06:38.509 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:38.555 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:38.600 >     MPPTs AC power: a: 48 W b: 47 W
14:06:38.649 > Fetch inverter: 114190550241
14:06:38.698 > Queue size - NRF: 3 CMT: 0
14:06:38.938 > RX Period End
14:06:38.988 > All missing
14:06:39.035 > Nothing received, resend whole request
14:06:39.082 > TX AlarmData Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 C7 00 00 00 00 00 00 00 00 E8 8F E0 
14:06:39.143 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:39.190 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 161.00, total: 161.00
14:06:39.235 > [DPL] targeting -30 W, base load is 150 W, power meter reads 161.0 W (valid)
14:06:39.290 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:39.352 > [DPL] requesting 286 W from 1 solar-powered inverter currently producing 95 W (diff 191 W, hysteresis 10 W)
14:06:39.404 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:39.452 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 191 W AC
14:06:39.689 > [DPL inverter 114190550241]:
14:06:39.744 >     solar-powered, producing 95 W
14:06:39.789 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:39.842 >     sending commands enabled, reachable, eligible
14:06:39.961 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:40.088 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:40.148 >     MPPTs AC power: a: 48 W b: 47 W
14:06:40.372 > RX Period End
14:06:40.424 > All missing
14:06:40.565 > Nothing received, resend whole request
14:06:40.829 > TX AlarmData Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 11 00 67 BF 11 C7 00 00 00 00 00 00 00 00 E8 8F E0 
14:06:40.894 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:40.945 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 162.00, total: 162.00
14:06:40.990 > [DPL] targeting -30 W, base load is 150 W, power meter reads 162.0 W (valid)
14:06:41.044 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:41.098 > [DPL] requesting 287 W from 1 solar-powered inverter currently producing 95 W (diff 192 W, hysteresis 10 W)
14:06:41.145 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:41.193 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 192 W AC
14:06:41.394 > [DPL inverter 114190550241]:
14:06:41.453 >     solar-powered, producing 95 W
14:06:41.500 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:41.563 >     sending commands enabled, reachable, eligible
14:06:41.619 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:41.667 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:41.710 >     MPPTs AC power: a: 48 W b: 47 W
14:06:41.761 > RX Period End
14:06:42.013 > All missing
14:06:42.089 > Nothing received, resend count exeeded
14:06:42.146 > TX SystemConfigPara Channel: 75 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 C7 00 00 00 00 00 00 00 00 FC 9B F4 
14:06:42.215 > RX Period End
14:06:42.267 > All missing
14:06:42.318 > Nothing received, resend whole request
14:06:42.377 > TX SystemConfigPara Channel: 3 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 C7 00 00 00 00 00 00 00 00 FC 9B F4 
14:06:42.580 > Received MQTT message on topic: vzlogger/data/chn2/raw
14:06:42.829 > [PowerMeterMqtt] Topic 'vzlogger/data/chn2/raw': new value: 249.00, total: 249.00
14:06:42.883 > RX Period End
14:06:42.947 > All missing
14:06:42.993 > Nothing received, resend whole request
14:06:43.038 > TX SystemConfigPara Channel: 23 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 C7 00 00 00 00 00 00 00 00 FC 9B F4 
14:06:43.084 > RX Period End
14:06:43.143 > All missing
14:06:43.192 > Nothing received, resend whole request
14:06:43.443 > TX SystemConfigPara Channel: 40 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 C7 00 00 00 00 00 00 00 00 FC 9B F4 
14:06:43.488 > [DPL] targeting -30 W, base load is 150 W, power meter reads 249.0 W (valid)
14:06:43.536 > [DPL] inverter 114190550241 is behind power meter producing 95 W
14:06:43.581 > [DPL] requesting 374 W from 1 solar-powered inverter currently producing 95 W (diff 279 W, hysteresis 10 W)
14:06:43.634 > [DPL] will cover 95 W using 1 solar-powered inverter
14:06:43.853 > [DPL] battery allowance is 0/0 W DC/AC, solar power is 0/0 W DC/AC, requested are 279 W AC
14:06:43.908 > [DPL inverter 114190550241]:
14:06:44.060 >     solar-powered, producing 95 W
14:06:44.105 >     lower/current/upper limit: 50/110/800 W, output capability: 800 W
14:06:44.153 >     sending commands enabled, reachable, eligible
14:06:44.262 >     max reduction production/standby: 45/45 W, max increase: 0 W
14:06:44.471 >     target limit/output/state: -1 W (unchanged)/95 W/unchanged, 0 update timeouts
14:06:44.521 >     MPPTs AC power: a: 48 W b: 47 W
14:06:44.585 > RX Period End
14:06:44.672 > All missing
14:06:44.716 > Nothing received, resend whole request
14:06:44.783 > TX SystemConfigPara Channel: 61 --> 15 84 84 75 51 80 18 83 32 80 05 00 67 BF 11 C7 00 00 00 00 00 00 00 00 FC 9B F4 
14:06:44.878 > RX Period End
14:06:44.935 > All missing

[spcqike]

Der wechselrichter ist scheinbar nicht erreichbar. Hast du einen täglichen Neustart eingestellt? Kann man das bei smarten Batterien? Wenn ja solltest du das tun.

Mehr lese ich auf die Schnelle nicht raus.

[dk7td]

Ok, danke!
Nachdem ich die OpenDTU neu gestartet hatte, lief alles wieder komplett normal. Seltsam. Wenn der WR nicht erreichbar war, hätte ich doch eher den neustarten müssen?

Welchen Neustart meinst Du? Den vom WR? Das ginge im Zweifel dann doch auch nicht, wenn er nicht erreichbar ist?

[Snusme83]

Schade, dass es wieder auftritt bzw. es schon wieder ein Problem gibt. Hat die oDTUoB wieder "nur" die Grundlast eingespeist, obwohl mehr Bezug ist?

Frage, wie steht es um deine Funkstatistik? Ich bin zwar kein Profi was die Konsolenlogs angeht, aber bei dir sind auch einige "All missing" bzw. "Nothing Received" zu sehen. Deswegen denke ich, dass du auch ne optimierungsbedürftige Kommunikation zwischen oDTUoB und Wechselrichter hast! Wie stehts um die Erfolgreich Empfangenen Daten?

[dk7td]

Er hat lt. Anzeige der OpenDTU gar nichts eingespeist, was allerdings höchstwahrscheinlich der fehlenden Verbindung geschuldet war. Wenn ich den aktuellen Netzbezug angeschaut habe, sah dieser nach einem fixen Einspeisewert aus.

Funkstatistik muß ich mir tatsächlich mal ansehen. Meine OpenDTU hat keine externen Antennen, nur die ins Gehäuse geklebten. Möglicherweise gibt es an dieser Stelle Verbesserungsbedarf.

Was mich eben irritiert, ist die Tatsache, daß ein Neustart der OpenDTU das vermeintliche Verbindungsproblem gelöst hat, ohne daß ich an der Funkstrecke (Position der OpenDTU etc.) irgendetwas verändert habe.

[dk7td]

Moin zusammen!
Hier mal eine Funkstatistik von heute. Sieht eigentlich sehr gut aus, finde ich.