search

iobroker-community-adapters / ioBroker.shelly

Integrate your Shelly devices into ioBroker via MQTT or CoIoT
Other
168 stars 68 forks source link

(undefined / undefined / undefined) is offline #695

Closed JB1985 closed 2 years ago

JB1985 commented 2 years ago

Shelly device

Shelly2.5

Protocol (CoAP / MQTT)

CoAP

The problem

[http controlFunction] Unable to perform request - device 192.168.2.115 (undefined / undefined / undefined) is offline -- Mit der Version 6.2.2 werden Befehle nicht ausgeführt. Mit 6.2.1 funktioniert es. Fehlermeldung siehe oben.

Version of nodejs

16.17.1

Version of ioBroker js-controller

4.0.23

Version of Adapter

6.2.2

Operating system running ioBroker

debian bullseye

Checklist of files to include below

Additional information & file uploads

No response

klein0r commented 2 years ago

Das Problem kann nicht mit dem Upgrade von 6.2.1 auf 6.2.2 zusammenhängen. Da wurde nur eine Zeile geändert. Dein Gerät wird irgendwie nicht erkannt und deswegen wird "undefined" geliefert.

Bitte ein komplettes Debug-Log liefern (hast Du ja auch angehakt, dass Du das machst)

JB1985 commented 2 years ago

Ich hatte von einer älteren Version upgegraded. Ich weiß nicht mehr, welche es war.

Ich bin jetzt wieder auf 6.2.2 und werde es beobachten,

Die Fehlermeldung war ja nicht nur bei einer Shelly, sondern bei so ca. 60% aller Shellys. Als ich dann ein downgrade machte, funktionierte es wieder.

klein0r commented 2 years ago

Wenn kein Debug-Log kommt, dann mache ich hier zu

JB1985 commented 2 years ago

So, ich habe neue Logs:

[http controlFunction] Error in function state.coap.http_cmd of state SHSW-25#CXXXXX#1.Shutter.state for 192.168.2.150 (shellyswitch25 / shellyswitch25-CXXXX / SHSW-25#CXXXXXX): AxiosError: Request failed with status code 400

[http controlFunction] Unable to perform request - device 192.168.2.150 (undefined / undefined / undefined) is offline

# ping 192.168.2.150
PING 192.168.2.150 (192.168.2.150) 56(84) bytes of data.
64 bytes from 192.168.2.150: icmp_seq=1 ttl=127 time=111 ms
64 bytes from 192.168.2.150: icmp_seq=2 ttl=127 time=23.5 ms
64 bytes from 192.168.2.150: icmp_seq=3 ttl=127 time=4.92 ms
64 bytes from 192.168.2.150: icmp_seq=4 ttl=127 time=10.0 ms
64 bytes from 192.168.2.150: icmp_seq=5 ttl=127 time=208 ms
64 bytes from 192.168.2.150: icmp_seq=6 ttl=127 time=113 ms
^C
--- 192.168.2.150 ping statistics ---
6 packets transmitted, 6 received, 0% packet loss, time 5009ms
rtt min/avg/max/mdev = 4.917/78.435/207.926/73.191 ms

Bei einigen funktioniert es und bei einigen nicht.

klein0r commented 2 years ago

Wie soll mir die eine Log-Zeile bei dem undefined Thema helfen? Bitte das komplette Log hochladen

JB1985 commented 2 years ago

log.txt

iobroker.2022-10-20.log

klein0r commented 2 years ago

iobroker.2022-10-20.log ist mit Version 6.2.0 - das ignoriere ich mal. Und log.txt ist unvollständig. Ich brauche die erste Verbindung vom Gerät mit IP 192.168.2.153

JB1985 commented 2 years ago

iobroker.2022-10-20.log ist mit Version 6.2.0 - das ignoriere ich mal.

Ab 08:34:00 ist es Version 6.2.0, davor ist es 6.2.2.

log-192.168.2.153.txt

Das ist alles, was ich zu der IP grepen konnte.

*** Edit

Um 22 Uhr werden bei mir, via Script die Rollläden runtergefahren. Deswegen dir Uhrzeit 22 mit den Fehlern:

shelly.0 (4159) [http controlFunction] Unable to perform request - device 192.168.2.153 (undefined / undefined / undefined) is offline

Die Rollläde wird nämlich nicht runtergefahren. Es sind ungefähr 50% bei den es nicht funktioniert.

Vielleicht ist da ein Limit eingebaut, wie viele Shellys gleichzeitig angesprochen werden dürfen?

klein0r commented 2 years ago

Sorry, aber ich kann hier nicht weiter machen. Ich möchte wissen, WARUM der Fehler auftritt. Also was genau in den ersten Sekunden nach der CoAP-Verbindung vom Gerät mit IP 192.168.2.153 passiert ist. Also wie das "undefined" entsteht. Das ist das Problem - dass danach nix funktioniert, ist klar.

Bitte stop die Instanz, lösch dein Log und starte die Instanz wieder. Wenn sich die Geräte verbunden haben, dann nochmal das Log teilen.

JB1985 commented 2 years ago

iobroker.current.log

Sorry, war falscher Log. Jetzt sollte es passen.

klein0r commented 2 years ago

Und das ist mit Loglevel debug erstellt worden?! Da sind ja nur "info" Einträge enthalten.

JB1985 commented 2 years ago

iobroker.2022-10-20.log

image

debug ist eingeschaltet. Ich habe das Script - zum Schließen aller Rollläden - angestoßen. Folgende Devices haben nicht reagiert:

IP: 192.168.2.148, 192.168.2.153, 192.168.2.154, 192.168.2.151

JB1985 commented 2 years ago

Ping Test, um zu zeigen das die Geräte auch online sind und guten Empfang:

ping 192.168.2.148

PING 192.168.2.148 (192.168.2.148) 56(84) bytes of data. 64 bytes from 192.168.2.148: icmp_seq=1 ttl=127 time=79.2 ms 64 bytes from 192.168.2.148: icmp_seq=2 ttl=127 time=11.3 ms 64 bytes from 192.168.2.148: icmp_seq=3 ttl=127 time=10.6 ms 64 bytes from 192.168.2.148: icmp_seq=4 ttl=127 time=29.3 ms 64 bytes from 192.168.2.148: icmp_seq=5 ttl=127 time=5.54 ms 64 bytes from 192.168.2.148: icmp_seq=6 ttl=127 time=6.19 ms

ping 192.168.2.151 PING 192.168.2.151 (192.168.2.151) 56(84) bytes of data. 64 bytes from 192.168.2.151: icmp_seq=1 ttl=127 time=104 ms 64 bytes from 192.168.2.151: icmp_seq=2 ttl=127 time=15.0 ms 64 bytes from 192.168.2.151: icmp_seq=3 ttl=127 time=52.3 ms 64 bytes from 192.168.2.151: icmp_seq=4 ttl=127 time=3.49 ms 64 bytes from 192.168.2.151: icmp_seq=5 ttl=127 time=4.34 ms

~# ping 192.168.2.153 PING 192.168.2.153 (192.168.2.153) 56(84) bytes of data. 64 bytes from 192.168.2.153: icmp_seq=1 ttl=127 time=99.8 ms 64 bytes from 192.168.2.153: icmp_seq=2 ttl=127 time=4.95 ms 64 bytes from 192.168.2.153: icmp_seq=3 ttl=127 time=6.74 ms 64 bytes from 192.168.2.153: icmp_seq=4 ttl=127 time=5.28 ms 64 bytes from 192.168.2.153: icmp_seq=5 ttl=127 time=4.46 ms 64 bytes from 192.168.2.153: icmp_seq=6 ttl=127 time=6.42 ms ^C

~# ping 192.168.2.154 PING 192.168.2.154 (192.168.2.154) 56(84) bytes of data. 64 bytes from 192.168.2.154: icmp_seq=1 ttl=127 time=67.0 ms 64 bytes from 192.168.2.154: icmp_seq=2 ttl=127 time=24.5 ms 64 bytes from 192.168.2.154: icmp_seq=3 ttl=127 time=7.64 ms 64 bytes from 192.168.2.154: icmp_seq=4 ttl=127 time=5.05 ms 64 bytes from 192.168.2.154: icmp_seq=5 ttl=127 time=4.84 ms ^C --- 192.168.2.154 ping statistics ---

klein0r commented 2 years ago

debug ist eingeschaltet.

Du musst das Log-Level auf der Instanz verstellen. Wenn Du dort Debug anhakst, dann bedeutet das nur, dass die Debug-Meldungen vom Shelly auch geloggt werden.

JB1985 commented 2 years ago

iobroker.2022-10-20.log

Sorry! Jetzt aber ...