Zentralen

Hallo
Nachdem ich die CCU nach Einspielen eines Backups wieder glücklich am Laufen hatte (vorher befand sich die CCU nach einem Neustart plötzlich bis auf die Direktverkn. im Auslieferungszustand!) lief diese auch eine Weile. Nachdem ich ein neues Programm getestet und implementiert hatte, stellte ich am nächsten Tag fest, dass die CCU eingefroren war. Nach einem Neustart brauchte man nur versuchen sie zu bedienen (Servicemeldungen anschauen, Gerät bedienen, Programm öffnen) und schon war die CCU wieder eingefroeren. Das Deaktivieren des besagten Programms hat nichts geholfen. Das Log ist voll von Meldungen wie diese

ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed

Und auch diese hier klingt verdächtig:

 local0.emerg ReGaHss: Crash: Could not spawn a new request handler! {"HTTP-Listener"}  





Das aktuelle Log sieht wie folgt aus





Aug  6 14:56:03 (none) syslog.info syslogd started: BusyBox v1.00 (2014.07.21-09:08+0000)

Aug  6 14:56:04 (none) user.debug setclock: Try to get time from ntp.homematic.com

Oct 23 12:23:08 (none) user.debug setclock: Thu Oct 23 12:23:08 CEST 2014

Oct 23 12:23:09 (none) user.info firewall: configuration set

Oct 23 12:23:17 (none) local0.info udhcpd: udhcpd (v0.9.9-pre) started

Oct 23 12:23:18 (none) cron.notice crond: crond 2.3.2 dillon, started, log level 8

Oct 23 12:23:19 (none) user.info : hss_lcd: Programm initialisiert. Starte Hauptschleife.

Oct 23 12:23:29 (none) daemon.info cuxd: write_pid /var/run/cuxd.pid 

Oct 23 12:23:29 (none) user.info homematic: started cux-daemon

Oct 23 12:23:30 (none) daemon.info cuxd: CUx-Daemon(0.66) on CCU(1.515) start PID:1223

Oct 23 12:23:34 (none) daemon.info cuxd: AUTOMOUNT system(mount -t vfat /dev/sda1 /home)

Oct 23 12:23:34 (none) daemon.info cuxd: write_proxy /tmp/cuxd_proxy.ini

Oct 23 12:23:34 (none) daemon.info cuxd: add interface 'CUxD'

Oct 23 12:23:34 (none) daemon.info cuxd: write 4 interfaces to /usr/local/etc/config/InterfacesList.xml

Oct 23 12:23:35 (none) daemon.info cuxd: USB(1-2) 'insmod /usr/local/addons/cuxd/cdc-acm.ko'

Oct 23 12:23:36 (none) user.info homematic: started ftp server

Oct 23 12:23:40 (none) user.info homematic: started inetd

Oct 23 12:23:45 (none) user.info homematic: Homematic 1.515 has been started

Oct 23 12:23:45 (none) daemon.info init: ^MStarting pid 1395, console /dev/ttyS0: '/sbin/getty'

Oct 23 12:23:50 (none) daemon.info cuxd: USB(1-2) mknod '/dev/ttyACM0'

Oct 23 12:23:50 (none) daemon.info cuxd: USB(1-2/ttyACM0) CUL868 connect(9600:8N1)

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: XmlrpcTypeToIseVal failed 

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: XmlrpcTypeToIseVal failed 

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: XmlrpcTypeToIseVal failed 

Oct 23 12:28:59 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  

Oct 23 12:29:00 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: XmlrpcTypeToIseVal failed 

Oct 23 12:29:00 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  

Oct 23 12:29:00 (none) local0.err ReGaHss: Error: IseSingleCondition::GetValData - invalid object ID 

Oct 23 12:29:05 (none) daemon.info cuxd: INIT 'xmlrpc_bin://127.0.0.1:1999' '7330'

Oct 23 12:29:06 (none) local0.err ReGaHss: Error: IseESP::ExecError= Execution failed:  0 0x00  99 0x63  0 0x00  100 0x64  0 0x00  92 0x5c  

Oct 23 12:29:06 (none) daemon.info cuxd: setup CUX9000006:1 read(JEQ0686199:1) => BidCos-RF.JEQ0686199:1 (WEATHER) DP(|TEMPERATURE|)

Oct 23 12:29:07 (none) daemon.info cuxd: setup CUX9002007:1 read(JEQ0724802:1) => BidCos-RF.JEQ0724802:1 (WEATHER) DP(|TEMPERATURE|HUMIDITY|)

Oct 23 12:29:07 (none) daemon.info cuxd: setup CUX9002008:1 read(JEQ0725751:1) => BidCos-RF.JEQ0725751:1 (WEATHER) DP(|TEMPERATURE|HUMIDITY|)

Oct 23 12:29:07 (none) daemon.info cuxd: setup CUX9002009:1 read(LEQ0177292:1) => BidCos-RF.LEQ0177292:1 (WEATHER) DP(|TEMPERATURE|HUMIDITY|)

Oct 23 12:29:18 (none) user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET

Oct 23 12:29:18 (none) user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.

Oct 23 12:29:18 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0656217:1","STATE"} result=  

Oct 23 12:29:18 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:18 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:19 (none) user.err rfd: HSSParameter::GetValue() id=BRIGHTNESS failed getting physical value.

Oct 23 12:29:19 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0459101:1","BRIGHTNESS"} result=  

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:20 (none) user.err rfd: HSSParameter::GetValue() id=BRIGHTNESS failed getting physical value.

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0459209:1","BRIGHTNESS"} result=  

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:20 (none) user.err rfd: HSSParameter::GetValue() id=BRIGHTNESS failed getting physical value.

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0459120:1","BRIGHTNESS"} result=  

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:20 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:22 (none) user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET

Oct 23 12:29:22 (none) user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.

Oct 23 12:29:22 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0584426:1","STATE"} result=  

Oct 23 12:29:22 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:22 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:26 (none) user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET

Oct 23 12:29:26 (none) user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.

Oct 23 12:29:26 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"KEQ0023274:1","STATE"} result=  

Oct 23 12:29:26 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:26 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:27 (none) user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET

Oct 23 12:29:27 (none) user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.

Oct 23 12:29:27 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"KEQ0023274:2","STATE"} result=  

Oct 23 12:29:27 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:27 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:29:29 (none) user.err rfd: HSSParameter::GetValue() id=BRIGHTNESS failed getting physical value.

Oct 23 12:29:29 (none) local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"JEQ0459140:1","BRIGHTNESS"} result=  

Oct 23 12:29:29 (none) local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed 

Oct 23 12:29:29 (none) local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 

Oct 23 12:30:01 (none) cron.notice crond: USER root pid 1702 cmd /bin/arm7setclock

Oct 23 12:43:01 (none) syslog.info -- MARK --

Oct 23 12:45:01 (none) cron.notice crond: USER root pid 2030 cmd /bin/arm7setclock

Oct 23 12:53:59 (none) auth.info login: root login  on `pts/0'

Oct 23 12:57:45 (none) local0.emerg ReGaHss: Crash: Could not spawn a new request handler! {"HTTP-Listener"} 









Ein vergangenes Log enthielt eine weitere verdächtige Meldung. Diese sieht allerdings nach C++ Code aus, muss also Teil der Firmware sein. Kann das sein?:





Oct 20 22:17:57 (none) local0.err ReGaHss: Error: IseESP::SyntaxError= Error 1 at row 288 col 18 near ^::SetBreakOnRestart()^M {^M   if( system.IsVar("id") )^M   {^M     object oTmp = dom^M  

Oct 20 22:17:57 (none) local0.err ReGaHss:  Error: ParseProgram: SyntaxError= ::SetBreakOnRestart()^M {^M   if( system.IsVar("id") )^M   {^M     object oTmp = dom.GetObject( system.GetVar("id") );^M     if( oTmp )^M     {^M       if( system.GetVar("value") == "true" )^M       {^M         Write( oTmp.BreakOnRestart( true ) );^M       }^M       else^M       {^M         Write( oTmp.BreakOnRestart( false ) );^M       }^M     }^M   }^M   return;^M }^M ^M function ::SetActive()^M {^M   if( system.IsVar("id") )^M   {^M     object oTmp = dom.GetObject( system.GetVar("id") );^M     if( oTmp )^M     {^M       if( system.GetVar("value") == "true" )^M       {^M         Write( oTmp.Active( true ) );^M       }^M       else^M       {^M         Write( oTmp.Active( false ) );^M       }^M     }^M   }^M   return;^M }^M ^M function ::SetVisible()^M {^M   if( system.IsVar("id") )^M   {^M     object oTmp = dom.GetObject( system.GetVar("id") );^M     if( oTmp )^M     {^M       if( system.GetVar("value") == "true" )^M       {^M         Wri

Oct 20 22:17:57 (none) user.notice e( oTmp.Visible( true ) );^M       }^M     







Ich hoffe Sie können mir helfen. Ich habe immer wieder Probleme mit der CCU bezüglich Stabilität und solchen Abstürzen. Leider hab ich schon viel Geld in das Homematic System investiert, sonst haette ich mich schön längst nach einer Alternative umgesehen



Gruss Ralf Zaißer

Hallo derrapf,

Sie sollten in diesem Fall ein Backup der Homematic Zentrale mit einer entsprechenden Fehlerbeschreibung an Ihren Lieferanten zur Analyse einsenden.

Zudem sollte jegliche unzertifizierte Zusatz-Software von der Zentrale entfernt werden, da sonst keine korrekte Funktion der Zentrale gewährleistet werden kann.

Hallo Herr Sandhorst

Danke für diese Antwort aber das ist jetzt nicht das was ich mir unter Hilfe vorstelle.

Wenn ich ein Backup mitsamt der Zentrale einschicke, bin ich wahrscheinlich für längere Zeit ohne die Steuerung. D.h. ich müsste erst mal alle relvanten Dinge zurückbauen.
Ich brauch relativ dringend wenigstens einen Hinweis den ich verfolgen kann. Aktuell bin ich nciht mal mehr in der Lage die CCU zu bedienen, weil sie sich schon nach dem Reboot aufhängt. Ich kann also nicht mal ein aktuelles Backup machen.
Per Telnet und Winscp komm ich aber ohne Probleme drauf.


Es muss doch für einen Spezialisten möglich sein anhand der Logs rauszufinden wo der Fehler liegt.

Ich arbbeite auch in einer Softwarefirma. Es kommt aber eher selten vor, dass wir unsere Kunden bitte den kompletten Rechner mit einem Fullbackup des Betriebsystems einzuschicken. Zuerst mal machen wir uns die Mühe die Logfiles zu analysieren. Ist das bei EQ3 / ELV anders? Und was soll denn eigentlich mein CCU Lieferant mit dem Backup und der CCU?
Der wird damit nichts anfangen könne und das eh Sie oder EQ3 weiterleiten. Dann sind wir doch wieder genau an dieser Stelle. Warum so umständlich?

Gruss Ralf Zaißer

Hallo derrapf,

gerne geben wir Ihnen eine kurze Rückmeldung zu der aus Ihrer Sicht umständlichen Vorgehensweise.

Der kostenlose technische Support des ELV Versandhauses (als einer der vielen Vertriebskanäle des Homematic Systemes) wird durch den Verkauf der Ware finanziert. Aus diesem Grunde können wir unsere begrenzten Support-Kapazitäten lediglich unseren treuen ELV-Kunden zur Verfügung stellen.

Bei Prüfung Ihrer Kundendaten konnten wir jedoch keine relevanten Kaufnachweise über die angesprochenen Homematic Komponenten auffinden.

Sollten Sie Ihre Komponenten über das ELV Versandhaus bezogen haben, senden Sie bitte ein Backup mit Fehlerbeschreibung und ELV-Kundennummer an technik@elv.de

Sollten Sie Ihre Ware nicht bei ELV Elektronik bezogen haben, bitten wir Sie, auf Ihren Vertragspartner zuzugehen. Wir sind uns sicher, dass dieser gerne Ihre Fragen beantwortet, genauso wie wir dies für unsere treuen ELV-Kunden auch tun.