Firmware zu CUL, CUNX und Co. mit Timestamp Option ASKSIN tsculfw V0.41

[jw1hal]

Hallo noansi,

ich weiß jetzt nicht, ob wir aneinander vorbeireden. Ich habe 2xCUL, einmal 868 und einmal 433. Beide greifen sicherlich auf die besagte Datei "10_IT.pm" zu. Ich bin kein Experte, weiß nicht was die Datei macht und in wie weit die beiden CUL´s darauf zugreifen werden. Sie hat sicherlich mehr oder weniger mit IT zu tun, was dann wohl eher auf 433 schließen lässt oder wo eben mehr der 433er CUL in Frage kommen würde.
Die Frage ich aber nun für mich und die ist immer noch offen, ob der 868er CUL mit der TS-Firmware und der 433er CUL mit der a-culfw-Firmware (ich glaube 1.67 oder so war das) noch ordentlich ihre Arbeit machen, wenn ich die Datei "10_IT.pm" aus der Sicherung wieder nehme.

Die nächste Frage wäre für mich was nun vorteilhafter für den 433er wäre. Für die die Fensterkontakte brauche ich ja wohl TS auf den 868er. Aber was ist nun ganz ehrlich für 433 besser? Ich meine jetzt gerade, wo beide CUL´s mit TS laufen, habe ich den Eindruck, dass es läuft. Alles was da ist wird geschalten und gut ist. Allerdings habe ich ja noch ein paar Dosen, die noch nicht laufen. Und wenn da mit a-culfw mehr Chancen bestehen (den Eindruck habe ich), wäre dies doch dann besser. Dann wäre ich aber wieder bei der Frage aus dem obrigen Abschnitt.

Die Dosen haben auch alle das Attribut IODev auf CUL_433 gesetzt. Ich würde ja gerne alles posten, damit man es sieht, befürchte aber, dass es dann zu viel wird. Gut, im Einsatz habe ich nur 5. Das sind die Dinger von Brennenstuhl. Und das sind, wenn ich jetzt so überlege, die einzigen Sachen, die über 433 laufen. Der Rest läuft über 868 (HM; Lichtschalter, Thermostate und Fensterkontakte) und IP (Sonoff, DBox2 und Sony-TV).

[noansi]

Hallo jw1hal,

Die Frage ich aber nun für mich und die ist immer noch offen, ob der 868er CUL mit der TS-Firmware und der 433er CUL mit der a-culfw-Firmware (ich glaube 1.67 oder so war das) noch ordentlich ihre Arbeit machen, wenn ich die Datei "10_IT.pm" aus der Sicherung wieder nehme.

Der 868er wird sie nicht nutzen.

Die aktuelle a-culfw findest Du hier https://forum.fhem.de/index.php/topic,35064.msg273774.html#msg273774.

Die nächste Frage wäre für mich was nun vorteilhafter für den 433er wäre.

Das wirst Du wohl schlicht ausprobieren müssen.

Mit einem Backup vom jetzigen Stand, mit dem es anscheinend gar nicht mal so schlecht läuft, kannst Du auch wieder zurück.

Und wenn da mit a-culfw mehr Chancen bestehen (den Eindruck habe ich), wäre dies doch dann besser.

In jedem Fall musst Du die Fernbedienung zu diesen Dosen noch funktionsfähig haben, da mit Autcreate nur was gehen kann, wenn der 433er CUL das Schalttelegram empfangen kann.

Gruß, Ansgar

[jw1hal]

Hallo noansi,

ich danke dir. Dann werde ich mal probieren.


Gruß jw1hal

[presskopf]

Hallo Ansgar, hallo alle,

seit geraumer Zeit nutze ich TSCUL eigentlich ohne Probleme; bin auch auf 0.29, wobei 0.26 auch anstandslos bei mir lief.
Ich habe 3 CULs (Arduino Nano) am Start. Zwei über ser2net an Raspberries im LAN; der Erste am Server.

Jetzt macht seit Kurzem einer der drei Burschen: CUL5 Probleme, indem er nicht mehr senden kann.
Erst nach einem reopen läuft er wieder - aber nur für kurze Zeit.

Jemand eine Idee?
Hat der Arduino einen Schatten oder habe ich was falsch konfiguriert?


Um 11:30 habe ich mal ein "set roll_kitchen stop" gesendet.

Hier das relevante Log:

Code Auswählen Erweitern


018.11.26 10:09:20 3: LogHist CUL5:  448367 A F402 00779844 00 15 AA001122AA001122AA001122AA001122AA001122AA _ping
2018.11.26 10:09:20 3: LogHist CUL5:  455959 A F401 00787440 00 0C 78 865A 43110F 000000 B4E233 -78dB
2018.11.26 10:09:20 3: LogHist CUL5:  471427 A F402 00802916 00 15 AA001122AA001122AA001122AA001122AA001122AA _ping
2018.11.26 10:09:20 3: LogHist CUL5:  475973 A F401 00807444 00 0C 78 8470 43110F 000000 00E233 -78dB
2018.11.26 10:09:20 3: LogHist CUL5:  478510 A F401 00809972 00 0C 15 865A 3EF2D6 000000 ACDC2E -68.5dB
2018.11.26 10:09:20 3: LogHist CUL5:  485600 A F401 00817020 00 0D FA 8410 5160AA ABCDEF 06012300 -59dB
2018.11.26 10:09:20 3: LogHist CUL5:  498561 A F401 00829976 00 0C 15 8470 3EF2D6 000000 00DC2E -68.5dB
2018.11.26 10:09:20 3: LogHist CUL5:  499300 A F401 00830720 00 0D 26 8410 516081 ABCDEF 06012300 -66dB
2018.11.26 10:09:20 3: LogHist CUL5:  502155 A F402 00833656 00 01 CC _ping
2018.11.26 10:09:20 3: LogHist CUL5:  502970 A F402 00834456 00 15 AA001122AA001122AA001122AA001122AA001122AA _ping
2018.11.26 10:09:20 3: LogHist CUL5:  506314 A F40C 00837800 00 0D F8 A610 44BC95 ABCDEF 06010000 -80.5dB _AEScommReq
2018.11.26 10:09:20 3: LogHist CUL5:  506534 A F403 00837976 15 11 F8 A002 ABCDEF 44BC95 0449F64FDA9BC802 _CCAdly:84 _dhmSt:176
2018.11.26 10:09:20 3: LogHist CUL5:  506585 A F40C 00838072 00 0D F9 A610 44BC95 ABCDEF 06010000 -81dB _AEScommReq
2018.11.26 10:09:20 3: LogHist CUL5:  506858 A F403 00838304 23 11 F9 A002 ABCDEF 44BC95 0418DCBC04F53C02 _CCAdly:140 _dhmSt:232
2018.11.26 10:09:20 3: TSCUL_ParseTsHM: CUL5 HM AES Comm Req device authentication timed out from 44BC95/door_base:  506965 A F412 00838456 00 0D F9 A610 44BC95 ABCDEF 06010000 -81dB _AuthTimeout
2018.11.26 10:09:20 3: LogHist CUL5:  455959 A F401 00787440 00 0C 78 865A 43110F 000000 B4E233 -78dB
2018.11.26 10:09:20 3: LogHist CUL5:  471427 A F402 00802916 00 15 AA001122AA001122AA001122AA001122AA001122AA _ping
2018.11.26 10:09:20 3: LogHist CUL5:  475973 A F401 00807444 00 0C 78 8470 43110F 000000 00E233 -78dB
2018.11.26 10:09:20 3: LogHist CUL5:  478510 A F401 00809972 00 0C 15 865A 3EF2D6 000000 ACDC2E -68.5dB
2018.11.26 10:09:20 3: LogHist CUL5:  485600 A F401 00817020 00 0D FA 8410 5160AA ABCDEF 06012300 -59dB
2018.11.26 10:09:20 3: LogHist CUL5:  498561 A F401 00829976 00 0C 15 8470 3EF2D6 000000 00DC2E -68.5dB
2018.11.26 10:09:20 3: LogHist CUL5:  499300 A F401 00830720 00 0D 26 8410 516081 ABCDEF 06012300 -66dB
2018.11.26 10:09:20 3: LogHist CUL5:  502155 A F402 00833656 00 01 CC _ping
2018.11.26 10:09:20 3: LogHist CUL5:  502970 A F402 00834456 00 15 AA001122AA001122AA001122AA001122AA001122AA _ping
2018.11.26 10:09:20 3: LogHist CUL5:  506314 A F40C 00837800 00 0D F8 A610 44BC95 ABCDEF 06010000 -80.5dB _AEScommReq
2018.11.26 10:09:20 3: LogHist CUL5:  506534 A F403 00837976 15 11 F8 A002 ABCDEF 44BC95 0449F64FDA9BC802 _CCAdly:84 _dhmSt:176
2018.11.26 10:09:20 3: LogHist CUL5:  506585 A F40C 00838072 00 0D F9 A610 44BC95 ABCDEF 06010000 -81dB _AEScommReq
2018.11.26 10:09:20 3: LogHist CUL5:  506858 A F403 00838304 23 11 F9 A002 ABCDEF 44BC95 0418DCBC04F53C02 _CCAdly:140 _dhmSt:232
2018.11.26 10:09:20 3: LogHist CUL5:  506965 A F412 00838456 00 0D F9 A610 44BC95 ABCDEF 06010000 -81dB _AuthTimeout
2018.11.26 10:09:20 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 44BC95/door_base:  507077 A F409 00838576 00 11 F9 A002 ABCDEF 44BC95 0418DCBC04F53C02 _sfail _noAnsw
2018.11.26 10:09:59 1: RMDIR: ./restoreDir/save/2018-11-23
2018.11.26 10:15:45 3: CUL_HM set roll_kitchen stop
2018.11.26 10:23:33 3: LogHist CUL5:  267087                 As 0D FA 8002 ABCDEF 516475 01012100
2018.11.26 10:23:33 3: LogHist CUL5:  267090 A F101 01647312 00 0D FA A641 516475 ABCDEF 01A02150 -56dB
2018.11.26 10:23:33 3: LogHist CUL5:  267216 A F103 01647408 01 0A FA 8002 ABCDEF 516475 00 _CCAdly:4 _dhmSt:96
2018.11.26 10:23:33 3: LogHist CUL5:  267319 A F103 01647512 01 0D FA 8002 ABCDEF 516475 01012100 _CCAdly:4 _dhmSt:200
2018.11.26 10:23:33 3: LogHist CUL5:  277711 A F101 01657908 00 0C 3A 8470 3F81C7 000000 00AF3B -83dB
2018.11.26 10:23:33 3: LogHist CUL5:  277819 A F101 01657952 00 0D FB 8410 516475 ABCDEF 06012100 -56.5dB
2018.11.26 10:23:33 3: LogHist CUL5:  302587 A F101 01682804 00 0C 74 865A 430EFE 000000 98BF3C -78dB
2018.11.26 10:23:33 3: LogHist CUL5:  306313 A F101 01686556 00 0D FC A641 516475 ABCDEF 01A12150 -59dB
2018.11.26 10:23:33 3: LogHist CUL5:  306321                 As 0D FC 8002 ABCDEF 516475 01012100
2018.11.26 10:23:33 3: LogHist CUL5:  306461 A F103 01686672 06 0A FC 8002 ABCDEF 516475 00 _CCAdly:24 _dhmSt:116
2018.11.26 10:23:33 3: LogHist CUL5:  306572 A F103 01686776 01 0D FC 8002 ABCDEF 516475 01012100 _CCAdly:4 _dhmSt:220
2018.11.26 10:23:33 3: LogHist CUL5:  307092 A F101 01687264 00 0D FE 8410 5160AA ABCDEF 06012300 -58dB
2018.11.26 10:23:33 3: LogHist CUL5:  311155 A F10C 01691396 00 0C FB A641 44BC95 ABCDEF 0132C8 -77dB _AEScommReq
2018.11.26 10:23:33 3: LogHist CUL5:  311298 A F103 01691492 01 11 FB A002 ABCDEF 44BC95 04E3358E717A5B02 _CCAdly:4 _dhmSt:96
2018.11.26 10:23:33 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 44BC95/door_base:  311522 A F109 01691764 00 11 FB A002 ABCDEF 44BC95 04E3358E717A5B02 _sfail _noAnsw
2018.11.26 10:47:31 1: PERL WARNING: Argument "on" isn't numeric in numeric gt (>) at ./FHEM/98_SVG.pm line 1556.
2018.11.26 10:47:31 1: PERL WARNING: Argument "off" isn't numeric in numeric gt (>) at ./FHEM/98_SVG.pm line 1556.
2018.11.26 10:47:31 1: PERL WARNING: Argument "on" isn't numeric in subtraction (-) at ./FHEM/98_SVG.pm line 1928.
2018.11.26 10:47:31 1: PERL WARNING: Argument "off" isn't numeric in subtraction (-) at ./FHEM/98_SVG.pm line 1928.
2018.11.26 10:47:31 1: PERL WARNING: Argument "off" isn't numeric in sprintf at ./FHEM/98_SVG.pm line 2197.
2018.11.26 10:55:45 3: ABFALL myAbfall - CALENDAR:myCalendar triggered, updating ABFALL myAbfall ...
2018.11.26 10:55:45 3: ABFALL_UPDATE
2018.11.26 10:55:45 2: get myCalendar text is deprecated and will be removed soon. Use get myCalendar events instead.
2018.11.26 11:25:27 2: TSCUL_ReceiveDelayed: CUL5  C 00=07 01=2E 02=01 03=42 04=E9 05=CA 06=31 07=0C 08=45 09=00 0A=00 0B=06 0C=F3 0D=0D 0E=65 0F=6A 10=C8 11=93 12=03 13=22 14=F8 15=34 16=07 17=3C 18=18 19=16 1A=6C 1B=43 1C=67 1D=91 1E=87 1F=6B 20=F8 21=56 22=10 23=AB 24=2B 25=38 26=11 27=41 28=68 29=68 2A=68 2B=3E 2C=68 2D=68 2E=68 2F=00 30=00 31=14 32=F2 33=00 34=C0 35=0D 36=00 37=00 38=30 39=BE 3A=00 3B=00 3C=00 3D=00
2018.11.26 11:30:19 3: CUL_HM set roll_kitchen stop
2018.11.26 11:30:20 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  124331 A F004 05698628 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:22 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  125594 A F004 05699888 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:23 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  126856 A F004 05701148 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:23 3: LogHist CUL5:  412570 A F001 03890324 00 0E 21 8410 3EF2D6 000000 0BACDF0B40 -65.5dB
2018.11.26 11:30:23 3: LogHist CUL5:  414464 A F001 03892284 00 0C 9D 865A 432C73 000000 98CB36 -71.5dB
2018.11.26 11:30:23 3: LogHist CUL5:  415153 A F001 03892944 00 0D 36 8041 3F81A7 4B7E69 0731C880 -63dB
2018.11.26 11:30:23 3: LogHist CUL5:  417501 A F001 03895320 00 0D 30 8410 516081 ABCDEF 06012400 -65dB
2018.11.26 11:30:23 3: LogHist CUL5:  422502 A F001 03900324 00 0C 29 8470 3EF2D6 000000 00DF2E -66dB
2018.11.26 11:30:23 3: LogHist CUL5:  168256 A F002 04170416 00 01 C3 _ping
2018.11.26 11:30:23 3: LogHist CUL5:  314294 A F002 04316488 00 01 CC _ping
2018.11.26 11:30:23 3: LogHist CUL5:  390321 A F002 04916916 00 01 CC _ping
2018.11.26 11:30:23 3: LogHist CUL5:  143680 A F002 05194616 00 01 C3 _ping
2018.11.26 11:30:23 3: LogHist CUL5:  466358 A F002 05517348 00 01 CC _ping
2018.11.26 11:30:23 3: LogHist CUL5:  123284                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:23 3: LogHist CUL5:  124331 A F004 05698628 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:23 3: LogHist CUL5:  125594 A F004 05699888 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:23 3: LogHist CUL5:  126856 A F004 05701148 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:23 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 3FC88B/roll_kitchen:  127096 A F009 05702408 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:26 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  129588 A F004 05703880 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:27 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  130835 A F004 05705140 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  132098 A F004 05706400 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  168256 A F002 04170416 00 01 C3 _ping
2018.11.26 11:30:28 3: LogHist CUL5:  314294 A F002 04316488 00 01 CC _ping
2018.11.26 11:30:28 3: LogHist CUL5:  390321 A F002 04916916 00 01 CC _ping
2018.11.26 11:30:28 3: LogHist CUL5:  143680 A F002 05194616 00 01 C3 _ping
2018.11.26 11:30:28 3: LogHist CUL5:  466358 A F002 05517348 00 01 CC _ping
2018.11.26 11:30:28 3: LogHist CUL5:  123284                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:28 3: LogHist CUL5:  124331 A F004 05698628 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  125594 A F004 05699888 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  126856 A F004 05701148 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  127096 A F009 05702408 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:28 3: LogHist CUL5:  128534                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:28 3: LogHist CUL5:  129588 A F004 05703880 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  130835 A F004 05705140 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: LogHist CUL5:  132098 A F004 05706400 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:28 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 3FC88B/roll_kitchen:  132337 A F009 05707660 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:30 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  134031 A F004 05708328 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:31 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  135293 A F004 05709588 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  136554 A F004 05710848 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  123284                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:33 3: LogHist CUL5:  124331 A F004 05698628 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  125594 A F004 05699888 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  126856 A F004 05701148 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  127096 A F009 05702408 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:33 3: LogHist CUL5:  128534                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:33 3: LogHist CUL5:  129588 A F004 05703880 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  130835 A F004 05705140 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  132098 A F004 05706400 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  132337 A F009 05707660 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:33 3: LogHist CUL5:  132983                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:33 3: LogHist CUL5:  134031 A F004 05708328 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  135293 A F004 05709588 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: LogHist CUL5:  136554 A F004 05710848 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:33 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 3FC88B/roll_kitchen:  136795 A F009 05712108 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:36 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  139830 A F004 05714132 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:37 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  141098 A F004 05715392 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:38 3: TSCUL_ParseTsHM: CUL5 HM CCA channel busy error to 3FC88B/roll_kitchen:  142354 A F004 05716652 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  128534                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:39 3: LogHist CUL5:  129588 A F004 05703880 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  130835 A F004 05705140 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  132098 A F004 05706400 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  132337 A F009 05707660 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:39 3: LogHist CUL5:  132983                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:39 3: LogHist CUL5:  134031 A F004 05708328 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  135293 A F004 05709588 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  136554 A F004 05710848 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  136795 A F009 05712108 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
2018.11.26 11:30:39 3: LogHist CUL5:  138786                 As 0B F1 A011 ABCDEF 3FC88B 0301
2018.11.26 11:30:39 3: LogHist CUL5:  139830 A F004 05714132 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  141098 A F004 05715392 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: LogHist CUL5:  142354 A F004 05716652 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
2018.11.26 11:30:39 3: TSCUL_ParseTsHM: CUL5 HM repeat failed to 3FC88B/roll_kitchen:  142594 A F009 05717912 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw


list CUL5

Code Auswählen Erweitern


Internals:
   CMDS       ABCEFGJKMNRUVWXYZeilmtx
   CUL5_MSGCNT 648
   CUL5_TIME  2018-11-26 11:00:21
   Clients    STACKABLETS:STACKABLE:CUL_HM:CUL_IR:HMS
   DEF        192.168.0.205:5555 5555
   DeviceName 192.168.0.205:5555
   FD         25
   FHTID      5555
   NAME       CUL5
   NR         791
   PARTIAL   
   RAWMSG     A0C2984703EF2D600000000DF2E::-66:CUL5:
   RSSI       -66
   STATE      Initialized
   TYPE       TSCUL
   VERSION    VTS 0.29 CSM868
   VERSION_HW nanoCUL_V1.x
   VERSION_TS yes AES ChTblSize:220
   XmitOpen   1
   assignUpdCntI 5
   assignedIDsCnt 3
   initString X21
Ar
AM5
AHABCDEF
   owner_CCU  VCCU
   MatchList:
     1:STACKABLETS ^\*
     2:STACKABLE ^\*
     A:CUL_HM   ^A....................
     B:CUL_IR   ^I............
     C:HMS      ^810e04......a001
   READINGS:
     2018-11-26 09:55:45   Xmit-Events     non-HM:1 init:1 disconnected:1 ok:1
     2017-07-29 21:23:58   ccconf          freq:868.300MHz bWidth:325KHz rAmpl:42dB sens:8dB
     2018-11-26 09:55:25   cmds             A B C E F G J K M N R U V W X Y Z e i l m t x
     2018-11-26 09:55:45   cond            ok
     2018-11-26 09:55:20   prot_disconnected last
     2018-11-26 09:55:27   prot_init       last
     2018-11-26 09:55:27   prot_non-HM     last
     2018-11-26 09:55:45   prot_ok         last
     2018-11-26 11:21:55   scF             0.999804466406144
     2018-11-26 09:55:27   state           Initialized
     2018-10-22 23:46:20   uptime          0 15:15:03
     2018-11-26 10:12:38   version         VTS 0.29 CSM868
   helper:
     CUrun      1
     ChkPart    0
     RA_Timeout 0
     VTS        1
     VTS_ACK    1
     VTS_AES    1
     assIdCnt   3
     assIdRep   3
     hmTSAt1Add
     recd       0
     tbuf       
     DEVIO:
       RXfailTO   
     HM:
       ChTblSize  220
       FUP        0
       HMactive   1
       hmCrdts    0
       hmSbusy    0
       ChTbl:
         3FC88B3F   01
         44BC9501   01
         5164753F   01
       msgCNT:
         0x01       633
         0x02       76
         0x03       29
         0x04       12
         0x09       6
         0x0C       7
         0x0E       4
         0x12       1
       unknwn:
     cnd:
       0          1
       250        1
       253        1
       255        1
     hmLogHist:
        130835 A F004 05705140 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        132098 A F004 05706400 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        132337 A F009 05707660 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
        132983                 As 0B F1 A011 ABCDEF 3FC88B 0301
        134031 A F004 05708328 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        135293 A F004 05709588 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        136554 A F004 05710848 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        136795 A F009 05712108 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
        138786                 As 0B F1 A011 ABCDEF 3FC88B 0301
        139830 A F004 05714132 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        141098 A F004 05715392 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        142354 A F004 05716652 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail
        142594 A F009 05717912 00 0B F1 A011 ABCDEF 3FC88B 0301 _sfail _noAnsw
        018109 A F002 06117792 00 01 CC _ping
     hmQ:
       3FC88B:
       44BC95:
       516475:
     ids:
       3FC88B:
         cfg        +3FC88B,00,01,00
         name       roll_kitchen
       44BC95:
         cfg        +44BC95,01,01,02
         name       door_base
       516475:
         cfg        +516475,00,01,00
         name       motion_base
     q:
       ATrNo      0
       HMcndN     0
       InQueues   0
       XRpCnt     0
       XRpTm      1543222546.70196
       answerPend 0
       hmLanQlen  1
       apIDs:
         3FC88B     0
       cap:
         sum        33750
     ref:
       Sdly       0
       ioByteRate 1000000
       ioByteRateMeas 3621.99548418276
       lHMt       6117792
       lSys       261637821
       pTTu       1024
       pndAs      0
       pndCUAp    0
       pngLm      19
       pngMax     1177
       pngMaxTot  1177
       pngMin     11
       pngRef     17
       pngtm      260714800
       scErr      1.26550682727247
       scF        0.999804466406144
       scFN       2
       scHT       4170416
       scST       259690816
Attributes:
   hmId       ABCDEF
   hmLanQlen  1_min
   icon       cul_cul
   rfmode     HomeMatic

list roll_kitchen

Code Auswählen Erweitern


Internals:
   CUL1_MSGCNT 5
   CUL1_RAWMSG A0EF080023FC88BABCDEF0101C80059::-63:CUL1:
   CUL1_RSSI  -63
   CUL1_TIME  2018-11-26 10:15:45
   CUL3_MSGCNT 5
   CUL3_RAWMSG A0EF080023FC88BABCDEF0101C80059::-82:CUL3:
   CUL3_RSSI  -82
   CUL3_TIME  2018-11-26 10:15:45
   CUL5_MSGCNT 5
   CUL5_RAWMSG A0EF080023FC88BABCDEF0101C80059::-68.5:CUL5:
   CUL5_RSSI  -68.5
   CUL5_TIME  2018-11-26 10:15:45
   DEF        3FC88B
   IODev      CUL5
   LASTInputDev CUL1
   MSGCNT     15
   NAME       roll_kitchen
   NOTIFYDEV  global
   NR         772
   NTFY_ORDER 50-roll_kitchen
   STATE      MISSING ACK
   TYPE       CUL_HM
   lastMsg    No:F0 - t:02 s:3FC88B d:ABCDEF 0101C80059
   protCmdDel 1
   protLastRcv 2018-11-26 10:15:45
   protRcv    5 last_at:2018-11-26 10:15:45
   protResnd  3 last_at:2018-11-26 11:30:35
   protResndFail 1 last_at:2018-11-26 11:30:39
   protSnd    7 last_at:2018-11-26 11:30:19
   protState  CMDs_done_Errors:1
   rssi_CUL5  cnt:4 min:-89 max:-89 avg:-89 lst:-89
   rssi_at_CUL1 cnt:5 min:-65 max:-62.5 avg:-63.2 lst:-63
   rssi_at_CUL3 cnt:5 min:-85.5 max:-80 avg:-82.2 lst:-82
   rssi_at_CUL5 cnt:5 min:-73 max:-67 avg:-69.09 lst:-68.5
   READINGS:
     2018-11-26 10:15:45   CommandAccepted yes
     2017-07-17 16:36:02   D-firmware      2.8
     2017-07-17 16:36:02   D-serialNr      MEQ1106629
     2018-01-09 20:32:06   PairedTo        0xABCDEF
     2018-01-09 20:32:12   R-driveDown     27 s
     2017-07-17 16:39:37   R-driveTurn     0.5 s
     2018-01-09 20:32:12   R-driveUp       27 s
     2017-07-17 16:39:36   R-pairCentral   0xABCDEF
     2017-07-17 16:39:37   R-powerUpAction off
     2017-07-17 16:39:37   R-sign          off
     2018-01-09 20:32:06   RegL_00.        02:01 0A:E4 0B:73 0C:09 15:FF 18:00 00:00
     2018-01-09 20:32:11   RegL_01.        08:00 09:00 0A:00 0B:01 0C:0E 0D:01 0E:0E 0F:05 10:00  30:06 57:24 56:00 00:00
     2018-11-26 10:15:45   deviceMsg       on (to VCCU)
     2018-11-26 10:15:45   level           100
     2018-11-26 10:15:45   motor           stop:on
     2018-11-26 10:15:45   pct             100
     2017-07-17 16:39:05   powerOn         2017-07-17 16:39:04
     2018-11-26 10:15:45   recentStateType ack
     2018-11-26 11:30:39   state           MISSING ACK
     2018-11-26 10:15:45   timedOn         off
   helper:
     HM_CMDNR   241
     cSnd       11ABCDEF3FC88B0301,11ABCDEF3FC88B0301
     dlvlCmd    ++A011ABCDEF3FC88B0201C80000
     mId        006A
     regLst     ,0,1,3p
     rxType     1
     supp_Pair_Rep 0
     ack:
     dir:
       cur        stop
       rct        up
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       lstRecType 02
       newChn     +3FC88B,00,01,00
       nextSend   1543223745.58339
       nxtSndMcnt F0
       rxt        0
       tgtDly     88
       vccu       VCCU
       lRcTm:
         CUL1       1247948
         CUL3       1232312
         CUL5       1223436
         tnms       256744407
       p:
         3FC88B
         00
         01
         00
       prefIO:
         CUL5
     mRssi:
       mNo        F0
       io:
         CUL1:
           -63
           -63
         CUL3:
           -82
           -82
         CUL5:
           -58.5
           -58.5
     prt:
       bErr       0
       sProc      0
     q:
       qReqConf   
       qReqStat   
     role:
       chn        1
       dev        1
       prs        1
     rssi:
       CUL5:
         avg        -89
         cnt        4
         lst        -89
         max        -89
         min        -89
       at_CUL1:
         avg        -63.2
         cnt        5
         lst        -63
         max        -62.5
         min        -65
       at_CUL3:
         avg        -82.2
         cnt        5
         lst        -82
         max        -80
         min        -85.5
       at_CUL5:
         avg        -69.1
         cnt        5
         lst        -68.5
         max        -67
         min        -73
     tmpl:
Attributes:
   IODev      CUL5
   IOgrp      VCCU:CUL5
   autoReadReg 4_reqStatus
   devStateIcon up:fts_shutter_10@green down:fts_shutter_100@black 9\d.*:fts_shutter_10 8\d.*:fts_shutter_20 7\d.*:fts_shutter_30 6\d.*:fts_shutter_40 5\d.*:fts_shutter_50 4\d.*:fts_shutter_60 3\d.*:fts_shutter_70 2\d.*:fts_shutter_80 1\d.*:fts_shutter_90 0\d.*:fts_shutter_100
   eventMap   on:up off:down stop:stop
   expert     2_raw
   firmware   2.8
   model      HM-LC-Bl1PBU-FM
   peerIDs    00000000,
   room       CUL_HM,roll
   serialNr   MEQ1106629
   subType    blindActuator
   webCmd     stop:up:90:80:70:60:50:40:30:20:10:down

log nach einem Reopen:

Code Auswählen Erweitern


2018.11.26 11:41:46 0: TSCUL_Parse: CUL5 External Reset Restart detected: C_RE
2018.11.26 11:41:46 1: TSCUL_Parse: CUL5 Restart detected: C_ReadyCSM868
2018.11.26 11:41:50 3: CUL5: Possible commands: ABCEFGJKMNRUVWXYZeilmtx
2018.11.26 11:41:50 1: CUL5 is VERSION_TS, VTS 0.29 CSM868, nanoCUL_V1.x
2018.11.26 11:41:51 2: TSCUL_condUpdateHM: CUL5 new condition init
2018.11.26 11:41:51 1: 192.168.0.205:5555 reappeared (CUL5)
2018.11.26 11:41:53 2: TSCUL_condUpdateHM: CUL5 new condition ok
2018.11.26 11:42:00 3: CUL_HM set roll_kitchen stop

[noansi]

Hallo Presskopf,

CUL5 HM CCA channel busy error

besagt, dass der nano meint, der Kanal sei belegt. Sprich er empfängt etwas auf der 868.3MHz Frequenz und sendet daher nicht.

Hast Du ein elektrisches/elektronisches Gerät in der Nähe des nano neu aufgebaut, was zu Störstrahlung führen könnte?
Wie alt ist das Netzteil, über den der nano (mit) versorgt wird. Sterbende oder schlechte Schaltnetzteile können auch tolle Effekt machen.

Spinnt eventuell ein auf 868MHz sendendes device in dem Hausbereich und sendet ständig (hatten wir vor einiger Zeit mal mit einem HM device und hatte ich mal mit einem SlowRF Sensor mit leer werdender Batterie)?

Du kannst ja mal CUL5 gegen CUL3 tauschen und schauen, ob das Problem mit wandert oder ob es am gleichen Ort bleibt.
Wenn es mit wandert, dann hätte der eher nano einen weg.
Wenn es am gleich Ort bleibt, dann musst Du vor Ort, respektive in dem Hausbereich nach dem Problem suchen. Ganz blöd, wenn es vom Nachbarn käme.

Gruß, Ansgar.

PS: Dein ccconf ist veraltet und enspricht nicht HM Betrieb. Den solltest Du mal neu abholen, bevor Du es in ein list packst.

[presskopf]

Hast Du ein elektrisches/elektronisches Gerät in der Nähe des nano neu aufgebaut, was zu Störstrahlung führen könnte?
Wie alt ist das Netzteil, über den der nano (mit) versorgt wird. Sterbende oder schlechte Schaltnetzteile können auch tolle Effekt machen.

Hallo Ansgar,

Danke für die Tipps.
Ich habe mit dem Einfachsten angefangen, dem Netzteil. Der Nanocul lag in der Tat relativ nahe am (originalen) Raspberry-Netzteil.
Mit einem längeren Kabel (1m) zeigt sich, dass es offenbar keinen Absturz mehr gibt (bis jetzt). Zumindest ist der CUL auch nach > 15 Stunden noch einsatzbereit.
Argh.....
Nachtrag 02.01.2019 - keine Probleme bis dato

Dennoch verbleiben Logeinträge, die mich stutzig machen. Hier scheint nun mein Türsensor door_main eine Rolle zu spielen, auch wenn er bisher ohne Anstand  funktioniert.

Code Auswählen Erweitern


2018.11.27 11:22:16 3: TSCUL_ParseTsHM: CUL5 HM message cleared while waiting for send 44BC98/door_main:  056371 A F104 09790284 00 00 F3 A002 ABCDEF 44BC98 04AB6836F8052B02
2018.11.27 11:22:17 3: TSCUL_ParseTsHM: CUL5 HM message cleared while waiting for send 44BC98/door_main:  057490 A F104 09791396 00 00 F4 A002 ABCDEF 44BC98 04B693E0D58CBC02
2018.11.27 11:22:21 3: TSCUL_ParseTsHM: CUL5 HM message cleared while waiting for send 44BC98/door_main:  061661 A F104 09795568 00 00 F5 A002 ABCDEF 44BC98 04DE2B699C618602
2018.11.27 11:22:22 3: TSCUL_ParseTsHM: CUL1 HM message cleared while waiting for send 44BC98/door_main:  062468 A F104 03128572 00 00 F6 A002 ABCDEF 44BC98 043CC18BC1606A02
2018.11.27 11:22:23 3: TSCUL_ParseTsHM: CUL1 HM message cleared while waiting for send 44BC98/door_main:  063521 A F104 03129628 00 00 F7 A002 ABCDEF 44BC98 04069C97F41E7002

Viele Grüße
Matthias

PS Ich mag den Thread hier nicht mit dem Thema zuhauen, falls es gar nichts mit TSCUL zu tun hat. Das kann ich aber nicht 100% einschätzen; daher bitte Bescheid geben und ich mache ein eigenes Topic auf.


list door_main

Code Auswählen Erweitern


Internals:
   CUL1_MSGCNT 263
   CUL1_RAWMSG A19FDA60344BC98ABCDEFE1E916709750D64EB09D4E47FFC239E4::-72.5:CUL1:
   CUL1_RSSI  -72.5
   CUL1_TIME  2018-11-27 14:23:20
   CUL3_MSGCNT 126
   CUL3_RAWMSG A19FDA60344BC98ABCDEFE1E916709750D64EB09D4E47FFC239E4::-74:CUL3:
   CUL3_RSSI  -74
   CUL3_TIME  2018-11-27 14:23:20
   CUL5_MSGCNT 252
   CUL5_RAWMSG A0DFDA61044BC98ABCDEF06010000:AESCom-ok:-64.5:CUL5:59DFEF62
   CUL5_RSSI  -64.5
   CUL5_TIME  2018-11-27 14:23:20
   DEF        44BC98
   IODev      CUL5
   LASTInputDev CUL5
   MSGCNT     641
   NAME       door_main
   NOTIFYDEV  global
   NR         714
   NTFY_ORDER 50-door_main
   STATE      closed
   TYPE       CUL_HM
   lastMsg    No:FD - t:10 s:44BC98 d:ABCDEF 06010000
   protCmdDel 3
   protEvt_AESCom-ok 55 last_at:2018-11-27 14:23:20
   protLastRcv 2018-11-27 14:23:20
   protNack   4 last_at:2018-11-27 08:45:39
   protRcv    93 last_at:2018-11-27 14:23:20
   protSnd    88 last_at:2018-11-27 14:23:20
   protState  CMDs_done
   rssi_at_CUL1 cnt:135 min:-85.5 max:-64.5 avg:-72.15 lst:-72.5
   rssi_at_CUL3 cnt:126 min:-85.5 max:-66.5 avg:-71.24 lst:-74
   rssi_at_CUL5 cnt:127 min:-77 max:-59 avg:-64.48 lst:-64.5
   READINGS:
     2018-11-27 14:30:51   Activity        alive
     2018-11-27 11:20:52   CommandAccepted yes
     2018-11-27 11:20:50   D-firmware      1.0
     2018-11-27 11:20:50   D-serialNr      NEQ0096313
     2018-11-27 08:45:38   PairedTo        0xABCDEF
     2016-12-16 22:38:09   R-cyclicInfoMsg on
     2016-12-16 22:38:30   R-eventDlyTime  0 s
     2018-11-27 11:20:50   R-pairCentral   set_0xABCDEF
     2016-12-16 22:38:09   R-sabotageMsg   on
     2016-12-16 22:38:30   R-sign          on
     2018-11-27 08:45:38   RegL_01.          08:01 20:9C 21:00 30:06 00:00
     2018-11-27 14:23:20   aesCommToDev    ok
     2018-11-27 14:23:20   aesKeyNbr       02
     2018-11-27 12:49:41   aesReqTo        VCCU
     2018-11-27 14:23:20   alive           yes
     2018-11-27 14:23:20   battery         ok
     2018-11-27 14:23:20   contact         closed (to VCCU)
     2018-11-12 22:57:12   powerOn         2018-11-12 22:57:12
     2018-11-27 14:23:20   recentStateType info
     2018-11-27 14:23:20   sabotageError   off
     2018-11-27 14:23:20   state           closed
     2017-02-19 19:09:33   trigDst_VCCU    noConfig
     2016-12-16 22:34:52   trigDst_broadcast noConfig
     2018-11-27 12:49:41   trig_aes_VCCU   ok:133
     2018-11-27 12:49:41   trigger_cnt     133
   helper:
     HM_CMDNR   253
     cSnd       01ABCDEF44BC98000802010AE40B730C09,01ABCDEF44BC980006
     getCfgList all
     getCfgListNo ,4
     mId        00C7
     regLst     ,0,1,4p
     rxType     28
     supp_Pair_Rep 0
     ack:
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       lstRecType 10
       newChn     +44BC98,01,01,02
       nextSend   1543325000.77306
       nxtSndMcnt FD
       rxt        2
       tgtDly     88
       vccu       VCCU
       lRcTm:
         CUL1       64330364
         CUL3       64282504
         CUL5       54211604
         tnms       357999620
       lastAESReq:
         auth       59DFEF62
         authAck    As0EFD8002ABCDEF44BC980059DFEF62
         cntl       166
         data       010000
         lStm       1543325000.71691
         len        0D
         mcnt       FD
         subtp      06
         type       10
       p:
         44BC98
         01
         01
         02
       prefIO:
         CUL5
     mRssi:
       mNo        FD
       io:
         CUL1:
           -72.5
           -72.5
         CUL3:
           -74
           -74
         CUL5:
           -54.5
           -54.5
     prt:
       bErr       0
       sProc      0
       sleeping   1
       try        1
       rspWait:
     q:
       qReqConf   00
       qReqStat   
     role:
       chn        1
       dev        1
     rpt:
       IO         CUL5
       flg        A
       ts         1543325000.71209
       ack:
         HASH(0x2ac0f50)
         FD8002ABCDEF44BC9800
     rssi:
       at_CUL1:
         avg        -72.1592592592593
         cnt        135
         lst        -72.5
         max        -64.5
         min        -85.5
       at_CUL3:
         avg        -71.2420634920635
         cnt        126
         lst        -74
         max        -66.5
         min        -85.5
       at_CUL5:
         avg        -64.4803149606299
         cnt        127
         lst        -64.5
         max        -59
         min        -77
     shadowReg:
       RegL_00.    02:01 0A:E4 0B:73 0C:09
     tmpl:
   role:
Attributes:
   IODev      CUL5
   IOgrp      VCCU:CUL5
   actCycle   000:50
   actStatus  alive
   aesCommReq 1
   autoReadReg 4_reqStatus
   expert     2_full
   firmware   1.0
   model      HM-SEC-SCo
   peerIDs   
   room       CUL_HM
   serialNr   NEQ0096313
   subType    threeStateSensor

[noansi]

Hallo Matthias,

Der Nanocul lag in der Tat relativ nahe am (originalen) Raspberry-Netzteil.

Schön, wenn es so einfach gewesen wäre.
Wenn es lange Zeit in der alten unveränderten Lage problemlos funktioniert hat und das Problem erst jetzt aufgetreten ist, dann würde ich mir jetzt schon ein Reservenetzteil zulegen. 

message cleared while waiting for send

Das ist eine speziele Timoutmeldung für ein Abbrechen eines Sendeversuchs, wenn während des Wartens auf Kanalzugriff die Sendemessage wegen Timeout gelöscht wurde.

Jede Sendenachricht bekommt in der Firmware einen Timeout "aufgedrückt", um nicht beliebig lange und unsinnig zu versuchen diese auch zu senden und damit auch für eine lange Wartezeit einen der raren Sendepuffer zu belegen. Es gibt normalerweise nur ein relativ enges Zeitfenster für Antworten, danach wird ein Sendeversuch in der Regel sinnlos.

In dem speziell Log Fall versuchte die Firmware das device zum Signieren der Nachricht zu bewegen, aber konnte die Nachricht nicht rechtzeitig absetzen, als dass erwartet werden könnte, dass das device auch noch "wach" sein dürfte.
Das passiert in der Regel, wenn gleichzeigtig zum Warten auf Senden noch eine andere Nachricht eines anderen devices empfangen wird oder die Kommunikation zu einem anderen device früher angefangen wurde und zuerst abgearbeitet wird.

Ob die Nachricht doch noch richtig signiert empfangen werden kann hängt dann von der Anzahl der Wiederholversuche des devices ab. Würde es seine Nachricht nur einmal senden, dann käme sie nicht bei FHEM an. Wiederholt es, dann klappt es meist bei einem der weiteren Versuche.

Da Deine Log Einträge dicht beieinander liegen, würde ich mal interpretieren, dass erst der 6. Versuch erfolgreich war. Ansonsten müsstes Du das Fenster/die Tür relativ schnell hintereinander geöffnet und geschlossen haben.
Das würde weiterhin bedeuten, dass recht viele devices zur nahezu gleichen Zeit dazwischen gefunkt haben oder FHEM einige HM Kommandos abgesetzt hat.
Genauer ließe es sich nur mit mehr verbose (4) interpretieren.

Was noch passiert ist, dass vom 3. auf den 4. Eintrag das IO Device von CUL5 nach CUL1 gewechselt wurde. Der RSSI abhängige IO Devicewechsel hat also offenbar funktioniert.

Gruß, Ansgar.

[klausw]

Hallo Ansgar,

Dein Modul nutze ich nun schon eine Weile und bin sehr zufrieden damit.
Nur hat mein nanoCUL ein Problem nach dem start/neustart des Raspberry2.
Er wird einfach nicht erkannt (das hat nichts mit Deinem Modul zu tun).
Ein abziehen/anstecken des CUL reicht, und er taucht wieder als USB Device auf.
Alternativ (mein Pi läuft in 300km Entfernung) kann man mit

Code Auswählen Erweitern

/bin/echo '1-1' | /usr/bin/tee /sys/bus/usb/drivers/usb/unbind
#kleine pause
/bin/echo '1-1' | /usr/bin/tee /sys/bus/usb/drivers/usb/bind
Den gesamten USB zurücksetzen, was den CUL auch zurückbringt.
Damit wird aber auch die LAN Verbindung gekappt (das bind müsste, wenn das ganze auch über SSH funktionieren soll, z.B. über ein cron Job gemacht werden)

Nun meine Frage zu Deinem TSCUL Modul:
Nach jedem (zumeist ungewollten) Neustart des Raspberry bekomme ich folgende Meldung:

Code Auswählen Erweitern

Messages collected while initializing FHEM:
configfile: ASKSIN not supported
ASKSIN not supported
CUL1: Mode HomeMatic not supported, wrong firmware?!?

Autosave deactivated
und

Code Auswählen Erweitern

attr CUL1 rfmode HomeMatic wurde dabei gelöscht.

Jedes mal wenn TSCUL keinen CUL findet verschwindet das Attribut.
Spricht etwas dagegen, diesen Automatismus zu entfernen?

Grüße
Klaus

PS: muss die Datei 10_CUL_HM.pm derzeit noch in "exclude_from_update" geführt werden?

[noansi]

Hallo Klaus,

Ein abziehen/anstecken des CUL reicht, und er taucht wieder als USB Device auf.

Hast Du mal mit dmsg geschaut, ob er wirklich nicht erkannt wird, oder ob er nur einer anderen Schnittstelle zugewiesen wird (mein Raspi macht so was jedenfalls, wenn 99-usb-serial.rules nicht genutzt wird, da er die USB Port Numerierung beim Reboot anders handhabt, als beim ColdBoot)?

Im letzteren Fall wäre dann die Frage, ob der nano eine eindeutige Seriennummer hat und somit per 99-usb-serial.rules zu seiner Schnittstelle gezwungen werden kann.

Nach jedem (zumeist ungewollten) Neustart des Raspberry bekomme ich folgende Meldung

Das liegt dann schlicht daran, dass der nano nicht in seinen Möglichkeiten erkannt und initialisiert werden kann.

Da beim Setzen des rfmode Attributs dann die letzte Meldung als Fehlermeldung zurückgegeben wird, wird auch das Attribut nicht von fhem gesetzt.

In Deinem Fall natürlich blöd. Normalerweise, wenn die Funktionalität nicht in die Firmware compiliert wurde, jedoch grundsätzlich nützlich.

Ich überleg mal, ob mir dazu was sinnvolles einfällt.

muss die Datei 10_CUL_HM.pm derzeit noch in "exclude_from_update" geführt werden?

In MultiIO Umgebung zu Verringerung von IO-Wechseln bei CULs mit wenig Speicher (device Zordnung wird dann im EEPROM gespeichet), empfehle ich mal ja. Auf den EEPROM Verschleiß nimmt die reguläre 10_CUL_HM.pm von Martin keine Rücksicht.
Meine Variante ist jedoch nicht auf Martins aktuellem Stand, was seine funktionalen Änderungen/Ergänzungen angeht.
Grundsätzlich sollte es jedoch mit Martins regulärer Version auch funktionieren, so dass der "exclude_from_update" nicht zwingend ist.
Ich habe es jedoch selbst nicht getestet. Teste und berichte. 

Gruß, Ansgar.

[klausw]

Hallo Ansgar,

Hast Du mal mit dmsg geschaut, ob er wirklich nicht erkannt wird, oder ob er nur einer anderen Schnittstelle zugewiesen wird (mein Raspi macht so was jedenfalls, wenn 99-usb-serial.rules nicht genutzt wird, da er die USB Port Numerierung beim Reboot anders handhabt, als beim ColdBoot)?

Der nanoCUL wird wirklich nicht erkannt.
Ich nutze sowieso /dev/serial/by-id/... daher ist mir die Schnittstellennummer selbst egal.

Code Auswählen Erweitern

user@pi:~ $ dmesg | grep USB
[    0.823068] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    0.829609] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    0.831217] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.838395] hub 1-0:1.0: USB hub found
[    0.864238] usbhid: USB HID core driver
[    1.260501] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    1.490855] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    1.492707] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    1.495519] hub 1-1:1.0: USB hub found
[    1.820512] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    1.950899] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    1.952746] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.046087] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:ab:aa:65
[    2.140555] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
[    2.295380] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015
[    2.297325] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.410546] usb 1-1.3: new full-speed USB device number 5 using dwc_otg
[    2.960553] usb 1-1.3: new full-speed USB device number 6 using dwc_otg
[    3.510592] usb 1-1.3: new full-speed USB device number 7 using dwc_otg
[    4.050615] usb 1-1.3: new full-speed USB device number 8 using dwc_otg
[    4.490884] usb 1-1-port3: unable to enumerate USB device
[    4.800540] usb 1-1.4: new full-speed USB device number 9 using dwc_otg
[    4.933854] usb 1-1.4: New USB device found, idVendor=0658, idProduct=0200
[    4.933869] usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    4.961818] cdc_acm 1-1.4:1.0: ttyACM0: USB ACM device
[    4.962717] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[    5.030533] usb 1-1.5: new full-speed USB device number 10 using dwc_otg
[    5.176568] usbserial: USB Serial support registered for generic
[    5.189671] usb 1-1.5: New USB device found, idVendor=0403, idProduct=6001
[    5.189692] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    5.189700] usb 1-1.5: Product: DuoFern USB-Stick
[    5.190199] usbserial: USB Serial support registered for FTDI USB Serial Device
[    5.193115] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected
[    5.194969] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0
[    5.198478] ftdi_sio 1-1.5:1.0: FTDI USB Serial Device converter detected
[    5.203157] usb 1-1.5: FTDI USB Serial Device converter now attached to ttyUSB1
user@pi:~ $ lsusb
Bus 001 Device 010: ID 0403:6001 Future Technology Devices International, Ltd FT232 USB-Serial (UART) IC
Bus 001 Device 009: ID 0658:0200 Sigma Designs, Inc.
Bus 001 Device 004: ID 0403:6015 Future Technology Devices International, Ltd Bridge(I2C/SPI/UART/FIFO)
Bus 001 Device 003: ID 0424:ec00 Standard Microsystems Corp. SMSC9512/9514 Fast Ethernet Adapter
Bus 001 Device 002: ID 0424:9514 Standard Microsystems Corp.
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
user@pi:~ $ ls -l /dev/serial/by-id/
insgesamt 0
lrwxrwxrwx 1 root root 13 Dez 11 09:17 usb-0658_0200-if00 -> ../../ttyACM0
lrwxrwxrwx 1 root root 13 Dez 11 09:17 usb-FTDI_UMFT230XB_FTWJO8UB-if00-port0 -> ../../ttyUSB0
lrwxrwxrwx 1 root root 13 Dez 11 09:17 usb-Rademacher_DuoFern_USB-Stick_WR01E1RT-if00-port0 -> ../../ttyUSB1

-------------------------

/bin/echo '1-1' | /usr/bin/tee /sys/bus/usb/drivers/usb/unbind
#kleine pause
/bin/echo '1-1' | /usr/bin/tee /sys/bus/usb/drivers/usb/bind

-------------------------

user@pi:~ $ ls -l /dev/serial/by-id/
insgesamt 0
lrwxrwxrwx 1 root root 13 Dez 11 10:23 usb-0658_0200-if00 -> ../../ttyACM0
lrwxrwxrwx 1 root root 13 Dez 11 10:23 usb-FTDI_FT232R_USB_UART_SUB02-if00-port0 -> ../../ttyUSB1
lrwxrwxrwx 1 root root 13 Dez 11 10:23 usb-FTDI_UMFT230XB_FTWJO8UB-if00-port0 -> ../../ttyUSB0
lrwxrwxrwx 1 root root 13 Dez 11 10:23 usb-Rademacher_DuoFern_USB-Stick_WR01E1RT-if00-port0 -> ../../ttyUSB2
user@pi:~ $ lsusb
Bus 001 Device 016: ID 0403:6001 Future Technology Devices International, Ltd FT232 USB-Serial (UART) IC
Bus 001 Device 017: ID 0658:0200 Sigma Designs, Inc.
Bus 001 Device 013: ID 0403:6001 Future Technology Devices International, Ltd FT232 USB-Serial (UART) IC
Bus 001 Device 012: ID 0403:6015 Future Technology Devices International, Ltd Bridge(I2C/SPI/UART/FIFO)
Bus 001 Device 011: ID 0424:ec00 Standard Microsystems Corp. SMSC9512/9514 Fast Ethernet Adapter
Bus 001 Device 002: ID 0424:9514 Standard Microsystems Corp.
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
user@pi:~ $ dmesg | grep USB
...
[  928.418055] usb 1-1.1: USB disconnect, device number 3
[  928.418748] smsc95xx 1-1.1:1.0 eth0: unregister 'smsc95xx' usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet
[  928.496476] usb 1-1.2: USB disconnect, device number 4
[  928.496825] ftdi_sio ttyUSB0: error from flowcontrol urb
[  928.497299] ftdi_sio ttyUSB0: FTDI USB Serial Device converter now disconnected from ttyUSB0
[  928.498232] usb 1-1.4: USB disconnect, device number 9
[  928.500038] usb 1-1.5: USB disconnect, device number 10
[  928.500555] ftdi_sio ttyUSB1: error from flowcontrol urb
[  928.501073] ftdi_sio ttyUSB1: FTDI USB Serial Device converter now disconnected from ttyUSB1
[  979.237544] hub 1-1:1.0: USB hub found
[  979.555733] usb 1-1.1: new high-speed USB device number 11 using dwc_otg
[  979.686083] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[  979.686104] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[  979.781472] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:ab:aa:65
[  979.885737] usb 1-1.2: new full-speed USB device number 12 using dwc_otg
[  980.041734] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015
[  980.041754] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  980.049262] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected
[  980.050926] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0
[  980.145725] usb 1-1.3: new full-speed USB device number 13 using dwc_otg
[  980.301859] usb 1-1.3: New USB device found, idVendor=0403, idProduct=6001
[  980.301880] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  980.301890] usb 1-1.3: Product: FT232R USB UART
[  980.310875] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[  980.312270] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB1
[  980.405736] usb 1-1.4: new full-speed USB device number 14 using dwc_otg
[  980.955751] usb 1-1.4: new full-speed USB device number 15 using dwc_otg
[  981.085741] usb 1-1.5: new full-speed USB device number 16 using dwc_otg
[  981.244606] usb 1-1.5: New USB device found, idVendor=0403, idProduct=6001
[  981.244628] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  981.244639] usb 1-1.5: Product: DuoFern USB-Stick
[  981.253583] ftdi_sio 1-1.5:1.0: FTDI USB Serial Device converter detected
[  981.254989] usb 1-1.5: FTDI USB Serial Device converter now attached to ttyUSB2
[  981.565743] usb 1-1.4: new full-speed USB device number 17 using dwc_otg
[  981.709020] usb 1-1.4: New USB device found, idVendor=0658, idProduct=0200
[  981.709040] usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[  981.710554] cdc_acm 1-1.4:1.0: ttyACM0: USB ACM device


Das liegt dann schlicht daran, dass der nano nicht in seinen Möglichkeiten erkannt und initialisiert werden kann.
Da beim Setzen des rfmode Attributs dann die letzte Meldung als Fehlermeldung zurückgegeben wird, wird auch das Attribut nicht von fhem gesetzt.
In Deinem Fall natürlich blöd. Normalerweise, wenn die Funktionalität nicht in die Firmware compiliert wurde, jedoch grundsätzlich nützlich.
Ich überleg mal, ob mir dazu was sinnvolles einfällt.

Wäre super.
Wäre es nicht sowieso sinnvoller die Attribute nur zu setzen, wenn der CUL auch online ist.
Solange keine Verbindung besteht macht es in meinen Augen keinen Sinn Einstellungen zu übertragen.

In MultiIO Umgebung zu Verringerung von IO-Wechseln bei CULs mit wenig Speicher (device Zordnung wird dann im EEPROM gespeichet), empfehle ich mal ja. Auf den EEPROM Verschleiß nimmt die reguläre 10_CUL_HM.pm von Martin keine Rücksicht.
Meine Variante ist jedoch nicht auf Martins aktuellem Stand, was seine funktionalen Änderungen/Ergänzungen angeht.
Grundsätzlich sollte es jedoch mit Martins regulärer Version auch funktionieren, so dass der "exclude_from_update" nicht zwingend ist.
Ich habe es jedoch selbst nicht getestet. Teste und berichte. 

Ich komme derzeit mit einem CUL durch das ganze Haus. Daher sollte das mit dem EEPROM kein Problem sein.
Ich werde es mal testen ... aber erst wenn ich vor Ort bin ... die Heizung muss ich noch schalten können

Grüße
Klaus

[noansi]

Hallo Klaus,

Wäre es nicht sowieso sinnvoller die Attribute nur zu setzen, wenn der CUL auch online ist.
Solange keine Verbindung besteht macht es in meinen Augen keinen Sinn Einstellungen zu übertragen.

Das ist ja gerade das Problem.

Bei der FHEM Initialisierung werden erst die defines durchgearbeitet und dann erst die (FHEM-) Attribute gesetzt.

Beim define wird das CUL bezüglich seiner Fähigkeiten abgefragt und erst mal in den default SlowRF Modus initialisiert.
Wird dann das Attribut "rmode" gesetzt, stehen die Informationen zu den "Fähigkeiten" zur Verfügung, sofern das CUL zum define Zeitpunkt angeschlossen und nutzbar ist.

Wenn es HomeMatic nicht kann, dann macht auch rfmode HomeMatic, hmId etc. keinen Sinn und es wird ein Fehler zurück geliefert (entsprechend Deinem Log), was zur Folge hat, dass diese attribute nicht gesetzt werden. Die sekundäre Folge ist dann dass keine Einstellungen an das nicht erreichbare CUL übertragen werden.

Die Readings werden erst nach dem Durchackern der fhem.cfg gesetzt, so dass auch der letzte Zustand zu diesem Zeitpunkt noch nicht verfügbar ist.

Gruß, Ansgar.

[noansi]

Hallo Klaus,

versuch es mal mit der angehängten Version von 00_TSCUL.pm.
Wenn die Schnittstelle zum device beim fhem Neustart nicht geöffnet werden kann, dann werden die hm relevanten Attribute damit trotzdem gesetzt.
Bitte gib mir Feedback ob es so problemlos funktioniert.

Ich hoffe, das hilft Dir bei Deinem Problem.
Dein USB Problem musst Du aber unabhängig davon angehen.

Gruß, Ansgar.

[klausw]

Das ging ja schnell.
Ich werde es testen sobald ich vor Ort bin. Das wird Mitte kommender Woche sein.
Aus der Ferne ist mir das zu heiß, oder ehr zu kalt

[noansi]

Hallo Klaus,

oder nimm gleich die angehängte.

Darin ist der neu eingebaute Time Broadcast sauberer drin.
Für rfmode HomeMatic wird damit zyklisch die Uhrzeit an alle hm devices per broadcast geschickt (Danke an Michael für die Info zum  Broadcast).
Mit dem Attribut hmTmBrdcstInt kann man das Sendeintervall von 86400s entsprechend 24h auch verstellen oder mit 0 den Broadcast auch abstellen.

Also wunder Dich nicht, wenn auf einmal auch die Uhren richtig gehen. 

Gruß, Ansgar.

[klausw]

oder nimm gleich die angehängte.

Habe sie jetzt mal aufgespielt, nach dem Reboot wir das rfmode Attribut nicht gelöscht. Super, genau das, was ich benötige.
Die Zeit habe ich bisher nicht beachtet 

Die Standard 10_CUL_HM funktioniert auch problemlos. Da ich nur einen CUL nutze, sollte das auch nicht stören.

Für das USB Problem habe ich ja eine Lösung. Eventuell automatisiere ich das noch.
Scheinbar bin ich der Einzige mit diesem Problem, was mich zu der Frage führt ob es an dem Arduino Nano liegt was eingebaut ist.

Danke für die schnelle Unterstützung Ansgar!