Verbindung zu HM-CFG-LAN verloren

Deutsche Foren Software
#1

Hallo,

ich habe folgendes Problem.

Seit Gestern bekomme ich keine nutzbare Verbindung zum HM-CFG-LAN mehr hin.
Ich habe bereits alle Komponenten durchgestartet.
Leider ohne Erfolgt.

Im error LOG finde ich zu Hauf folgende Einträge:

03/21/16 01:21:06.132 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Warning: !!!Not!!! sending packet, because init sequence is not complete: 0C9FA011FD00013E9C610201C8 03/21/16 01:22:50.122 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Error in file PhysicalInterfaces/HM-CFG-LAN.cpp line 768 in function void BidCoS::HM_CFG_LAN::listen(): Could not connect to server 192.168.0.62 on port 1000. Poll failed with error code: 1.

Ich habe weder die Geräte noch die Konfiguration angepasst.
Somit ist dieser Zustand für mich nicht wirklich erklärbar.

So sieht das log nach einem Start aus:

03/21/16 01:47:22.800 Starting Homegear... 03/21/16 01:47:22.801 Homegear version 0.6.0-1269 03/21/16 01:47:22.801 Git commit SHA of libhomegear-base: xx 03/21/16 01:47:22.801 Git commit SHA of Homegear: xxx 03/21/16 01:47:22.802 Info: Setting allowed core file size to "4294967295" for user with id 0 and group with id 0. 03/21/16 01:47:22.803 Info: Core file size now is "4294967295". 03/21/16 01:47:22.803 Info: Setting maximum thread priority to "100" for user with id 0 and group with id 0. 03/21/16 01:47:22.803 Info: Maximum thread priority now is "100". 03/21/16 01:47:22.806 Starting Homegear... 03/21/16 01:47:22.807 Homegear version 0.6.0-1269 03/21/16 01:47:22.807 Git commit SHA of libhomegear-base: xxx 03/21/16 01:47:22.807 Git commit SHA of Homegear: xxx 03/21/16 01:47:22.810 Info: Loading family module mod_homematicbidcos.so 03/21/16 01:47:22.835 /etc/homegear/families/homematicbidcos.conf 03/21/16 01:47:22.843 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Info: Enabling AES encryption for communication with HM-CFG-LAN. 03/21/16 01:47:22.843 Info: Loading family module mod_miscellaneous.so 03/21/16 01:47:22.849 /etc/homegear/families/miscellaneous.conf 03/21/16 01:47:22.853 Info: Settings up physical interfaces and GPIOs... 03/21/16 01:47:22.853 Info: Dropping privileges to user homegear (114) and group homegear (121) 03/21/16 01:47:22.854 Info: Homegear is (now) running as user with id 114 and group with id 121. 03/21/16 01:47:22.854 Info: Setting allowed core file size to "4294967295" for user with id 114 and group with id 121. 03/21/16 01:47:22.854 Info: Core file size now is "4294967295". 03/21/16 01:47:22.854 Info: Setting maximum thread priority to "100" for user with id 114 and group with id 121. 03/21/16 01:47:22.855 Info: Maximum thread priority now is "100". 03/21/16 01:47:22.926 Info: Backing up database... 03/21/16 01:47:23.149 Initializing database... 03/21/16 01:47:23.155 Starting script engine server... 03/21/16 01:47:23.211 Initializing licensing controller... 03/21/16 01:47:23.211 Loading licensing controller data... 03/21/16 01:47:23.211 Loading devices... 03/21/16 01:47:23.211 Loading XML RPC devices... 03/21/16 01:47:24.816 Loading device 3 03/21/16 01:47:24.817 Module HomeMatic BidCoS: Info: Central address set to 0xFD0001. 03/21/16 01:47:24.819 Module HomeMatic BidCoS: Loading peer 1 03/21/16 01:47:24.855 Module HomeMatic BidCoS: Loading peer 2 03/21/16 01:47:24.876 Module HomeMatic BidCoS: Loading peer 3 03/21/16 01:47:24.909 Module HomeMatic BidCoS: Loading peer 4 03/21/16 01:47:24.942 Module HomeMatic BidCoS: Loading peer 5 03/21/16 01:47:24.975 Module HomeMatic BidCoS: Loading peer 6 03/21/16 01:47:24.996 Module HomeMatic BidCoS: Loading peer 7 03/21/16 01:47:25.017 Module HomeMatic BidCoS: Loading peer 8 03/21/16 01:47:25.045 Module HomeMatic BidCoS: Loading peer 9 03/21/16 01:47:25.066 Module HomeMatic BidCoS: Loading peer 10 03/21/16 01:47:25.088 Module HomeMatic BidCoS: Loading peer 11 03/21/16 01:47:25.110 Module HomeMatic BidCoS: Loading peer 12 03/21/16 01:47:25.132 Module HomeMatic BidCoS: Loading peer 13 03/21/16 01:47:25.154 Module HomeMatic BidCoS: Loading peer 14 03/21/16 01:47:25.189 Module HomeMatic BidCoS: Loading peer 15 03/21/16 01:47:25.223 Module HomeMatic BidCoS: Loading peer 16 03/21/16 01:47:25.258 Loading XML RPC devices... 03/21/16 01:47:25.263 Loading device 1 03/21/16 01:47:25.264 Start listening for packets... 03/21/16 01:47:25.266 Initializing RPC client... 03/21/16 01:47:25.266 Info: Connecting to host 192.168.0.62 on port 1000... 03/21/16 01:47:25.266 Starting XML RPC server RPCServer1 listening on 0.0.0.0:2001... 03/21/16 01:47:25.271 Starting XML RPC server RPCServer2 listening on 0.0.0.0:2002, SSL enabled... 03/21/16 01:47:25.272 RPC Server (Port 2001): Info: RPC Server started listening on address 0.0.0.0 and port 2001 03/21/16 01:47:25.329 Starting XML RPC server RPCServer3 listening on 0.0.0.0:2003, SSL enabled, authentication enabled... 03/21/16 01:47:25.329 RPC Server (Port 2002): Info: RPC Server started listening on address 0.0.0.0 and port 2002 03/21/16 01:47:25.374 Starting CLI server... 03/21/16 01:47:25.375 RPC Server (Port 2003): Info: RPC Server started listening on address 0.0.0.0 and port 2003 03/21/16 01:47:25.375 Initializing event handler... 03/21/16 01:47:25.376 Loading events... 03/21/16 01:47:25.377 Startup complete. Waiting for physical interfaces to connect. 03/21/16 01:47:25.378 All physical interfaces are connected now. 03/21/16 01:47:25.378 Starting UPnP server... 03/21/16 01:47:25.380 Info: UPnP server: Binding to address: 192.168.0.101 03/21/16 01:47:25.381 UPnP Server: Info: Started listening. 03/21/16 01:47:40.278 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Error in file PhysicalInterfaces/HM-CFG-LAN.cpp line 768 in function void BidCoS::HM_CFG_LAN::listen(): Could not connect to server 192.168.0.62 on port 1000. Poll failed with error code: 1.

Wenn ich aber mit dem eQ-3 LAN Configurator das Gerät aufrufe, erreiche ich es zuverlässig.

Hat wer eine Idee, wie ich hier weiter komme?

portboy

#2

Mut zur Selbsthilfe :slight_smile:

Habe dem HM CFG LAN mal die neue FW 0.965 verpasst.

Zu finden hier: http://www.eq-3.de/service/downloads.html?id=87 - HomeMatic Firmware Update Tool V1.2.

Nun läuft es wieder :stuck_out_tongue:
Habe aber im Rahmen meiner Recherche herausgefunden, dass der LAN Adapter dazu neigen kann, aus unerklärlichen Gründen die Verbindung zu verlieren. Abhilfe schein immer nur eine FW update zu verschaffen (selbst wenn die Versin die Gleiche ist).

Habt ihr auch dieses Verhalten?

Werde dies mal weiter beobachten.

Da es sich nicht um einen Fehler von Homegear handelt sondern der Hardware handelt, darf der Thread gerne verschoben werden :mrgreen:

#3

Ich hab das Problem aktuell auch, nur ein Firmware-Update wird es nicht richten, es gibt nämlich keine aktuellere mehr.

06/27/18 18:44:56.824 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Error in file PhysicalInterfaces/HM-CFG-LAN.cpp line 431 in function void BidCoS::HM_CFG_LAN::reconnectThread(): Could not connect to server 192.168.xx.yy on port 1000. Poll failed with error code: 1.
06/27/18 18:44:58.096 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Warning: Connection to HM-CFG-LAN closed. Trying to reconnect...
06/27/18 18:45:06.184 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Error in file PhysicalInterfaces/HM-CFG-LAN.cpp line 431 in function void BidCoS::HM_CFG_LAN::reconnectThread(): Could not connect to server 192.168.xx.yy on port 1000. Poll failed with error code: 1.
06/27/18 18:45:08.097 Module HomeMatic BidCoS: LAN-Konfigurationsadapter "My-HM-CFG-LAN": Warning: Connection to HM-CFG-LAN closed. Trying to reconnect...

Ideen?

#4

Hallo @m0wlheld,

es kommt keine TCP-Verbindung zustande. Der Fehler tritt in der C-Funktion poll() auf. Diese wartet, bis auf dem TCP-Socket IO-Operationen ausgeführt werden können. Aus der Doku der Funktion zu dem Fehlerbit (POLLERR):

Error condition (only returned in revents; ignored in events).
This bit is also set for a file descriptor referring to the
write end of a pipe when the read end has been closed.

Zu revents:

The field revents is an output parameter, filled by the kernel with the
events that actually occurred.

Der Funktionsrückgabewert 1 bedeutet, dass in einem Socketdeskriptor (es gibt nur einen) Ereignisse aufgetreten sind.

Zusammengefasst kann also Linux-Kernel-seitig keine TCP-Verbindung aufgebaut werden. Einfachster Grund: Das Gerät ist unter der angegebenen IP-Adresse und Port nicht erreichbar. Kannst du den HM-CFG-LAN unter der angegebenen IP anpingen? Was sagt nmap? Ist Port 1000 geöffnet?

Viele Grüße

Sathya

#5

Nun der Fehler entsteht aus einem Timing verhalten, dass gerade bei etwas komplexeren Netzwerken auftreten kann. Ursächlich können dafür auch Switches mit leichten Aussetzern sein.

Kommt HomeGear nicht regelmäßig genug mit einem Paket beim HM-CFG-LAN an, meldet der HM-CFG-LAN die Verbindung zu HomeGear ab. Eigentlich sollte der HM-CFG-LAN dann wieder für neue Verbindungen bereit stehen. Oftmals ist aber dann doch noch das Paket vom HomeGear zum HM-CFG-LAN unterwegs, womit dann der Port 1000, der HM-CFG-LAN-seitig nur für exakt eine Verbindung ausgelegt ist “blockiert”. Für einen Retry ist der Port dann nicht erreichbar. Leider kommt die Firmware im HM-CFG-LAN dabei in einen Zustand, aus dem sie selber nicht mehr raus kommt. Folge ist, dass nur noch ein Reset hilft. Sprich einmal PowerCyclen.
EQ3 macht aber am HM-CFG-LAN nichts mehr, das Produkt wurde eingestellt.
Überhaupt tendiert EQ3 immer mehr zu HM-IP anstatt HM-BidCos parallel weiter zu pflegen.

Ich habe mich daher entschieden, bei mir alle HM-CFG-LAN nach und nach durch Raspberry 3 mit dem CC1101 von pmayer’s cod.m Shop zu tauschen. Mit der HomeGear-Gateway Unterstützung verspricht dass deutlich zuverlässiger zu sein. Außerdem kann man die PIs mit einem Kabel und POE Splitter via POE stromversorgen.

2 Likes