AVM Fritz!DECT 200 - FHEM-Amoklauf nach ausstecken

[Dragonfly]

Habe, bevor ich in die Arbeit bin, meinen DECT200 ausgesteckt - kann also momentan den Fehler nicht nocheinmal reproduzieren.
Folgende Einstellungen:

Code Auswählen Erweitern

define fb_buero FBAHA UNIX:SEQPACKET:/var/tmp/me_avm_home_external.ctl

Code Auswählen Erweitern

define FBDECT_16 FBDECT 16 switch
...
Logfile Meldungen in 1 Sektunde:

Code Auswählen Erweitern

2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 1: FBDECT: unknown message type
2013.05.24 19:15:25 3: fb_buero: Unknown code , help me!
2013.05.24 19:15:25 1: FBDECT: unknown message type
Wenn ich mich recht erinnere habe ich gestern oder vorgestern ein Update der FBAHA dabei gehabt.
Auf der Fritz ist die aktuelle Labor drauf.
Nach Neustart der Fritz alles im grünen Bereich.
Momentan wird der Zustand als "inactiv" richtig angezeigt - da ja ausgesteckt.
Log-Auszug nach Neustart:

Code Auswählen Erweitern

2013.05.24 21:15:19 3: Opening fb_buero device UNIX:SEQPACKET:/var/tmp/me_avm_home_external.ctl
2013.05.24 21:15:19 3: fb_buero device opened
2013.05.24 21:15:19 1: FBAHA_DoInit called
LG - Tom

[rudolfkoenig]

Kannst Du bitte pruefen, ob es
- reproduzierbar ist
- was steht in der fbaha RAWMSG reading im Fehlerfall
- passiert es auch mit der Socket Schnittstelle

[Dragonfly]

Hallo Rudi, danke für dein schnelles reagieren.

Ganz was anderes von AVM:

Verbesserungen in der Version 84.05.55-25188

    FHEM wurde auf die SVN-Version 5.4 vom 08.04.2013 aktualisiert
    Unterstützung der AVM-Aktoren FRITZ!DECT 200 und FRITZ!Powerline 546E

- reproduzierbar ist
Habe den DECT200 an die gestartete Box gehängt: Fehler beim Ausstecken - "inactive" wird nicht angezeigt, obwohl die FB das Gerät als "inactive" erkennt. Ansonsten sieht alles normal aus.
Werde über Mittag die Box mit DECT200 neu starten, mal sehen, ob sich das Verhalten ändert, da ja nach Neustart der Box ohne DECT200 "inactive" gesetzt wurde.

- was steht in der fbaha RAWMSG reading im Fehlerfall
- passiert es auch mit der Socket Schnittstelle
k.A. was du damit meinst :-(

[Dragonfly]

- reproduzierbar ist
Klein Korrektur: jetzt geht es wieder los - habe den Stecker um ca 4.10 aus der Dose genommen, dann um 4.20 einen Restart gemacht, um zu sehen ob sich der Status auf "inactive" ändert. Gerade eben 2x ein und ausgesteckt ohne zu schalten - FHEM ist wieder blockiert - soll heißen, was jetzt passiert sehe ich erst später in den logs.

[rudolfkoenig]

>  Ganz was anderes von AVM:
Hier verstehe ich nicht, was Du meinst.
Ich hoffe, dass Du beim Testen die fhem.de Version + update benutzt.

>  - was steht in der fbaha RAWMSG reading im Fehlerfall
Im FHEM-telnet "list fbaha" eingeben, und die Zeile mit RAWMSG zitieren.
Das gleiche geht auch in FHEMWEB, fbaha Detailansicht.

>  - passiert es auch mit der Socket Schnittstelle
Du sprichst den AHA Server offensichtlich ueber die Dateischnittstelle an.
Was passiert, wenn du die Netzwerk (socket) Schnittstelle mit Port 2002 verwendest?

[Dragonfly]

>  Ganz was anderes von AVM:
war nur zu deiner Info, daß die da wieder weitergemacht haben - ja ich nehm die fhem.de version + update
außer dieses:

UPD ./CHANGED
UPD FHEM/01_FHEMWEB.pm
UPD FHEM/24_NetIO230B.pm

Folgende Meldung noch aus dem Log:

Code Auswählen Erweitern

2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 3: fb_buero: Unknown code 00000010000000010000000100000014, help me!
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 3: fb_buero: Unknown code 0000000500, help me!
Noch läuft alles, trotz aus und anstecken...

[Dragonfly]

Abgestürzt.

>  - was steht in der fbaha RAWMSG reading im Fehlerfall
FHEMWEB und FHEM-telnet reagieren nicht mehr
Diese RAWMSG hatte ich, als noch alles lief:
0703001c00000002001000000000000c0000000f0004000000000000 und
0703001c00000002001000000000000c0000000f0004000000000001

Mache nun einen Neustart der Box und ein Update.

[Dragonfly]

So Update erledigt, FB mit DECT200 gestartet - diesen ein und ausgeschalten - DECT200 abgesteckt - warten bis in FB DECT200 nicht mehr als online angezeigt wird - absturz.

>  - passiert es auch mit der Socket Schnittstelle
Habe damals aus diesem grund gewechselt: on some Labor variants only the UNIX socket is available
Nach dem Neustart werde ich wie folgt umsteigen:
define fb_buero FBAHA fritz.box:2002

[Dragonfly]

Siehe da mit
define fb_buero FBAHA fritz.box:2002
wird der Status wieder als "inactive" angezeigt - kein Absturz.
Werde das heute noch etwas weiter testen.

Kann es sein, daß mit der FRITZ!OS 05.55-25409 BETA
UNIX:SEQPACKET:/var/tmp/me_avm_home_external.ctl
aus dem Rennen ist?

[rudolfkoenig]

Das wuerde mich nicht ueberraschen, obwohl diese Datei in der Protokollspezifikation von AVM explizit beschrieben ist.

[stromer-12]

Diese Datei ist bei mir auf der Fritzbox noch vorhanden.
Bei mir Läuft Fhem im Image vom AVM mit update auf die aktuelle SVN.
Greife aber per <name>:2002 direkt auf meinen 546E zu.

[stromer-12]

>
Folgende Meldung noch aus dem Log:

Code Auswählen Erweitern

2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 3: fb_buero: Unknown code 00000010000000010000000100000014, help me!
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 1: FBDECT: unknown message type 00
2013.05.25 12:36:50 3: fb_buero: Unknown code 0000000500, help me!

Heute nacht es es mich auch ereilt.

Es fing so an und das Log vergrößerte sich mehr als 20MB:

2013.05.28 00:00:55 2: Switched CUL_1 rfmode to HomeMatic
2013.05.28 00:14:11 2: Switched CUL_1 rfmode to SlowRF
2013.05.28 00:14:11 1: FBDECT: unknown message type 00
2013.05.28 00:14:11 1: FBDECT: unknown message type 00
2013.05.28 00:14:12 3: pl_s: Unknown code 0000002303e800000000000c0000001400040000000002110703001c0000002303e800, help me!
2013.05.28 00:14:12 1: FBDECT: unknown message type
2013.05.28 00:14:12 1: FBDECT: unknown message type
2013.05.28 00:14:12 3: pl_s: Unknown code , help me!
2013.05.28 00:14:12 1: FBDECT: unknown message type
2013.05.28 00:14:12 1: FBDECT: unknown message type

[rudolfkoenig]

Das Problem trat auf, falls im Puffer Muell stand. Da die Daten ueber TCP/IP transferiert wurden, muss entweder der AHA Server oder FHEM verwirrt gewesen sein. Ich habe ein paar Zeilen eingefuegt, um in so einem Fall den Puffer zu leeren. Falls es jemand einfach reproduzieren kann, bitte melden.

[Iliketechnology]

Ich kann es nicht einfach reproduzieren, aber die Info beisteuern, dass es bei mir nach Ausführen des update Befehls los ging. Die Log ist immens groß und die Rawmsg steht nur 1x am Anfang.

[Tom111]

Ich hab jetzt mal n bischen rumprobiert, bis jetzt treten die Fehlermeldungen bei mir im Log nur dann auf,
wenn ich mich auf meiner Fritz!Box anmelde und da durchklicke.
Gehe ich nicht auf die Web-GUI der Fritz!Box dann bleibt das Logfile sauber.
Evtl. kann damit jemand was anfangen.

Code Auswählen Erweitern

2014.10.01 16:43:52 1: FBDECT: unknown message type 00
2014.10.01 16:43:52 1: FBAHA: resetting buffer as we are out of sync (8)
2014.10.01 16:45:52 1: FBDECT: unknown message type 00
2014.10.01 16:45:52 1: FBAHA: resetting buffer as we are out of sync (8)
2014.10.01 16:45:52 1: FBAHA: resetting buffer as we are out of sync (0)
2014.10.01 16:47:54 1: FBDECT: unknown message type 00
2014.10.01 16:47:54 1: FBAHA: resetting buffer as we are out of sync (8)
2014.10.01 16:47:54 1: FBAHA: resetting buffer as we are out of sync (0)
2014.10.01 16:49:56 1: FBAHA: resetting buffer as we are out of sync (0)
2014.10.01 16:51:54 1: FBDECT: unknown message type 00
2014.10.01 16:51:54 1: FBAHA: resetting buffer as we are out of sync (8)
2014.10.01 16:57:58 1: FBAHA: resetting buffer as we are out of sync (0)
2014.10.01 17:04:00 1: FBAHA: resetting buffer as we are out of sync (0)