Notify reagiert nur sporadisch

[Gernott]

Hallo

Ich habe mir eine Fensterüberwachung gebaut mit einem Watchdog. Die ganze Sache funktioniert, bis auf das gelegentliche Verschlucken eines notify, was ich nicht verstehe.

Wenn der Watchdog auslöst (Fenster zu lange offen), wird on the fly ein notify definiert, was sich selbst löschen soll (delete), wenn das Fenster wieder geschlossen wird. Außerdem soll dann ein Systembefehl ausgeführt werden, was ebenfalls geht.

Das define notify klappt immer, das notify erscheint korrekt in der Liste in FHEM:

Code Auswählen Erweitern

2014.02.14 20:59:46 3: Watchdog watchdog_EG.Bad.Fenster triggered
2014.02.14 20:59:46 5: Cmd: >{
system "/home/pi/sip-tools/sipcall-bad.sh&";
fhem('define kill.sipcall notify hm.window_BadFenster:closed delete kill.sipcall;;"ps ax | grep sipcall | grep -v grep | awk \'{print $1}\' | xargs kill -SIGINT&"');
fhem('setstate watchdog_EG.Bad.Fenster defined');
}<

2014.02.14 20:59:46 5: Cmd: >define kill.sipcall notify hm.window_BadFenster:closed delete kill.sipcall;"ps ax | grep sipcall | grep -v grep | awk '{print $1}' | xargs kill -SIGINT&"<
2014.02.14 20:59:46 5: Triggering global (1 changes)
2014.02.14 20:59:46 5: Notify loop for global DEFINED kill.sipcall
2014.02.14 20:59:46 5: Cmd: >setstate watchdog_EG.Bad.Fenster defined<



Wenn das Fenster geschlossen wird, reagiert das notify mal und mal nicht. Anbei mal ein Logausschnitt mit erfolgreichem notify:

Code Auswählen Erweitern

2014.02.14 21:00:35 5: Triggering hm.window_BadFenster (2 changes)
2014.02.14 21:00:35 5: Notify loop for hm.window_BadFenster closed
2014.02.14 21:00:35 5: Triggering kill.sipcall
2014.02.14 21:00:35 5: Cmd: >delete kill.sipcall<
2014.02.14 21:00:35 5: Triggering global (1 changes)
2014.02.14 21:00:35 5: Notify loop for global DELETED kill.sipcall

Und so sieht es aus, wenn die Triggerung nicht erfolgt (mit HMLAN Messages davor und danach):

Code Auswählen Erweitern


2014.02.14 20:59:59 5: HMLAN_Parse: HMLAN1 R:E2476E6   stat:0000 t:7AE2FE20 d:FF r:FFAC     m:34 A641 2476E6 1EA24B 013200
2014.02.14 20:59:59 5: HMLAN1 dispatch A0C34A6412476E61EA24B013200::-84:HMLAN1
2014.02.14 20:59:59 5: HMLAN_Send:  HMLAN1 S:S31FBF4E2 stat:  00 t:00000000 d:01 r:31FBF4E2 m:34 8002 1EA24B 2476E6 0101C800
2014.02.14 20:59:59 5: Triggering hm.window_BadFenster (2 changes)
2014.02.14 20:59:59 5: Notify loop for hm.window_BadFenster closed
2014.02.14 20:59:59 5: HMLAN_Parse: HMLAN1 R:R31FBF4E2 stat:0002 t:00000000 d:FF r:7FFF     m:34 8002 1EA24B 2476E6 0101C800

Mir ist das ziemlich rätselhaft. Hat jemand eine Idee, woran das liegen könnte?

Viele Grüße
G.