Abwechselnd No Response und Missing Ack bei HM

[Clif]

Hallo zusammen,

seit gestern habe ich mit meinen HM system Probleme.
Alle Termostate melden abwechselnd Missing ACK und Response Timeout: RegisterRead
Bisher habe ich
1. Neu gepairt --> Pairing hat nicht auf anhieb geklappt es kam mehrfach nAC
2. Termostat in der Config entfernt und komplett neu angelegt
3. Termostat resettet
4. Fhem Update
5. Raspi neustart
alles in allem wurde es aber nicht besser eher schlechter.

Gestern abend hatte ich die Regler soweit das die alle die komandos empfangen hatten und das auch bestätigt. Heut früh war wieder alles wie vorher und alles Missing Ack und Response Timeout.

Hat jemand eine Idee?

Viele Grüße,

Clif

[Puschel74]

Hallo,

Hat jemand eine Idee?

Ja.
Die angepinnten Beiträge hast du gelesen?

Da es sich hier weniger um eine "Anfängerfrage" handelt sondern eher um ein Problem mit/an einem HM-Device wäre das richtigere Unterforum der HM-Bereich - das wird aber in einem angepinnten Beitrag auch so erwähnt.
Aber gut - ich verschieb mal in den HomeMatic-Bereich.

Das nächste mal bitte selbst überlegen wo die Frage besser aufgehoben wäre - danke.

Grüsse

[Clif]

Ja.
Die angepinnten Beiträge hast du gelesen?

Ja habe ich und sorry für den falschen Bereich

Ich habe auch die Suche hier ausgibig genutzt und nichts passendes gefunden
Mittlerweile geht nur noch der Funk Dimmer normal, die Termostate werden zwar als alive angezeigt, sind aber im Status Fehlerhaft.

Viele Grüße,
Clif

[martinp876]

Hallo Clif,

die Termostate werden zwar als alive angezeigt, sind aber im Status Fehlerhaft.

soll heisen?

kannst du einmal rohmessages aufzeichnen?
http://forum.fhem.de/index.php/topic,16563.0.html

machst du aktionen oder sind das automatische reads?
Gruss Martin

[Clif]

Hallo Martin,

Zitat

    die Termostate werden zwar als alive angezeigt, sind aber im Status Fehlerhaft.

soll heisen?

Es wird Missing ACK oder Response Timeout: RegisterRead angezeigt.  Das passiert vor allem wenn ich z.B. getConfig gesendet habe.
Ich habe vorhin mal ein simples Pair gesendet  da stand als Status dann CMDs_done.

Sooo hier mal noch die Fehlenden Punkte
Der Auszug aus dem Log:

Code Auswählen Erweitern

2014.03.21 18:34:06.954 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:34:06.977 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033B6B13 IDcnt:0004
2014.03.21 18:34:17.259 0: HMLAN_Parse: hmusb R:E22BEAC   stat:0000 t:033B8393 d:FF r:FFC8     m:4C 8610 22BEAC 000000 0A28C310002D
2014.03.21 18:34:31.962 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:34:31.972 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033BCCC3 IDcnt:0004
2014.03.21 18:34:44.261 0: HMLAN_Parse: hmusb R:E22BEB6   stat:0000 t:033BFCB0 d:FF r:FFD8     m:5C 8610 22BEB6 000000 0A84E210002D
2014.03.21 18:34:56.967 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:34:56.998 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033C2E70 IDcnt:0004
2014.03.21 18:34:59.558 0: HMLAN_Parse: hmusb R:E231E5B   stat:0000 t:033C386B d:FF r:FFBC     m:D6 8610 231E5B 000000 0AA8E10F0658
2014.03.21 18:34:59.632 0: HMLAN_Send:  hmusb S:SE5B5C932 stat:  00 t:00000000 d:01 r:E5B5C932 m:39 A112 050540 231E5B
2014.03.21 18:35:09.343 0: HMLAN_Parse: hmusb R:RE5B5C932 stat:0001 t:033C3973 d:FF r:FFBD     m:39 8002 231E5B 050540 00
2014.03.21 18:35:09.352 0: HMLAN_Send:  hmusb S:+231E5B,00,01,1E
2014.03.21 18:35:09.354 0: HMLAN_Send:  hmusb S:SE5B5EF6B stat:  00 t:00000000 d:01 r:E5B5EF6B m:3A A001 050540 231E5B 00040000000000
2014.03.21 18:35:10.024 0: HMLAN_Parse: hmusb R:RE5B5EF6B stat:0008 t:00000000 d:FF r:7FFF     m:3A A001 050540 231E5B 00040000000000
2014.03.21 18:35:10.026 0: HMLAN_Parse: hmusb no ACK from 231E5B
2014.03.21 18:35:21.975 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:35:21.993 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033C901F IDcnt:0004
2014.03.21 18:35:29.066 0: HMLAN_Parse: hmusb R:E22B5EC   stat:0000 t:033CABB0 d:FF r:FFC2     m:50 8610 22B5EC 000000 0A78C4100026
2014.03.21 18:35:46.984 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:35:47.020 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033CF1D0 IDcnt:0004
2014.03.21 18:36:12.002 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:36:12.015 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033D5389 IDcnt:0004
2014.03.21 18:36:38.940 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:36:38.962 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033DBCC5 IDcnt:0004
2014.03.21 18:36:42.770 0: HMLAN_Parse: hmusb R:E22BEAC   stat:0000 t:033DCB90 d:FF r:FFC8     m:4D 8610 22BEAC 000000 0A28C310002D
2014.03.21 18:37:03.950 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:37:03.957 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033E1E75 IDcnt:0004
2014.03.21 18:37:26.551 0: HMLAN_Parse: hmusb R:E231E5B   stat:0000 t:033E76A3 d:FF r:FFBC     m:D7 8610 231E5B 000000 0AA8E00F0658
2014.03.21 18:37:26.628 0: HMLAN_Send:  hmusb S:SE5B80763 stat:  00 t:00000000 d:01 r:E5B80763 m:3B A112 050540 231E5B
2014.03.21 18:37:34.306 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:37:34.312 0: HMLAN_Parse: hmusb R:RE5B80763 stat:0001 t:033E77A5 d:FF r:FFBC     m:3B 8002 231E5B 050540 00
2014.03.21 18:37:34.321 0: HMLAN_Send:  hmusb S:SE5B825B4 stat:  00 t:00000000 d:01 r:E5B825B4 m:3C A001 050540 231E5B 00040000000000
2014.03.21 18:37:34.334 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033E950A IDcnt:0004
2014.03.21 18:37:34.968 0: HMLAN_Parse: hmusb R:RE5B825B4 stat:0008 t:00000000 d:FF r:7FFF     m:3C A001 050540 231E5B 00040000000000
2014.03.21 18:37:34.970 0: HMLAN_Parse: hmusb no ACK from 231E5B
2014.03.21 18:37:43.001 0: HMLAN_Parse: hmusb R:E22BEB6   stat:0000 t:033EB6EC d:FF r:FFD8     m:5D 8610 22BEB6 000000 0A84E110002D
2014.03.21 18:37:50.554 0: HMLAN_Parse: hmusb R:E22B5EC   stat:0000 t:033ED46B d:FF r:FFC2     m:51 8610 22B5EC 000000 0A78C3100026
2014.03.21 18:38:01.166 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:38:01.179 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033EFDF4 IDcnt:0004
2014.03.21 18:38:26.187 0: HMLAN_Send:  hmusb I:K
2014.03.21 18:38:26.206 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700395 d:1EBBE7 O:050540 t:033F5FB1 IDcnt:0004

und hier mal noch nen schnipsel aus der fhem.cfg

Code Auswählen Erweitern

define CUL_HM_HM_CC_RT_DN_231E5B CUL_HM 231E5B
attr CUL_HM_HM_CC_RT_DN_231E5B IODev hmusb
attr CUL_HM_HM_CC_RT_DN_231E5B actCycle 000:10
attr CUL_HM_HM_CC_RT_DN_231E5B actStatus alive
attr CUL_HM_HM_CC_RT_DN_231E5B autoReadReg 4_reqStatus
attr CUL_HM_HM_CC_RT_DN_231E5B expert 2_full
attr CUL_HM_HM_CC_RT_DN_231E5B firmware 1.1
attr CUL_HM_HM_CC_RT_DN_231E5B model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B peerIDs
attr CUL_HM_HM_CC_RT_DN_231E5B room CUL_HM
attr CUL_HM_HM_CC_RT_DN_231E5B serialNr KEQ0723615
attr CUL_HM_HM_CC_RT_DN_231E5B subType thermostat
attr CUL_HM_HM_CC_RT_DN_231E5B webCmd getConfig:clear msgEvents:burstXmit
define CUL_HM_HM_CC_RT_DN_231E5B_Weather CUL_HM 231E5B01
attr CUL_HM_HM_CC_RT_DN_231E5B_Weather model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B_Weather peerIDs
define CUL_HM_HM_CC_RT_DN_231E5B_Climate CUL_HM 231E5B02
attr CUL_HM_HM_CC_RT_DN_231E5B_Climate model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B_Climate peerIDs
define CUL_HM_HM_CC_RT_DN_231E5B_WindowRec CUL_HM 231E5B03
attr CUL_HM_HM_CC_RT_DN_231E5B_WindowRec model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B_WindowRec peerIDs
attr CUL_HM_HM_CC_RT_DN_231E5B_WindowRec stateFormat last:trigLast
define Wohnzimmer_Heizung CUL_HM 231E5B04
define CUL_HM_HM_CC_RT_DN_231E5B_ClimaTeam CUL_HM 231E5B05
attr CUL_HM_HM_CC_RT_DN_231E5B_ClimaTeam model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B_ClimaTeam peerIDs
define CUL_HM_HM_CC_RT_DN_231E5B_remote CUL_HM 231E5B06
attr CUL_HM_HM_CC_RT_DN_231E5B_remote model HM-CC-RT-DN
attr CUL_HM_HM_CC_RT_DN_231E5B_remote peerIDs


[martinp876]

hm - das ist heftig.
Das Device sendet seine message, 100ms danach sendet FHEM ein 'warte mal, ich will wass' -> perfekt.
Das device Antwortet:'ok' 150ms später. ABER: das kommt erst 10sec später in FHEM an!
Das ist mehr als übel!
In den Logs passiert nichts, was diese Verzögerung erklärt.
Es liegt also weder am Device noch am HMLAN. Nachstellen kann ich es nicht, ohne dass du mir noch einmal sagst, wie du das erreichst.

Läuft noch etwas zwischendurch? Kannst du einmal mit apptime FHEM ausmessen?

[Clif]

Hi Martin,

ich habe noch mysql laufen (mit mehr oder weniger last) die DB ist dort aber recht schnell gewachsen.
Ich kann das DB Logging ja mal deaktivieren und Testen.

Apptime sagt mir grad nichts meintest du "time" ansich?

[martinp876]

apptime ist eine kleine timing-analyse, die ich für FHEM zum Analysieren geschrieben habe.
rufe einfach apptime in fhem auf - und schaue ins kommandref.

[Clif]

 
Ich hab jetzt mal dbLog aus gemact und mysql gestoppt
Jetzt funzt es wieder wie gewohnt.
Fazit mysql DB auslagern oder besser die Daten dafür Filtern (die DB war schon über 90 MB groß und das System hat erst 1,5 wochen geloggt)