HM-CC-RT-DN gepaired und Missing Ack [solved]

[linuxpaul]

Danke erstmal für die Hilfe,
hab mir ein HM-MOD-RPI-MOD zugelegt, eingebaut aber noch nicht weiter getestet

Ist das ein ähliches Problem?
https://forum.fhem.de/index.php/topic,79145.0.html


linuxpaul

[Lars_]

Moin zusammen,

da bin ich ja "fast" froh, das ihr auch das Problem habt 

Ich habe vor einiger Zeit meinen Raspi neu aufgesetzt, weil die Platte einen Schlag hatte und habe seit dem das o.g. Problem.

Seit dem Neuaufbau und Update auf die aktuellsten fhem-Module kann ich den desired-state der RT's nicht mehr setzen.
Das device steht im State "set_desired-temp nn.n" und bekommt nach einiger Zeit den State "Missing Ack". Wenn ich für den Kanal 04 (_CLIMA) ein set device burstXmit absetze, wird der desired-state aber gesetzt 

Meine Cul-Definition:

# CUL868
define CUL0 CUL /dev/ttyACM0@9600 1205
attr CUL0 rfmode HomeMatic
attr CUL0 room CUL_HM,Zentrale
attr CUL0 verbose 4

Einige CUL-Stati:
get CUL0 raw t02   : CUL0 raw => 00D671FF
get CUL0 raw C35   : CUL0 raw => C35 = 0D / 13
get CUL0 raw X   : CUL0 raw => 21  900

Ich habe eine neue config erstellt und alle RT's und Fenstersensoren angelernt, um Probleme mit Strukturen oder oder anderen Funktionen auszuschließen, aus meiner Sicht ohne Erfolg.
Eben habe ich noch den Fenstersensor von meinem Beispiel RT entfernt, das scheint auch nichts zu bringen ...

Log-Auszug (mit verbose 4 für den CUL) :
Betroffenes Device: 240359

Code Auswählen Erweitern

2017.11.17 09:28:14 3: CUL_HM set bad_dg_RT_Clima desired-temp 19.0
2017.11.17 09:28:33 4: CUL_Parse: CUL0 A 0F E8 8610 240473 000000 0A24C40E004007 -70.5
2017.11.17 09:28:45 4: CUL_Parse: CUL0 A 0C 53 865A 314278 000000 ACD62907 -70.5
2017.11.17 09:28:55 4: CUL_Parse: CUL0 A 0E DF 8410 314278 000000 0BACD60C4007 -70.5
2017.11.17 09:29:01 4: CUL_Parse: CUL0 A 0F 79 8610 21F6E3 000000 0A8CC10E0040E5 -87.5
2017.11.17 09:29:05 4: CUL_Parse: CUL0 A 0C 53 8470 314278 000000 00D62906 -71
2017.11.17 09:29:09 4: CUL_Parse: CUL0 A 0F 5F 8610 319EEA 000000 0AACD60B504010 -66
2017.11.17 09:29:11 4: CUL_Parse: CUL0 A 0D 35 A610 176E49 4A4E27 06018A00CB -100.5
2017.11.17 09:29:11 4: CUL_Parse: CUL0 A 11 35 A002 4A4E27 176E49 040F1824A42FE902C3 -104.5
2017.11.17 09:29:11 4: CUL_Parse: CUL0 A 19 35 A003 176E49 4A4E27 02A157B180A2BA37977C393440D6020CCB -100.5
2017.11.17 09:29:12 4: CUL_Parse: CUL0 A 0E 35 8002 4A4E27 176E49 0046FB6E8EC5 -103.5
2017.11.17 09:29:24 4: CUL_Parse: CUL0 A 0F 89 8610 220098 000000 0A24A90C004040 -42
2017.11.17 09:29:52 4: CUL_Parse: CUL0 A 0F 48 8610 21F6C3 000000 0AACD60A50401F -58.5
2017.11.17 09:30:10 4: CUL_Parse: CUL0 A 0F 75 8610 24034C 000000 0A24B50F004011 -65.5
2017.11.17 09:30:30 4: CUL_Parse: CUL0 A 0F F8 8610 240359 000000 0AB0F48E154025 -55.5
2017.11.17 09:30:55 4: CUL_Parse: CUL0 A 0C 54 865A 314278 000000 ACD62908 -70
2017.11.17 09:31:02 4: CUL_Parse: CUL0 A 0F 7A 8610 21F6E3 000000 0A8CC10E0040E8 -86
2017.11.17 09:31:15 4: CUL_Parse: CUL0 A 0C 54 8470 314278 000000 00D62908 -70
2017.11.17 09:31:15 4: CUL_Parse: CUL0 A 0F E9 8610 240473 000000 0A24C40E004009 -69.5
2017.11.17 09:31:44 4: CUL_Parse: CUL0 A 0F 60 8610 319EEA 000000 0AACD60B434010 -66
2017.11.17 09:32:08 4: CUL_Parse: CUL0 A 0F 8A 8610 220098 000000 0A24A90C00403F -42.5
2017.11.17 09:32:09 4: CUL_Parse: CUL0 A 0F 49 8610 21F6C3 000000 0AACD60A4A401E -59
2017.11.17 09:32:22 4: CUL_Parse: CUL0 A 0F 76 8610 24034C 000000 0A24B40F004011 -65.5
2017.11.17 09:33:12 4: CUL_Parse: CUL0 A 0F F9 8610 240359 000000 0AB0F58E154024 -56
2017.11.17 09:33:42 4: CUL_Parse: CUL0 A 0F EA 8610 240473 000000 0A24C40E00400B -68.5
2017.11.17 09:33:44 4: CUL_Parse: CUL0 A 0D 36 A610 176E49 4A4E27 06019500CB -100.5
2017.11.17 09:33:44 4: CUL_Parse: CUL0 A 19 36 A003 176E49 4A4E27 113309494BF68E9544526F4084242C02CC -100
2017.11.17 09:33:52 4: CUL_Parse: CUL0 A 0F 7B 8610 21F6E3 000000 0A8CC20E004005 -71.5
2017.11.17 09:33:55 4: CUL_Parse: CUL0 A 0C 55 865A 314278 000000 ACD72907 -70.5
2017.11.17 09:34:05 4: CUL_Parse: CUL0 A 0E E1 8410 314278 000000 0BACD70C4007 -70.5
2017.11.17 09:34:05 4: CUL_Parse: CUL0 A 0F 61 8610 319EEA 000000 0AACD70B334011 -65.5
2017.11.17 09:34:10 4: CUL_Parse: CUL0 A 0F 4A 8610 21F6C3 000000 0AACD70A39401E -59
2017.11.17 09:34:15 4: CUL_Parse: CUL0 A 0C 55 8470 314278 000000 00D72906 -71
2017.11.17 09:34:38 4: CUL_Parse: CUL0 A 0F 8B 8610 220098 000000 0A24A90C00403E -43
2017.11.17 09:35:06 4: CUL_Parse: CUL0 A 0F 6A 943F 4A4E27 000000 020221A15BBABF -106.5
2017.11.17 09:35:24 4: CUL_Parse: CUL0 A 0F 77 8610 24034C 000000 0A24B40F004010 -66
2017.11.17 09:35:39 4: CUL_Parse: CUL0 A 0F FA 8610 240359 000000 0AB0F68E154024 -56
2017.11.17 09:35:54 4: CUL_Parse: CUL0 A 0F EB 8610 240473 000000 0A24C40E00400B -68.5
2017.11.17 09:36:11 4: CUL_Parse: CUL0 A 0F 62 8610 319EEA 000000 0AACD70B264011 -65.5
2017.11.17 09:36:28 4: CUL_Parse: CUL0 A 0F 7C 8610 21F6E3 000000 0A8CC20E004006 -71
2017.11.17 09:36:40 4: CUL_Parse: CUL0 A 0C 56 865A 314278 000000 ACD82907 -70.5
2017.11.17 09:36:50 4: CUL_Parse: CUL0 A 0E E2 8410 314278 000000 0BACD80C4007 -70.5
2017.11.17 09:36:53 4: CUL_Parse: CUL0 A 0F 8C 8610 220098 000000 0A24A90C00403F -42.5
2017.11.17 09:37:00 4: CUL_Parse: CUL0 A 0C 56 8470 314278 000000 00D82906 -71
2017.11.17 09:37:02 4: CUL_Parse: CUL0 A 0F 4B 8610 21F6C3 000000 0AACD80A2A401F -58.5
2017.11.17 09:37:48 4: CUL_Parse: CUL0 A 0D 37 A610 176E49 4A4E27 06019500CC -100
2017.11.17 09:37:48 4: CUL_Parse: CUL0 A 19 37 A003 176E49 4A4E27 C2CB3A3E3CDBADCFC7EB151D5C81B165CB -100.5
2017.11.17 09:37:52 4: CUL_Parse: CUL0 A 0F FB 8610 240359 000000 0AB0F78E154024 -56
2017.11.17 09:38:11 4: CUL_Parse: CUL0 A 0F 78 8610 24034C 000000 0A24B40F004010 -66
2017.11.17 09:38:50 4: CUL_Parse: CUL0 A 0F 7D 8610 21F6E3 000000 0A8CC20E004006 -71
2017.11.17 09:38:54 4: CUL_Parse: CUL0 A 0F 8D 8610 220098 000000 0A24A90C00403F -42.5
2017.11.17 09:38:57 4: CUL_Parse: CUL0 A 0F EC 8610 240473 000000 0A24C40E00400A -69
2017.11.17 09:39:07 4: CUL_Parse: CUL0 A 0F 63 8610 319EEA 000000 0AACD80B264010 -66
2017.11.17 09:39:11 4: CUL_Parse: CUL0 A 0C 57 865A 314278 000000 ACD92A06 -71
2017.11.17 09:39:21 4: CUL_Parse: CUL0 A 0E E3 8410 314278 000000 0BACD90C4007 -70.5
2017.11.17 09:39:31 4: CUL_Parse: CUL0 A 0C 57 8470 314278 000000 00D92A07 -70.5
2017.11.17 09:39:39 4: CUL_Parse: CUL0 A 0F 4C 8610 21F6C3 000000 0AACD90A19401F -58.5
2017.11.17 09:40:44 4: CUL_Parse: CUL0 A 0F 79 8610 24034C 000000 0A24B40F004011 -65.5
2017.11.17 09:40:54 4: CUL_Parse: CUL0 A 0F FC 8610 240359 000000 0AB0F88E154025 -55.5
2017.11.17 09:40:57 4: CUL_Parse: CUL0 A 0F 7E 8610 21F6E3 000000 0A8CC20E004005 -71.5
2017.11.17 09:41:27 4: CUL_Parse: CUL0 A 0C 58 865A 314278 000000 ACD92A08 -70
2017.11.17 09:41:44.894 4: CUL_Parse: CUL0 A 0F 8E 8610 220098 000000 0A24A90C004041 -41.5
2017.11.17 09:41:45.091 4: CUL_Parse: CUL0 A 0F ED 8610 240473 000000 0A24C30E004007 -70.5
2017.11.17 09:41:47.348 4: CUL_Parse: CUL0 A 0C 58 8470 314278 000000 00D92A08 -70
2017.11.17 09:41:48.660 4: CUL_Parse: CUL0 A 0F 64 8610 319EEA 000000 0AACD90B004011 -65.5
2017.11.17 09:42:01.596 4: CUL_Parse: CUL0 A 0F 4D 8610 21F6C3 000000 0AACD90A08401F -58.5


Da das bei mir schon 3 Jahre lief, denke ich, dass das ein Problem mit einem geänderten Modul (CUL?) sein könnte. Ohne die Unterstützung der Wissenden werden wir hier vermutlich nicht weiterkommen. Vlt. kann Rudolf, Martin oder einer der anderen Erfahrenen ja mal drüberschauen?

Sollten noch weitere Infos benötigt werden, kann ich die gerne bereitstellen.

Danke schon mal und ein schönes Wochenende
Lars

hier noch die Version-Infos:

Code Auswählen Erweitern

Latest Revision: 15432

File              Rev   Last Change

fhem.pl           15377 2017-11-01 16:59:23Z rudolfkoenig
96_allowed.pm     14888 2017-08-13 12:07:12Z rudolfkoenig
98_autocreate.pm  15377 2017-11-01 16:59:23Z rudolfkoenig
57_Calendar.pm    14832 2017-08-01 18:36:03Z neubert
00_CUL.pm         15027 2017-09-08 09:11:43Z rudolfkoenig
10_CUL_HM.pm      15422 2017-11-11 16:43:17Z martinp876
93_DbLog.pm       15297 2017-10-20 20:59:52Z DS_Starter
98_DOIF.pm        14790 2017-07-26 10:27:41Z Damian
98_dummy.pm       12700 2016-12-02 16:49:42Z rudolfkoenig
91_eventTypes.pm  14888 2017-08-13 12:07:12Z rudolfkoenig
01_FHEMWEB.pm     15328 2017-10-27 10:51:17Z rudolfkoenig
92_FileLog.pm     14888 2017-08-13 12:07:12Z rudolfkoenig
36_JeeLink.pm     14707 2017-07-13 18:08:33Z justme1968
36_LaCrosse.pm    15365 2017-10-31 16:59:42Z HCS
91_notify.pm      14888 2017-08-13 12:07:12Z rudolfkoenig
99_SUNRISE_EL.pm  14888 2017-08-13 12:07:12Z rudolfkoenig
98_telnet.pm      15006 2017-09-05 09:37:33Z rudolfkoenig
99_Utils.pm       13259 2017-01-28 17:39:39Z rudolfkoenig
98_version.pm     15140 2017-09-26 09:20:09Z markusbloch

Blocking.pm       15412 2017-11-09 14:34:29Z rudolfkoenig
Color.pm          11159 2016-03-30 16:08:06Z justme1968
DevIo.pm          14933 2017-08-20 14:21:58Z rudolfkoenig
HMConfig.pm       15337 2017-10-29 06:43:02Z martinp876
HttpUtils.pm      15284 2017-10-18 19:46:13Z rudolfkoenig
RTypes.pm         10476 2016-01-12 21:03:33Z borisneubert
SetExtensions.pm  12935 2017-01-02 19:51:46Z rudolfkoenig
TcpServerUtils.pm 14862 2017-08-07 15:16:03Z rudolfkoenig
TimeSeries.pm     10907 2016-02-21 17:38:02Z borisneubert

[Lars_]

Nachtrag ....
Auf einem Test-Raspi mit dem gleichen (umgehängten) Device funktioniert das setzen des desired-state prima!

Auffälligster Unterschied bei den Modulen ist m. E. das CUL_HM

10_CUL_HM.pm   15340   29.10.17   08:32:38 OK
10_CUL_HM.pm   15422   11.11.17   16:43:17 Fehler

Ich denke es liegt an einem der geänderten Module, vermutlich dem 10_CUL_HM.pm mit einem der höheren ReleaseNr (>15340).

Martin, kannst du dir das bitte mal anschauen?
(ich werde das Modul auch mal auf das andere System kopieren, dann schauen wir, ob sich das wieder etwas kooperativer verhält

Gruß
Lars

[Yokurt]

Hallo,

auch bei meinem seit Jahren funktionierenden System mit CUL  am Raspi kamen die letzten Tage keine Kommandos mehr durch.

Mit einem Rückfall auf die "alte" 10_CUL_HM.pm Version 15170 vom 2.10. scheint wieder alles wie gewohnt zu funktionieren.

Gruß
Yokurt

[Lars_]

Test auf dem produktiven System mit dem 10_CUL_HM.pm (15340   29.10.17   08:32:38) vom Test-System erfolgreich 

Ich habe nur das Modul "10_CUL_HM.pm   15340 vom 29.10.17 08:32:38" auf das produktive System kopiert (restoreDirs war auf 5 directories eingestellt und für dieses Modul leider nicht mehr möglich).
Nach einem shutdown restart klappt das setzen des desired-state wieder!

Da muss wohl mal jemand drauf schauen.
(ich kann das problematische Modul für Analysedaten bei Bedarf wieder aktivieren, falls jemand was benötigt)

Gruß und ein schönes Wochenende

[linuxpaul]

Uiui,

in meinem Fall scheint fhem-hm-knecht richtig zu liegen.
Hab den Cube durch HM-MOD-RPI-MOD ersetzt, den rt zurückgesetzt, das Device gelöscht, fhem neu gestartet,
den rt neu gepaired und ... geht 

Nix desto trotz hab ich mal die Versionen des 10_CUL_HM 15340 und 15366 verglichen und da wurden einige Regexp
die u.a. auch auf HM-CC-RT-DN filtern etwas verschärft. Bewerten will/kann ich das aber nicht. Hat sicherlich einen Grund.

Danke nochmal an alle für den Einsatz


linuxpaul

[1907]

Ich habe das gleiche Problem.
Heute meinen ersten RT versucht in Betrieb zu nehmen (zusammen mit einem SelbstbauCUL) und damit kläglich gescheitert.
Das Pairing klappte zwar, aber ich bekomme wie ihr diese MissingACK Meldungen.

Gott sei dank habe ich diesen Thread gefunden.
Nach dem ich eine ältere 10_CUL_HM.pm installiert habe funktioniert alles wie erwartet.

Viele Grüße

[Dr. Boris Neubert]

Moin zusammen,

Wenn Du etwas erreichen willst, musst Du den Beitrag dem Programmautor melden, nicht den Moderatoren.

Grüße
Boris

[mgernoth]

Hallo,

versucht bitte mal in der aktuellen Version die Zeil 1180 auszukommentieren:

Code Auswählen Erweitern


  #CUL_HM_assignIO($mh{devH}); #this way the init and remove work even on startup for TSCUL


Evtl. verursacht irgendetwas in assignIO eine zu große Verzögerung und das Timing wird nicht mehr eingehalten.

Viele Grüße
  Michael

[noansi]

Hallo,

könnt Ihr bitte auch mal per shell mit

Code Auswählen Erweitern

perl -v
Eure perl Version checken und mitteilen.

Nicht auszuschließen, dass das den Unterschied macht.

Gruß, Ansgar.

[twenta]

Gehöre auch zur Gruppe der ,,MISSING ACKs". Habe diese gestern neu gepaired (Geräte waren zuvor einwandfrei gepaired), seitdem kann ich (mit stackable SCC VERSION
V 1.65 CSM868) keine Befehle mehr an die RTs senden.
Meine Perl Version ist perl 5, version 20, subversion 2 (v5.20.2) built for arm-linux-gnueabihf-thread-multi-64int

Auch das auskommentieren von
  #CUL_HM_assignIO($mh{devH});

Hat leider nichts gebracht

[mgernoth]

Hallo,

Auch das auskommentieren von
  #CUL_HM_assignIO($mh{devH});

Hat leider nichts gebracht

Ja, anscheinend führt die aktuelle assignIO-Logik (wird noch an anderen Stellen aufgerufen) dazu, dass der Fhem-Kern die Verzögerung auslöst.
Hier ist die aktuelle CUL_HM.pm mit der alten assignIO-Logik, damit sollten die Probleme erstmal behoben sein:
https://rmdir.de/~michael/10_CUL_HM.pm

Viele Grüße
  Michael

[Yokurt]

Hello,

das ist auch meine Perlversion (mit der es nicht funktioniert hat):

Code Auswählen Erweitern

perl -v

This is perl 5, version 20, subversion 2 (v5.20.2) built for arm-linux-gnueabihf-thread-multi-64int

Gruß
Yokurt

[linuxpaul]

Diese Version habe ich auch -> die Perl Version scheint es nicht zu sein.


linuxpaul

[Yokurt]

...Hier ist die aktuelle CUL_HM.pm mit der alten assignIO-Logik, damit sollten die Probleme erstmal behoben sein:
https://rmdir.de/~michael/10_CUL_HM.pm...

Hallo,

funktioniert bei mir

Gruß
Yokurt