76_SMAInverter.pm - Abfrage von SMA Wechselrichter

[knxler]

Hallo Heiko
ich habe den Eindruck das der Sunny Tripower 6.0 nicht zum Antworten kommt.
Er ist direkt mit Kabel in mein Netzwerk angebunden.
Zu deiner Frage, ja ich habe das Passwort geändert. Dies ist aber erst passiert als ich das Problem bemerkt habe. Für mich sieht es so aus wie der Beitrag 796 vom 2. April 2020.
Das komische ist, dass dieses Modul auf Anhieb funktioniert hat.

Hier mein List

Internals:
   DEF        XXXXXXX 192.168.0.XXX
   FUUID      5f03641e-f33f-5ea6-ed64-f026b4017432d198
   FVERSION   76_SMAInverter.pm:v2.14.0-s20399/2019-10-23
   HOST       192.168.0.XXX
   INTERVAL   120
   LASTUPDATE 0
   NAME       photovoltaik
   NR         690
   PASS       XXXXXXX
   STATE      Timeout: process terminated
   TYPE       SMAInverter
   HELPER:
     DEFAULT_TARGET_SERIAL 4294967295
     DEFAULT_TARGET_SUSYID 65535
     FAULTEDCYCLES 3
     INTERVAL   120
     MAXBYTES   300
     MYSERIALNUMBER 123321123
     MYSUSYID   233
     PACKAGE    main
     PKT_ID     32769
     VERSION    2.14.0
     RUNNING_PID:
       abortFn    SMAInverter_getstatusParseAborted
       arg        photovoltaik
       bc_pid     30
       finishFn   SMAInverter_getstatusParseDone
       fn         SMAInverter_getstatusDoParse
       loglevel   4
       pid        17458
       telnet     telnetForBlockingFn_1594058343.06516_127.0.0.1_44418
       timeout    60
       abortArg:
   READINGS:
     2020-07-06 16:14:51   modulstate      login failed
     2020-07-06 20:02:17   state           Timeout: process terminated
Attributes:
   detail-level 2
   interval   120
   mode       automatic
   offset     300
   room       Photovoltaik
   suppressSleep 0
   target-serial 3006723411
   target-susyid 374
   timeout    60
   verbose    5

und hier mein Log Eintrag:

2020.07.06 20:29:17.324 4: photovoltaik - ###############################################################
2020.07.06 20:29:17.325 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.06 20:29:17.325 4: photovoltaik - ###############################################################
2020.07.06 20:29:17.326 4: photovoltaik - timeout cycles since module start: 16
2020.07.06 20:29:17.366 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusDoParse
2020.07.06 20:29:17.824 4: photovoltaik - current time: 06.07.2020 20:29:17
2020.07.06 20:29:17.825 4: photovoltaik - operation time begin: 06.07.2020 04:31:56
2020.07.06 20:29:17.825 4: photovoltaik - operation time end: 06.07.2020 22:39:00
2020.07.06 20:29:17.828 4: photovoltaik - Send login to 192.168.0.XXX on Port 9522 with password XXXXXX
2020.07.06 20:29:17.829 5: photovoltaik - Send: 534D4100000402A000000001003A001060650EA0760153F536B30001E90023BB590700010000000001800C04FDFF07000000840300007D6D035F00000000DBF7F1FBFBEDFBB9B9A9888800000000
2020.07.06 20:30:17.341 1: SMAInverter photovoltaik -> BlockingCall SMAInverter_getstatusDoParse Timeout: process terminated
2020.07.06 20:31:17.330 4: photovoltaik - ###############################################################
2020.07.06 20:31:17.331 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.06 20:31:17.332 4: photovoltaik - ###############################################################
2020.07.06 20:31:17.332 4: photovoltaik - timeout cycles since module start: 17
2020.07.06 20:31:17.373 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusDoParse
2020.07.06 20:31:17.832 4: photovoltaik - current time: 06.07.2020 20:31:17
2020.07.06 20:31:17.832 4: photovoltaik - operation time begin: 06.07.2020 04:31:56
2020.07.06 20:31:17.833 4: photovoltaik - operation time end: 06.07.2020 22:39:00
2020.07.06 20:31:17.836 4: photovoltaik - Send login to 192.168.0.XXX on Port 9522 with password XXXXX
2020.07.06 20:31:17.837 5: photovoltaik - Send: 534D4100000402A000000001003A001060650EA0760153F536B30001E90023BB590700010000000001800C04FDFF0700000084030000F56D035F00000000DBF7F1FBFBEDFBB9B9A9888800000000
2020.07.06 20:32:17.349 1: SMAInverter photovoltaik -> BlockingCall SMAInverter_getstatusDoParse Timeout: process terminated

Heute beim rumprobieren gab es einmal folgenden Log:

2020.07.06 16:14:51.147 4: photovoltaik - ###############################################################
2020.07.06 16:14:51.148 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.06 16:14:51.149 4: photovoltaik - ###############################################################
2020.07.06 16:14:51.149 4: photovoltaik - timeout cycles since module start: 67
2020.07.06 16:14:51.190 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusDoParse
2020.07.06 16:14:51.652 4: photovoltaik - current time: 06.07.2020 16:14:51
2020.07.06 16:14:51.652 4: photovoltaik - operation time begin: 06.07.2020 04:31:56
2020.07.06 16:14:51.653 4: photovoltaik - operation time end: 06.07.2020 22:39:00
2020.07.06 16:14:51.656 4: photovoltaik - Send login to 192.168.0.XXX on Port 9522 with password XXXXXX
2020.07.06 16:14:51.657 5: photovoltaik - Send: 534D4100000402A000000001003A001060650EA0FFFF53F536B30001E90023BB590700010000000001800C04FDFF0700000084030000DB31035F00000000DBF7F1FBFBEDFBB9B9A9888800000000
2020.07.06 16:14:51.657 5: photovoltaik - Received:
2020.07.06 16:14:51.657 1: photovoltaik - Format of inverter response does not fit.
2020.07.06 16:14:51.659 4: photovoltaik - Send logout to 192.168.0.XXX on Port 9522
2020.07.06 16:14:51.659 5: photovoltaik - Send: 534D4100000402A00000000100220010606508A0FFFF53F536B30003E90023BB590700030000000002800E01FDFFFFFFFFFF00000000
2020.07.06 16:14:51.660 4: photovoltaik - logged out now from inverter serial: 3006723411, susyid: any susyid
2020.07.06 16:14:51.660 5: photovoltaik -> row_array before encoding:
2020.07.06 16:14:51.660 5: photovoltaik -> state Login failed
2020.07.06 16:14:51.661 5: photovoltaik -> modulstate login failed
2020.07.06 16:14:51.661 4: photovoltaik -> BlockingCall SMAInverter_getstatusDoParse finished
2020.07.06 16:14:51.671 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusParseDone
2020.07.06 16:14:51.672 5: photovoltaik -> row_array after decoding:
2020.07.06 16:14:51.672 5: photovoltaik -> state Login failed
2020.07.06 16:14:51.672 5: photovoltaik -> modulstate login failed
2020.07.06 16:14:51.706 4: photovoltaik -> BlockingCall SMAInverter_getstatusParseDone finished
2020.07.06 16:15:28.719 4: photovoltaik - ###############################################################
2020.07.06 16:15:28.721 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.06 16:15:28.721 4: photovoltaik - ###############################################################

Gruß Martin

[DS_Starter]

Ja, der WR kommt nicht zum Antworten, oder fühlt sich nicht angesprochen !
Du kannst mal den timeout Wert hochdrehen (10 Minuten) und den mode auf manuell stellen.

Dann get data ausführen und warten ob sich überhaupt noch etwas tut.
Frage ist natürlich was plötzlich dieses Verhalten ausgelöst hat. Vielleicht das Analgenpasswort im SMA Portal gesetzt/geändert ?

[knxler]

Hallo Heiko,
beim SMA-Portal bin ich gar nicht angemeldet.
Die Anlage antwortet nicht auch bei einem Timeout von 600 und einem get data.
Ich kann mich aber über den Sunny Explorer und über einen Browser mit der Anlage konnektieren. Ich habe für Benutzer und Installateur ein identisches Passwort gewählt. Es sind Buchstaben Zahlen und Sonderzeichen. Den Beitrag 810, nur Zahlen als Passwort kann ich nicht glauben.
Gibt es auf der Linuxseite in einer Shell eine Möglichkeit einen Test zu machen?
Ping funktioniert.
Gruß Martin

[DS_Starter]

Welche Sonderzeichen kommen denn im PW vor ?

[knxler]

Hallo, ein !

[DS_Starter]

das ist ok, habe ich auch bei mir.
Überlege doch mal was du evtl. noch geändert haben könntest.
Firewall ? Ping verwendet einen anderen Port !

[300P]

Hallo Heiko,
beim SMA-Portal bin ich gar nicht angemeldet.
Die Anlage antwortet nicht auch bei einem Timeout von 600 und einem get data.
Ich kann mich aber über den Sunny Explorer und über einen Browser mit der Anlage konnektieren. Ich habe für Benutzer und Installateur ein identisches Passwort gewählt. Es sind Buchstaben Zahlen und Sonderzeichen. Den Beitrag 810, nur Zahlen als Passwort kann ich nicht glauben.
Gibt es auf der Linuxseite in einer Shell eine Möglichkeit einen Test zu machen?
Ping funktioniert.
Gruß Martin

Hallo Martin,

nur Zahlen geht auch auf dem SMA-Portal.

Schau bitte noch einmal genau nach den Einträgen (Webbrowser) im WR bei den Gerätekomponenten nach den SUSyID.
Dort stehen bei meinen WR 2 bzw. bei SBS25 3 mal eine SUSyID

Von dort nicht die SYSyID des Hauptprozessors nehmen, bei mir es ist die SUSYID der Kommunikationsbaugruppe die Richtige !!!
Als Seriennummer die des Hauptprozessors nehmen !

Damit musst du dann eigentlich "reinkommen".

Ansonsten läßt Dich evtl. an irgendeiner stelle dein Netzwerk nicht "durch".
Versuch es auch mal so nah wie möglich am Netzwerkkabel des WR. (naheliegender Switch / HUB)
Sobald mehrere verschiedene Netzwerkgeräte einwirken kommt evtl., wie von Heiko beschrieben, dein Port evtl. nicht sauber durch (wird im Gerät geblockt oder nicht weitergereicht).
Das habe ich an einigen Stellen in meinem Kabelsalat auch bei dem EM, sobald von Kabel, über W-LAN, über HUB, über Switch, und dann noch per Powerline was läuft.

Gruß
300P

[knxler]

Hallo 300P, der WR und der PI hängen per Kabel am selben Switch.
Hallo Heiko, eine Firewall habe ich nicht in meinem internen Netz.
Was ist denn der Unterschied im Zugriff über SunnyExplorer, oder Webbrowser und über FEHM?
Kann eventuell der Port falsch sein?
Gruß Martin

[knxler]

Was mir noch einfällt, ich habe mal die nicht benötigten Pakete deinstalliert.
Welche Pakete werde denn benötigt?
Die in der Commandref erwähnten Pakete habe ich installiert.
Gruß Martin

[DS_Starter]

Was ist denn der Unterschied im Zugriff über SunnyExplorer, oder Webbrowser und über FEHM?

Generell wird der Port: 9522/UDP benutzt, der Sunny Explorer findet die Anlage m.W. über Speedwire Device Discovery auf Multicast Adresse, das Modul verwendet fest die angegebene IP-Adresse.

Der Port 9522 ist bei der IANA (Internet Assigned Numbers Authority) für SMA Speedwire Kommunikation eingetragen, also fix.

Die in der Commandref erwähnten Pakete habe ich installiert.

Dann passt das. Außerdem würdest du bei fehlen eines Perl Paketes richtige Fehler bekommen bis hin zum FHEM Abstrurz.

Stimmt denn die IP noch ? Hast du eine feste IP vergeb und kein DHCP ?

[knxler]

Ja, die IP stimmt. Ich konnekte mich ja über den Browser mit dieser IP an den den Sunny Tripower.

[DS_Starter]

Lösche dir mal die Attribute  target-serial und  target-susyid und poste erneut ein verbose 5 log der Ausgabe.

[knxler]

Hallo,
auf die Idee war ich auch schon gekommen beides heruszulöschen.
Ich habe auf meinem PI einen Packetsniffer installiert. Hierbei habe ich festgestellt, wenn ich GetData betätige keine Pakete ins Netz abgesetzt werden. Das Modul scheint nichts zu machen in Richtung Netzwerk.

Hier der Log

2020.07.08 11:09:27.242 3: SMAInverter photovoltaik - WARNING - old process 23376 will be killed now to start a new BlockingCall
2020.07.08 11:09:27.244 1: SMAInverter photovoltaik -> BlockingCall SMAInverter_getstatusDoParse Timeout: process terminated
2020.07.08 11:09:27.278 4: photovoltaik - ###############################################################
2020.07.08 11:09:27.278 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.08 11:09:27.279 4: photovoltaik - ###############################################################
2020.07.08 11:09:27.279 4: photovoltaik - timeout cycles since module start: 4
2020.07.08 11:09:27.319 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusDoParse
2020.07.08 11:09:27.775 4: photovoltaik - current time: 08.07.2020 11:09:27
2020.07.08 11:09:27.775 4: photovoltaik - operation time begin: 08.07.2020 04:34:12
2020.07.08 11:09:27.776 4: photovoltaik - operation time end: 08.07.2020 22:37:17
2020.07.08 11:09:27.779 4: photovoltaik - Send login to 192.168.0.XXX on Port 9522 with password XXXXX
2020.07.08 11:09:27.779 5: photovoltaik - Send: 534D4100000402A000000001003A001060650EA0FFFFFFFFFFFF0001E90023BB590700010000000001800C04FDFF0700000084030000478D055F00000000DBF7F1FBFBEDFBB9B9A9888800000000
2020.07.08 11:12:00.315 3: SMAInverter photovoltaik - WARNING - old process 23377 will be killed now to start a new BlockingCall
2020.07.08 11:12:00.317 1: SMAInverter photovoltaik -> BlockingCall SMAInverter_getstatusDoParse Timeout: process terminated
2020.07.08 11:12:00.352 4: photovoltaik - ###############################################################
2020.07.08 11:12:00.352 4: photovoltaik - ##########  Begin of new SMAInverter get data cycle  ##########
2020.07.08 11:12:00.352 4: photovoltaik - ###############################################################
2020.07.08 11:12:00.353 4: photovoltaik - timeout cycles since module start: 5
2020.07.08 11:12:00.393 4: photovoltaik -> Start BlockingCall SMAInverter_getstatusDoParse
2020.07.08 11:12:00.854 4: photovoltaik - current time: 08.07.2020 11:12:00
2020.07.08 11:12:00.854 4: photovoltaik - operation time begin: 08.07.2020 04:34:12
2020.07.08 11:12:00.855 4: photovoltaik - operation time end: 08.07.2020 22:37:17
2020.07.08 11:12:00.858 4: photovoltaik - Send login to 192.168.0.XXX on Port 9522 with password XXXXX
2020.07.08 11:12:00.859 5: photovoltaik - Send: 534D4100000402A000000001003A001060650EA0FFFFFFFFFFFF0001E90023BB590700010000000001800C04FDFF0700000084030000E08D055F00000000DBF7F1FBFBEDFBB9B9A9888800000000

Gruß Martin

[knxler]

Hallo noch einmal,
ich habe mal eine falsche IP eingegeben. Es kommt keine Fehlermeldung.
Ist das ok?

[DS_Starter]

ich habe mal eine falsche IP eingegeben. Es kommt keine Fehlermeldung.
Ist das ok?

Ja, es ist ein einfacher UDP- Call in die Welt. Der WR sollte sich dann angesprochen fühlen und antworten.