Test Adapter Fronius 2.0.x

diwoma

@nkleber
Hi ich habe jetzt einen Restart provoziert, ohne update davor und habe folgendes Log:

2023-06-07 05:30:24.134 - info: host.ioBroker-dev stopInstance system.adapter.fronius.0 (force=false, process=true)
2023-06-07 05:30:24.137 - info: fronius.0 (26043) Got terminate signal TERMINATE_YOURSELF
2023-06-07 05:30:24.181 - info: host.ioBroker-dev stopInstance system.adapter.fronius.0 send kill signal
2023-06-07 05:30:24.638 - info: fronius.0 (26043) terminating
2023-06-07 05:30:24.639 - info: fronius.0 (26043) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2023-06-07 05:30:24.833 - debug: fronius.0 (26043) GetArchiveData has thrown following error: AxiosError: Request failed with status code 404
2023-06-07 05:30:25.159 - info: host.ioBroker-dev instance system.adapter.fronius.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2023-06-07 05:30:27.198 - info: host.ioBroker-dev instance system.adapter.fronius.0 started with pid 26922
2023-06-07 05:30:27.525 - debug: fronius.0 (26922) Redis Objects: Use Redis connection: 127.0.0.1:9001
2023-06-07 05:30:27.538 - debug: fronius.0 (26922) Objects client ready ... initialize now
2023-06-07 05:30:27.539 - debug: fronius.0 (26922) Objects create System PubSub Client
2023-06-07 05:30:27.539 - debug: fronius.0 (26922) Objects create User PubSub Client
2023-06-07 05:30:27.544 - debug: fronius.0 (26922) Objects client initialize lua scripts
2023-06-07 05:30:27.546 - debug: fronius.0 (26922) Objects connected to redis: 127.0.0.1:9001
2023-06-07 05:30:27.552 - debug: fronius.0 (26922) Redis States: Use Redis connection: 127.0.0.1:9000
2023-06-07 05:30:27.555 - debug: fronius.0 (26922) States create System PubSub Client
2023-06-07 05:30:27.556 - debug: fronius.0 (26922) States create User PubSub Client
2023-06-07 05:30:27.602 - debug: fronius.0 (26922) States connected to redis: 127.0.0.1:9000
2023-06-07 05:30:27.662 - info: fronius.0 (26922) starting. Version 2.0.1 in /opt/iobroker/node_modules/iobroker.fronius, node: v16.19.0, js-controller: 4.0.24
2023-06-07 05:30:28.690 - debug: fronius.0 (26922) requestType https:// is not working! Now trying with http://
2023-06-07 05:30:28.717 - debug: fronius.0 (26922) getLoggerInfo: v1/GetLoggerInfo.cgi request is not supported.
2023-06-07 05:30:28.747 - debug: fronius.0 (26922) GetArchiveData has thrown following error: AxiosError: Request failed with status code 404
2023-06-07 05:30:28.784 - debug: fronius.0 (26922) Object {} does not have a property UAC, therefore no State was created
..........
2023-06-07 05:30:50.167 - debug: fronius.0 (26922) Property YEAR_ENERGY is null. No object created!
2023-06-07 05:30:58.704 - debug: fronius.0 (26922) Object creation will be done for 0 times
2023-06-07 05:30:58.895 - error: fronius.0 (26922) uncaught exception: Cannot convert undefined or null to object
2023-06-07 05:30:58.896 - error: fronius.0 (26922) TypeError: Cannot convert undefined or null to object
at hasOwnProperty ()
at fillDataObject (/opt/iobroker/node_modules/iobroker.fronius/main.js:1145:41)
at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.fronius/main.js:1195:13)
at listOnTimeout (node:internal/timers:561:11)
at processTimers (node:internal/timers:502:7)
2023-06-07 05:30:58.896 - error: fronius.0 (26922) Cannot convert undefined or null to object
2023-06-07 05:30:58.896 - error: fronius.0 (26922) uncaught exception: Cannot convert undefined or null to object
2023-06-07 05:30:58.896 - error: fronius.0 (26922) TypeError: Cannot convert undefined or null to object
at hasOwnProperty ()
at fillDataObject (/opt/iobroker/node_modules/iobroker.fronius/main.js:1145:41)
at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.fronius/main.js:1195:13)
at listOnTimeout (node:internal/timers:561:11)
at processTimers (node:internal/timers:502:7)
2023-06-07 05:30:58.896 - error: fronius.0 (26922) Cannot convert undefined or null to object
2023-06-07 05:30:59.403 - info: fronius.0 (26922) terminating
2023-06-07 05:30:59.404 - warn: fronius.0 (26922) Terminated (UNCAUGHT_EXCEPTION): Without reason
2023-06-07 05:30:59.918 - error: host.ioBroker-dev instance system.adapter.fronius.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2023-06-07 05:30:59.918 - info: host.ioBroker-dev Restart adapter system.adapter.fronius.0 because enabled
2023-06-07 05:31:29.934 - info: host.ioBroker-dev instance system.adapter.fronius.0 started with pid 26937
2023-06-07 05:31:30.234 - debug: fronius.0 (26937) Redis Objects: Use Redis connection: 127.0.0.1:9001
2023-06-07 05:31:30.248 - debug: fronius.0 (26937) Objects client ready ... initialize now
2023-06-07 05:31:30.249 - debug: fronius.0 (26937) Objects create System PubSub Client
2023-06-07 05:31:30.249 - debug: fronius.0 (26937) Objects create User PubSub Client
2023-06-07 05:31:30.254 - debug: fronius.0 (26937) Objects client initialize lua scripts
2023-06-07 05:31:30.256 - debug: fronius.0 (26937) Objects connected to redis: 127.0.0.1:9001
2023-06-07 05:31:30.262 - debug: fronius.0 (26937) Redis States: Use Redis connection: 127.0.0.1:9000
2023-06-07 05:31:30.264 - debug: fronius.0 (26937) States create System PubSub Client
2023-06-07 05:31:30.265 - debug: fronius.0 (26937) States create User PubSub Client
2023-06-07 05:31:30.314 - debug: fronius.0 (26937) States connected to redis: 127.0.0.1:9000
2023-06-07 05:31:30.366 - info: fronius.0 (26937) starting. Version 2.0.1 in /opt/iobroker/node_modules/iobroker.fronius, node: v16.19.0, js-controller: 4.0.24
2023-06-07 05:31:31.391 - debug: fronius.0 (26937) requestType https:// is not working! Now trying with http://
2023-06-07 05:31:31.411 - debug: fronius.0 (26937) getLoggerInfo: v1/GetLoggerInfo.cgi request is not supported.
2023-06-07 05:31:31.422 - debug: fronius.0 (26937) GetArchiveData has thrown following error: AxiosError: Request failed with status code 404
2023-06-07 05:31:31.429 - debug: fronius.0 (26937) Object {} does not have a property Enable, therefore no State was created
2023-06-07 05:31:31.484 - debug: fronius.0 (26937) Property P_Akku is null. No object created!
2023-06-07 05:31:31.484 - debug: fronius.0 (26937) Property E_Day is null. No object created!
2023-06-07 05:31:31.484 - debug: fronius.0 (26937) Property E_Year is null. No object created!
2023-06-07 05:31:31.484 - debug: fronius.0 (26937) Property rel_SelfConsumption is null. No object created!
...
{"ErrorCode":1240,"InverterState":"Sleeping","StatusCode":13},"IAC":{"Unit":"A","Value":0},"IDC":{"Unit":"A","Value":0},"IDC_2":{"Unit":"A","Value":0},"IDC_3":{"Unit":"A","Value":null},"IDC_4":{"Unit":"A","Value":null},"PAC":{"Unit":"W","Value":0},"SAC":{"Unit":"VA","Value":0},"TOTAL_ENERGY":{"Unit":"Wh","Value":6044085.741666666},"UAC":{"Unit":"V","Value":0.027594637125730515},"UDC":{"Unit":"V","Value":146.51486206054688},"UDC_2":{"Unit":"V","Value":152.09059143066406},"UDC_3":{"Unit":"V","Value":null},"UDC_4":{"Unit":"V","Value":null},"YEAR_ENERGY":{"Unit":"Wh","Value":null}} does not have a property IAC_L1, therefore no State was created
........
2023-06-07 05:31:31.858 - debug: fronius.0 (26937) Object {} does not have a property T_AMBIENT, therefore no State was created
2023-06-07 05:31:32.432 - error: fronius.0 (26937) uncaught exception: Cannot convert undefined or null to object
2023-06-07 05:31:32.432 - error: fronius.0 (26937) TypeError: Cannot convert undefined or null to object
at hasOwnProperty ()
at createStates (/opt/iobroker/node_modules/iobroker.fronius/lib/devObjects.js:474:41)
at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.fronius/lib/devObjects.js:127:17)
at listOnTimeout (node:internal/timers:561:11)
at processTimers (node:internal/timers:502:7)
2023-06-07 05:31:32.432 - error: fronius.0 (26937) Cannot convert undefined or null to object
2023-06-07 05:31:32.484 - debug: fronius.0 (26937) API Objekt E_Day is null, no object created!
2023-06-07 05:31:32.485 - debug: fronius.0 (26937) API Objekt E_Year is null, no object created!
2023-06-07 05:31:32.485 - debug: fronius.0 (26937) API Objekt P_Akku is null, no object created!
2023-06-07 05:31:32.485 - debug: fronius.0 (26937) API Objekt rel_SelfConsumption is null, no object created!
2023-06-07 05:31:32.485 - debug: fronius.0 (26937) API Objekt E_Day is null, no object created!
2023-06-07 05:31:32.485 - debug: fronius.0 (26937) API Objekt E_Year is null, no object created!
2023-06-07 05:31:32.746 - debug: fronius.0 (26937) Property UAC_L1 is null. No object created!
2023-06-07 05:31:32.746 - debug: fronius.0 (26937) Property UAC_L2 is null. No object created!
2023-06-07 05:31:32.746 - debug: fronius.0 (26937) Property UAC_L3 is null. No object created!
2023-06-07 05:31:32.822 - debug: fronius.0 (26937) Property DAY_ENERGY is null. No object created!
2023-06-07 05:31:32.823 - debug: fronius.0 (26937) Property IDC_3 is null. No object created!
2023-06-07 05:31:32.823 - debug: fronius.0 (26937) Property IDC_4 is null. No object created!
2023-06-07 05:31:32.823 - debug: fronius.0 (26937) Property UDC_3 is null. No object created!
2023-06-07 05:31:32.823 - debug: fronius.0 (26937) Property UDC_4 is null. No object created!
2023-06-07 05:31:32.823 - debug: fronius.0 (26937) Property YEAR_ENERGY is null. No object created!
2023-06-07 05:31:32.933 - info: fronius.0 (26937) terminating
2023-06-07 05:31:32.934 - warn: fronius.0 (26937) Terminated (UNCAUGHT_EXCEPTION): Without reason
2023-06-07 05:31:33.447 - error: host.ioBroker-dev instance system.adapter.fronius.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2023-06-07 05:31:33.447 - info: host.ioBroker-dev Restart adapter system.adapter.fronius.0 because enabled
2023-06-07 05:32:03.464 - info: host.ioBroker-dev instance system.adapter.fronius.0 started with pid 26952
2023-06-07 05:32:03.766 - debug: fronius.0 (26952) Redis Objects: Use Redis connection: 127.0.0.1:9001
2023-06-07 05:32:03.780 - debug: fronius.0 (26952) Objects client ready ... initialize now
2023-06-07 05:32:03.781 - debug: fronius.0 (26952) Objects create System PubSub Client
2023-06-07 05:32:03.781 - debug: fronius.0 (26952) Objects create User PubSub Client
2023-06-07 05:32:03.786 - debug: fronius.0 (26952) Objects client initialize lua scripts
2023-06-07 05:32:03.788 - debug: fronius.0 (26952) Objects connected to redis: 127.0.0.1:9001
2023-06-07 05:32:03.794 - debug: fronius.0 (26952) Redis States: Use Redis connection: 127.0.0.1:9000
2023-06-07 05:32:03.796 - debug: fronius.0 (26952) States create System PubSub Client
2023-06-07 05:32:03.796 - debug: fronius.0 (26952) States create User PubSub Client
2023-06-07 05:32:03.841 - debug: fronius.0 (26952) States connected to redis: 127.0.0.1:9000
2023-06-07 05:32:03.892 - info: fronius.0 (26952) starting. Version 2.0.1 in /opt/iobroker/node_modules/iobroker.fronius, node: v16.19.0, js-controller: 4.0.24
2023-06-07 05:32:04.918 - debug: fronius.0 (26952) requestType https:// is not working! Now trying with http://
2023-06-07 05:32:05.920 - error: fronius.0 (26952) IP is not a Fronius inverter
2023-06-07 05:32:16.198 - debug: fronius.0 (26952) checkArchiveStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:16.198 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:16.199 - debug: fronius.0 (26952) getLoggerInfo has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:16.199 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:28.997 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:38.981 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:48.997 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:32:58.981 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:33:08.996 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect EHOSTUNREACH 192.168.1.102:80
2023-06-07 05:33:15.932 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect ECONNREFUSED 192.168.1.102:80
2023-06-07 05:33:25.933 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect ECONNREFUSED 192.168.1.102:80
2023-06-07 05:33:35.934 - debug: fronius.0 (26952) checkStatus has thrown following error: Error: connect ECONNREFUSED 192.168.1.102:80

2023-06-07 05:33:51.993 - debug: fronius.0 (26952) Object {"IAC_L1":{"Unit":"A","Value":0},"IAC_L2":{"Unit":"A","Value":0},"IAC_L3":{"Unit":"A","Value":0},"UAC_L1":{"Unit":"V","Value":null},"UAC_L2":{"Unit":"V","Value":null},"UAC_L3":{"Unit":"V","Value":null}} does not have a property UAC, therefore no State was created
...
2023-06-07 05:33:53.069 - debug: fronius.0 (26952) Property YEAR_ENERGY is null. No object created!
2023-06-07 05:33:53.129 - error: fronius.0 (26952) uncaught exception: Cannot convert undefined or null to object
2023-06-07 05:33:53.129 - error: fronius.0 (26952) TypeError: Cannot convert undefined or null to object
at hasOwnProperty ()
at createStates (/opt/iobroker/node_modules/iobroker.fronius/lib/devObjects.js:474:41)
at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.fronius/lib/devObjects.js:127:17)
at listOnTimeout (node:internal/timers:561:11)
at processTimers (node:internal/timers:502:7)
2023-06-07 05:33:53.129 - error: fronius.0 (26952) Cannot convert undefined or null to object
2023-06-07 05:33:53.208 - debug: fronius.0 (26952) API Objekt E_Day is null, no object created!
2023-06-07 05:33:53.208 - debug: fronius.0 (26952) API Objekt E_Year is null, no object created!
2023-06-07 05:33:53.209 - debug: fronius.0 (26952) API Objekt P_Akku is null, no object created!
2023-06-07 05:33:53.209 - debug: fronius.0 (26952) API Objekt rel_SelfConsumption is null, no object created!
2023-06-07 05:33:53.209 - debug: fronius.0 (26952) API Objekt E_Day is null, no object created!
2023-06-07 05:33:53.209 - debug: fronius.0 (26952) API Objekt E_Year is null, no object created!
2023-06-07 05:33:53.630 - info: fronius.0 (26952) terminating
2023-06-07 05:33:53.630 - warn: fronius.0 (26952) Terminated (UNCAUGHT_EXCEPTION): Without reason
2023-06-07 05:33:54.146 - error: host.ioBroker-dev instance system.adapter.fronius.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2023-06-07 05:33:54.146 - info: host.ioBroker-dev Restart adapter system.adapter.fronius.0 because enabled
2023-06-07 05:33:54.146 - warn: host.ioBroker-dev Do not restart adapter system.adapter.fronius.0 because restart loop detected

Zur Erklärung:
Für ein sauberes Protokoll habe ich zuerst das Log gelöscht und einen Restart des Adapters durchgeführt.
Dann die Anlage runter gefahren und wieder gestartet.
Am Ende ist der Adapter rot:

diwoma

@diwoma @nkleber
Dazu noch etwas zum Verhalten des Restart-Prozesses:
Das IP-Interface ist relativ schnell da, aber der Inverter selbst ist längere Zeit (mind. 30 sek) im Zustand angehalten.
Das könnte dazu führen, dass einige der Abfragen beantwortet werden, aber die Abfragen die den Inverter selbst betrifft, eventuell nicht korrekt zurückkommen. was dann zur

uncaught exception: Cannot convert undefined or null to object

führen könnte. Vielleicht könntest Du im Debug noch die Abfrage mitloggen, damit man erkennen kann, welche Abfrage es ist.

mcm1957

@diwoma
Danke für die ausgezeichnete Dokumentation des Problems.
Ich hab ein issue erstellt (https://github.com/iobroker-community-adapters/ioBroker.fronius/issues/313) und auf die Info hier verwiesen.

c1olli

Anbei die Gegenüberstellung der beiden Adapter in ioBroker.
Darstellung mit einem Inverter und einem String.
Beim 1.xx Adapter fällt auf, dass viele Punkte doppelt sind. Daher fällt der 2.xx etwas schlanker aus.
Fronius.xlsx

nkleber

@c1olli Kann es sein dass du bei der V1.xx schon die Version 1.1.6 oder gar die 1.2.0 drauf hattest? Die offizielle Version ohne Github war die 1.1.3 und da müsste die Struktur eigentlich noch etwas anders aussehen...

c1olli

@nkleber
ich schau nochmal nach - vielleicht hab ich da was verbogen.
Edit:
Jepp da hatte ich wohl was ausprobiert.
Jetzt sollte es aber stimmen
Fronius.xlsx

Im oberen Beitrag habe ich auch die aktuelle Tabelle angehängt

diwoma

@c1olli
ich glaube, da ist noch ein Fehler: die "site" hat es in 1.x nicht gegeben, die gehört zu 2.x

Homoran

@diwoma ist es möglich/sinnvoll den code zu kürzen?
ich fürchte der lähmt den Aufruf des Threads

mcm1957

@homoran
Welchen Code?

Homoran

@mcm57 das was hier alles blockiert und in dem beantworteten Post in code-tags steht.

Negalein

@homoran sagte in Test Adapter Fronius 2.0.x:

ich fürchte der lähmt den Aufruf des Threads

bei mir blockiert nichts

Homoran

@negalein sagte in Test Adapter Fronius 2.0.x:

bei mir blockiert nichts

das klingt schon wieder nicht nach mobiler Ansicht

diwoma

@homoran @mcm57 @nkleber
Ich habe das Log gekürzt und die nicht relevanten Messages, die nur melden, dass ein DP nicht erzeugt wurde, weil er null war, rausgelöscht.

Nur mehr die meiner Meinung nach relevanten Daten zum Problem plus ein paar weitere Meldungen davor und danach habe ich gelassen, damit man sich auch das Timing beim Auftreten ansehen kann.

Homoran

@diwoma Danke!
komme wieder auf die Seite

c1olli

@diwoma
Jo hast recht - hatte ich wohl vergessen zu löschen - hab die aktuelle Version oben geändert

mcm1957

@homoran
Ich hatte auch vor der Kürzung keinerlei Probleme beim Zugriff.
Sorry - aber da scheint das Forum wohl auch zu klemmen ...

Homoran

@mcm57 sagte in Test Adapter Fronius 2.0.x:

@homoran
Ich hatte auch vor der Kürzung keinerlei Probleme beim Zugriff.
Sorry - aber da scheint das Forum wohl auch zu klemmen ...

ist aber schon länger dass grosse codeblöcke den Zugriff blockieren bzw. seeeeehr lange Ladezeiten verursachen.
Kann natürlich sein, dass es bei mir am Tablet schlimmer als am PC ist

mcm1957

@homoran
OK, das scheint dann wirklich ein Performanceproblem am Tablet zu sein.
Ich hab am PC (Laptop, Win 11, Chrome) null Verzögerungen bemerkt.

Wieder was gelernt.

Homoran

@mcm57 sagte in Test Adapter Fronius 2.0.x:

Performanceproblem am Tablet zu sein.

naja am PC wirst du icht nur 3GB RAM haben :joy:

mcm1957

@homoran
Jep - Laptop hat 16GB
Hab aber irgendwo noch ne ISA Steckkarte mit 512kB (oder nur 256kB?) RAM drauf - einzeln gesockelte Chips. Schätz nur die geht nicht ins dein Pad rein um es ein wenig aufzurüsten :-)

Community Forum

NEWS

Test Adapter Fronius 2.0.x

Support us

491

32.4k

81.4k

1.3m