Homematic Rolladenaktor nimmt Befehl an, führt ihn aber manchmal nicht aus

[Georg312]

Hallo,

mein Problem passt thematisch zu diesem Thread: Link .
Diesmal habe ich allerdings kein Problem mit verlorenen Rückmeldungen, sondern mit nicht ausgeführten Befehlen.

Um 7:00 Uhr sollen 8 Rolläden gleichzeitig hochfahren. Das funktioniert oft einwandfrei. Manchmal bleiben einige Läden unten. Das allerdings ohne einen "missing ack" sondern mit scheinbar angenommenen aber nicht ausgeführtem Befehl. Das leuchtet mir einfach nicht ein und lässt sich nur mit
einem Bug im Actuator erklären?  Es handelt sich um blindActuatoren vom Typ HM-LC-Bl1PBU-FM.

Ein paar Logauszüge:

Rolladen2 funktioniert einwandfrei:

2013-04-20_07:00:00 WZ_Rolladen2 set_on
2013-04-20_07:00:03 WZ_Rolladen2 level: 7.5 %
2013-04-20_07:00:03 WZ_Rolladen2 deviceMsg: 7.5 % (to HMLAN1)
2013-04-20_07:00:03 WZ_Rolladen2 7.5 %
2013-04-20_07:00:03 WZ_Rolladen2 motor: up:7.5 %
2013-04-20_07:00:36 WZ_Rolladen2 level: 100 %
2013-04-20_07:00:36 WZ_Rolladen2 deviceMsg: on (to HMLAN1)
2013-04-20_07:00:36 WZ_Rolladen2 on
2013-04-20_07:00:36 WZ_Rolladen2 motor: stop:on

Rolladen 4 auch:

2013-04-20_07:00:00 WZ_Rolladen4 set_on
2013-04-20_07:00:03 WZ_Rolladen4 level: 6.5 %
2013-04-20_07:00:03 WZ_Rolladen4 deviceMsg: 6.5 % (to HMLAN1)
2013-04-20_07:00:03 WZ_Rolladen4 6.5 %
2013-04-20_07:00:03 WZ_Rolladen4 motor: up:6.5 %
2013-04-20_07:00:37 WZ_Rolladen4 level: 100 %
2013-04-20_07:00:37 WZ_Rolladen4 deviceMsg: on (to HMLAN1)
2013-04-20_07:00:37 WZ_Rolladen4 on
2013-04-20_07:00:37 WZ_Rolladen4 motor: stop:on

Rolladen 1 bleibt unten:
2013-04-20_07:00:00 WZ_Rolladen1 set_on
2013-04-20_07:00:01 WZ_Rolladen1 level: 1.5 %
2013-04-20_07:00:01 WZ_Rolladen1 deviceMsg: 1.5 % (to HMLAN1)
2013-04-20_07:00:01 WZ_Rolladen1 1.5 %
2013-04-20_07:00:01 WZ_Rolladen1 motor: up:1.5 %
2013-04-20_07:00:01 WZ_Rolladen1 level: 3 %
2013-04-20_07:00:01 WZ_Rolladen1 deviceMsg: 3 % (to HMLAN1)
2013-04-20_07:00:01 WZ_Rolladen1 3 %
2013-04-20_07:00:01 WZ_Rolladen1 motor: down:3 %
2013-04-20_07:00:07 WZ_Rolladen1 level: 0 %
2013-04-20_07:00:07 WZ_Rolladen1 deviceMsg: off (to HMLAN1)
2013-04-20_07:00:07 WZ_Rolladen1 off
2013-04-20_07:00:07 WZ_Rolladen1 motor: stop:off

und Rolladen 3 auch:

2013-04-20_07:00:00 WZ_Rolladen3 set_on
2013-04-20_07:00:01 WZ_Rolladen3 level: 1.5 %
2013-04-20_07:00:01 WZ_Rolladen3 deviceMsg: 1.5 % (to HMLAN1)
2013-04-20_07:00:01 WZ_Rolladen3 1.5 %
2013-04-20_07:00:01 WZ_Rolladen3 motor: up:1.5 %
2013-04-20_07:00:01 WZ_Rolladen3 level: 3 %
2013-04-20_07:00:01 WZ_Rolladen3 deviceMsg: 3 % (to HMLAN1)
2013-04-20_07:00:01 WZ_Rolladen3 3 %
2013-04-20_07:00:01 WZ_Rolladen3 motor: down:3 %
2013-04-20_07:00:07 WZ_Rolladen3 level: 0 %
2013-04-20_07:00:07 WZ_Rolladen3 deviceMsg: off (to HMLAN1)
2013-04-20_07:00:07 WZ_Rolladen3 off
2013-04-20_07:00:07 WZ_Rolladen3 motor: stop:off


Ich hatte dieses Verhalten schon früher beobachtet. Neu ist heute, dass die fehlerhaften Läden scheinbar (gesehen habe ich das nicht) kurz hoch und dann wieder runterfahren obwohl kein weiterer Befehl gekommen ist?!

Das ausführliche HMLAN-Log schicke ich per PM direkt an Martin.

Gruß
Georg

[martinp876]

Hi Georg,

bei Rollo WZ_Rolladen1, WZ_Rolladen2 und KU_Rolladen wird ein off gesendet.
Gute nachricht, es ist kein Bug des HM, ist also lösbar.

Schlechte Nachricht, in FHEM klappt etwas nicht.

Kannst du einmal dein Kommando schickten? Alles was dazu gehoert. Ist da etwas mit toggel drin?
Aktuell habe ich keine erklaerung, woher das off kommt.

Gruss
Martin

[Georg312]

Hi Martin,

Es gibt eine struct mit den Rolläden:

define Rolladen_Garten structure room AZ_Rolladen KU_Rolladen WZ_Rolladen1 WZ_Rolladen2 WZ_Rolladen3 WZ_Rolladen4
attr Rolladen_Garten webCmd on:stop:off

Und ein at, zum auslösen:

define Rolladen_Garten_hoch at *{sunrise(1800,"7:00","9:00")} set Rolladen_Garten on


Mehr ist da nicht.

Gruß
Georg

[martinp876]

Hi,

Der machaismus ist, dass nach dem Ack des 'on' ein 'off' geschickt wird, bei 3 der Rollladen.

Es wird also sauber der Reihe nach verarbeitet.
Ich werde noch einmal im Code schauen.
Kann es sein dass es noch irgend ein anderen Notify gibt, dass dies anstossen kann?

Aber immerhin fehlt das "set_off". Seltsam ist das schon

Gruss
Maritn

[martinp876]

noch etwas:
tritt es immer auf? oder wechselt es?

[martinp876]

Zur Info,

habe das Problem einmal nachstellen koennen - werde es untersuchen.

Gruss
Martin

[Georg312]

Hi Martin,

das Du es nachstellen kannst, ist natürlich sehr gut.

hier noch die Infos:
- Weder die Aktoren, noch die Strukturen sind bei anderen ats oder notifys verwendet.
- Der Effekt tritt sporadisch auf. Alle paar Tage.

Georg

[martinp876]

Hallo Georg,

sieht leider bei mir auch so aus: Ich hatte den Fehler einmal.
Noch habe ich keine Ahnung wo der Befehl herkommt. Offensichtlich ist er nicht durch "set" gegangen, da sonst ein Log gekommen sein sollte. Automatiken, die ein set machen habe ich nicht....
Bin also noch nicht durch.
Gruss
Martin

[Georg312]

Hallo,

ich habe den Effekt jetzt auch mal live beobachten können. Rolladen fährt ein Stück runter und dann wieder hoch. Ich werde jetzt mal mit der "sleep 0.5" Variante die Rolläden leicht zeitversetzt fahren. Um einfach mal zu verifizieren, ob dann alles sauber läuft.

Gruß
Georg

[crissiloop]

Hallo,

bei mir taucht auch seit dem 26.04.13 abends das Problem auf. Mal mit einem Rollladen, mal auch mit 2. Ich kann noch nicht so richtig erkennen, woran es liegt.
Hier mal die Auszüge aus dem Log. Vielleicht hilft das ja was.

Code Auswählen Erweitern

2013-04-28_20:44:41 WZ_Nord_Rolladen level: set_runter
2013-04-28_20:44:42 WZ_Nord_Rolladen set_runter
2013-04-28_20:44:42 WZ_SuedOst_Rolladen level: set_runter
2013-04-28_20:44:42 WZ_SuedOst_Rolladen set_runter
2013-04-28_20:44:42 WZ_Terasse_Rolladen level: set_runter
2013-04-28_20:44:42 WZ_Terasse_Rolladen set_runter

2013-04-28_20:44:43 WZ_Nord_Rolladen level: runter00 %
2013-04-28_20:44:43 WZ_Nord_Rolladen deviceMsg: hoch (to HMLAN1)
2013-04-28_20:44:43 WZ_Nord_Rolladen hoch
2013-04-28_20:44:43 WZ_Nord_Rolladen motor: down:hoch

2013-04-28_20:44:43 WZ_SuedOst_Rolladen level: runter00 %
2013-04-28_20:44:43 WZ_SuedOst_Rolladen deviceMsg: hoch (to HMLAN1)
2013-04-28_20:44:43 WZ_SuedOst_Rolladen hoch
2013-04-28_20:44:43 WZ_SuedOst_Rolladen motor: down:hoch
2013-04-28_20:44:43 WZ_Terasse_Rolladen level: runter00 %
2013-04-28_20:44:43 WZ_Terasse_Rolladen deviceMsg: hoch (to HMLAN1)
2013-04-28_20:44:43 WZ_Terasse_Rolladen hoch
2013-04-28_20:44:43 WZ_Terasse_Rolladen motor: down:hoch
2013-04-28_20:44:43 WZ_Nord_Rolladen level: 96 %
2013-04-28_20:44:43 WZ_Nord_Rolladen deviceMsg: 96 % (to HMLANrunter)
2013-04-28_20:44:43 WZ_Nord_Rolladen 96 %
2013-04-28_20:44:43 WZ_Nord_Rolladen motor: up:96 %
2013-04-28_20:44:44 WZ_SuedOst_Rolladen level: 95 %
2013-04-28_20:44:44 WZ_SuedOst_Rolladen deviceMsg: 95 % (to HMLANrunter)
2013-04-28_20:44:44 WZ_SuedOst_Rolladen 95 %
2013-04-28_20:44:44 WZ_SuedOst_Rolladen motor: up:95 %

2013-04-28_20:44:49 WZ_SuedOst_Rolladen level: runter00 %
2013-04-28_20:44:49 WZ_SuedOst_Rolladen deviceMsg: hoch (to HMLAN1)
2013-04-28_20:44:49 WZ_SuedOst_Rolladen hoch
2013-04-28_20:44:49 WZ_SuedOst_Rolladen motor: stop:hoch
2013-04-28_20:44:49 WZ_Nord_Rolladen level: runter00 %
2013-04-28_20:44:49 WZ_Nord_Rolladen deviceMsg: hoch (to HMLAN1)
2013-04-28_20:44:49 WZ_Nord_Rolladen hoch
2013-04-28_20:44:49 WZ_Nord_Rolladen motor: stop:hoch

2013-04-28_20:45:12 WZ_Terasse_Rolladen level: runter %
2013-04-28_20:45:12 WZ_Terasse_Rolladen deviceMsg: runter % (to HMLAN1)
2013-04-28_20:45:12 WZ_Terasse_Rolladen runter %
2013-04-28_20:45:12 WZ_Terasse_Rolladen motor: stop:runter %

Wie man sieht, fährt der Terassenrolladen normal und die anderen beiden bleiben oben bzw. gehen direkt wieder hoch.

Der Befehl wird über ein Structure geschaltet, welche wie folgt definiert ist:

Code Auswählen Erweitern

define Alle_Rollaeden structure room WZ_Nord_Rolladen WZ_NordOst_Rolladen WZ_SuedOst_Rolladen WZ_Terasse_Rolladen K_Rolladen HWR_Rolladen GWC_Rolladen Bad_Rolladen GZ_Rolladen KZ_Rolladen SZ_Rolladen
attr Alle_Rollaeden clientstate_behavior relative
attr Alle_Rollaeden clientstate_priority hoch|on runter %
attr Alle_Rollaeden devStateIcon hoch:shutter_open:runter runter.*:shutter_closed:hoch
attr Alle_Rollaeden eventMap 100:hoch 1:runter 50:halb 85:Frost_oben
attr Alle_Rollaeden room Rollaeden
attr Alle_Rollaeden webCmd hoch:runter:stop

Die Attribute wurden auch auf die jeweiligen Rollläden vererbt.

Das Notify sieht wie folgt aus:

Code Auswählen Erweitern

define Alle_Rollaeden_runter at *{sunset("HORIZON=-3",0,"17:00","22:00")} {\
fhem("set Alle_Rollaeden runter;; define WZ_Raffstore_runter at +00:02:00 set WZ_Raffstore zu")\
}


Das letzte Update habe ich am 24.04.13 gemacht.

Code Auswählen Erweitern

2013.04.24 14:39:08 0: Server started with 64 defined entities (version Fhem 5.4 (DEVELOPMENT), $Id: fhem.pl 3075 2013-04-15 15:19:48Z rudolfkoenig $, pid 5953)

Als Ergänzung sei vielleicht noch zu sagen, dass Morgens alle 10 Rollläden ohne Probleme alle hochfahren. Die Hoch-Befehle erfolgen allerdings nicht über die Structure sondern die Aktoren werden einzeln aufgeführt. Ein Notify mit Sunrise löst eine Funktion aus, in welcher in einer Schleife alle Rollläden abgearbeitet werden. Sie fahren aber immer noch gleichzeitig laut Log. Also keine extra eingebauten Verzögerungen.

Gruß

[crissiloop]

So ich habe gestern abend das Notify abgeändert und habe den "runter" Befehl nicht mehr an die structure geschickt sondern an jeden Rollladen einzeln aber in einem Befehl.
Aber auch das war leider nicht des Rätsels Lösung? Ein Rollladen fuhr laut Log wieder kurz runter und dann direkt wieder hoch ohne einen Befehl fürs Hoch zu bekommen.

Irgendwelche Ideen, wie man das Problem beheben kann?
Oder was würdest du benötigen Martin, um den Thema auf die Schliche zu kommen?

Gruß Christian

[martinp876]

Hallo Christian,

du hast das Problem seit 26.4. Hast du da einen update gemacht? Welchen Version hattest du davor?

Wie oft tritt das Problem auf

Gruss
Martin

[crissiloop]

Hallo Martin,

ich habe am 26.04. keine Update gemacht. Das Update war am 24.04.
Seit 26.04.13 tritt das Problem nun jeden Abend auf, mal ein Rollladen mal auch zwei.

Und gestern Abend habe ich wieder ein Update gemacht und nun trat das Problem heute morgen auch mit meinem SZ_Rollladen auf.

Code Auswählen Erweitern

013-05-01_09:00:00 SZ_Rolladen set_hoch
2013-05-01_09:00:00 SZ_Rolladen level: 3runter %
2013-05-01_09:00:00 SZ_Rolladen deviceMsg: 3runter % (to HMLAN1)
2013-05-01_09:00:00 SZ_Rolladen 3runter %
2013-05-01_09:00:00 SZ_Rolladen motor: up:3runter %
2013-05-01_09:00:00 SZ_Rolladen level: 33 %
2013-05-01_09:00:00 SZ_Rolladen deviceMsg: 33 % (to HMLANrunter)
2013-05-01_09:00:00 SZ_Rolladen 33 %
2013-05-01_09:00:00 SZ_Rolladen motor: down:33 %
2013-05-01_09:00:03 SZ_Rolladen level: 30 %
2013-05-01_09:00:03 SZ_Rolladen deviceMsg: 30 % (to HMLANrunter)
2013-05-01_09:00:03 SZ_Rolladen 30 %
2013-05-01_09:00:03 SZ_Rolladen motor: stop:30 %

Das Notify:

Code Auswählen Erweitern

define SZ_Rolladen_hoch_we at 09:00:00 set SZ_Rolladen hoch

Das letzte Update davor habe ich am 09.04.13 gemacht

Code Auswählen Erweitern

2013.04.09 21:41:34 0: Server started with 63 defined entities (version Fhem 5.4 (DEVELOPMENT), $Id: fhem.pl 3053 2013-04-08 14:31:22Z rudolfkoenig $, pid 29119)

Gruß
Christian

[martinp876]

Hallo Christian,

Das ist ziemlich gut zu reproduzieren.
Kannst du die roh-logs einschalten mit
attr global verbose 1
attr global mseglog 1
attr <hmlan> loglevel 1

Nach dem Fehler ein list des Device machen.

Gruss
Martin

[crissiloop]

Hallo Martin,
so nach umstellen der LogLevels war natürlich heute abend kein Fehler vorhanden.
Ich werde es beobachten und sobald der Fehler wieder auftritt das List vom betreffenden Rollladen posten.

Gruß
Christian