Fehler auf Cubietruck -> 127.0.0.1:1234 disconnected, waiting to reappear

Begonnen von HoTi, 24 September 2014, 06:55:35

Vorheriges Thema - Nächstes Thema

HoTi

#15
Hallo zusammen,

ich habe das loglevel auf maximum gestellt.

Fällt euch da was auf?

Der Cubietruck ist jetzt 10d ohne reset! Interesant ist das es irgenwie mit FHEM zusammenhängen muss! Da die 24h neu starten wenn ich etwas an der fhem.cfg gemacht habe!

Angenommen ich änder die fhem.cfg um 13.14Uhr dann kommt das Problem am nächsten Tag um 13.14Uhr.
Kann ich damit dann das Igor Image ausschließen?!

Performance Monitor installiert und aktiviert (Restart 13:50Uhr)


2014.10.10 08:22:25 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:0905B1F3 IDcnt:0000
2014.10.10 08:22:50 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:22:50 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,09061393,0000

2014.10.10 08:22:50 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:09061393 IDcnt:0000
2014.10.10 08:23:15 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:23:16 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:23:17 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:23:18 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:23:19 1: HMLAN_Parse: hmusb new condition timeout
2014.10.10 08:23:19 5: Triggering hmusb (3 changes)
2014.10.10 08:23:19 5: Notify loop for hmusb cond: timeout
2014.10.10 08:23:19 4: eventTypes: HMLAN hmusb cond: timeout -> cond: timeout
2014.10.10 08:23:19 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:1 init:1  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:19 4: eventTypes: HMLAN hmusb prot_timeout: last -> prot_timeout: last
2014.10.10 08:23:19 1: 127.0.0.1:1234 disconnected, waiting to reappear (hmusb)
2014.10.10 08:23:19 5: Triggering hmusb (1 changes)
2014.10.10 08:23:19 5: Notify loop for hmusb DISCONNECTED
2014.10.10 08:23:19 4: eventTypes: HMLAN hmusb DISCONNECTED -> DISCONNECTED
2014.10.10 08:23:19 1: HMLAN_Parse: hmusb new condition disconnected
2014.10.10 08:23:19 5: Triggering hmusb (4 changes)
2014.10.10 08:23:24 1: 127.0.0.1:1234 reappeared (hmusb)
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:A2516B5
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:C
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:Y01,00,
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:Y02,00,
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:Y03,00,
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb I:T1BCA37DC,04,00,00000000
2014.10.10 08:23:24 1: HMLAN_Parse: hmusb new condition init
2014.10.10 08:23:24 5: Triggering hmusb (3 changes)
2014.10.10 08:23:24 5: Notify loop for hmusb cond: init
2014.10.10 08:23:24 4: eventTypes: HMLAN hmusb cond: init -> cond: init
2014.10.10 08:23:24 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:2 init:2  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:24 4: eventTypes: HMLAN hmusb prot_init: last -> prot_init: last
2014.10.10 08:23:24 5: HMLAN_Send:  hmusb S:SF8B9E25F stat:  00 t:00000000 d:01 r:F8B9E25F m:99 8112 2516B5 000000
2014.10.10 08:23:24 5: Triggering hmusb (1 changes)
2014.10.10 08:23:24 5: Notify loop for hmusb CONNECTED
2014.10.10 08:23:24 4: eventTypes: HMLAN hmusb CONNECTED -> CONNECTED
2014.10.10 08:23:25 1: 127.0.0.1:1234 disconnected, waiting to reappear (hmusb)
2014.10.10 08:23:25 5: Triggering hmusb (1 changes)
2014.10.10 08:23:25 5: Notify loop for hmusb DISCONNECTED
2014.10.10 08:23:25 4: eventTypes: HMLAN hmusb DISCONNECTED -> DISCONNECTED
2014.10.10 08:23:25 1: HMLAN_Parse: hmusb new condition disconnected
2014.10.10 08:23:25 5: Triggering hmusb (4 changes)
2014.10.10 08:23:25 1: 127.0.0.1:1234 reappeared (hmusb)
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:A2516B5
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:C
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:Y01,00,
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:Y02,00,
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:Y03,00,
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb I:T1BCA37DD,04,00,00000000
2014.10.10 08:23:25 1: HMLAN_Parse: hmusb new condition init
2014.10.10 08:23:25 5: Triggering hmusb (3 changes)
2014.10.10 08:23:25 5: Notify loop for hmusb cond: init
2014.10.10 08:23:25 4: eventTypes: HMLAN hmusb cond: init -> cond: init
2014.10.10 08:23:25 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:3 init:3  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:25 4: eventTypes: HMLAN hmusb prot_init: last -> prot_init: last
2014.10.10 08:23:25 5: HMLAN_Send:  hmusb S:SF8B9E66A stat:  00 t:00000000 d:01 r:F8B9E66A m:99 8112 2516B5 000000
2014.10.10 08:23:25 5: Triggering hmusb (1 changes)
2014.10.10 08:23:25 5: Notify loop for hmusb CONNECTED
2014.10.10 08:23:25 4: eventTypes: HMLAN hmusb CONNECTED -> CONNECTED
2014.10.10 08:23:27 1: 127.0.0.1:1234 disconnected, waiting to reappear (hmusb)
2014.10.10 08:23:27 5: Triggering hmusb (1 changes)
2014.10.10 08:23:27 5: Notify loop for hmusb DISCONNECTED
2014.10.10 08:23:27 4: eventTypes: HMLAN hmusb DISCONNECTED -> DISCONNECTED
2014.10.10 08:23:27 1: HMLAN_Parse: hmusb new condition disconnected
2014.10.10 08:23:27 5: Triggering hmusb (4 changes)
2014.10.10 08:23:27 1: 127.0.0.1:1234 reappeared (hmusb)
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:A2516B5
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:C
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:Y01,00,
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:Y02,00,
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:Y03,00,
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb I:T1BCA37DF,04,00,00000000
2014.10.10 08:23:27 1: HMLAN_Parse: hmusb new condition init
2014.10.10 08:23:27 5: Triggering hmusb (3 changes)
2014.10.10 08:23:27 5: Notify loop for hmusb cond: init
2014.10.10 08:23:27 4: eventTypes: HMLAN hmusb cond: init -> cond: init
2014.10.10 08:23:27 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:4 init:4  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:27 4: eventTypes: HMLAN hmusb prot_init: last -> prot_init: last
2014.10.10 08:23:27 5: HMLAN_Send:  hmusb S:SF8B9EE49 stat:  00 t:00000000 d:01 r:F8B9EE49 m:99 8112 2516B5 000000
2014.10.10 08:23:27 5: Triggering hmusb (1 changes)
2014.10.10 08:23:27 5: Notify loop for hmusb CONNECTED
2014.10.10 08:23:27 4: eventTypes: HMLAN hmusb CONNECTED -> CONNECTED
2014.10.10 08:23:31 1: 127.0.0.1:1234 disconnected, waiting to reappear (hmusb)
2014.10.10 08:23:31 5: Triggering hmusb (1 changes)
2014.10.10 08:23:31 5: Notify loop for hmusb DISCONNECTED
2014.10.10 08:23:31 4: eventTypes: HMLAN hmusb DISCONNECTED -> DISCONNECTED
2014.10.10 08:23:31 1: HMLAN_Parse: hmusb new condition disconnected
2014.10.10 08:23:31 5: Triggering hmusb (4 changes)
2014.10.10 08:23:31 1: 127.0.0.1:1234 reappeared (hmusb)
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:A2516B5
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:C
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:Y01,00,
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:Y02,00,
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:Y03,00,
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb I:T1BCA37E3,04,00,00000000
2014.10.10 08:23:31 1: HMLAN_Parse: hmusb new condition init
2014.10.10 08:23:31 5: Triggering hmusb (3 changes)
2014.10.10 08:23:31 5: Notify loop for hmusb cond: init
2014.10.10 08:23:31 4: eventTypes: HMLAN hmusb cond: init -> cond: init
2014.10.10 08:23:31 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:5 init:5  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:31 4: eventTypes: HMLAN hmusb prot_init: last -> prot_init: last
2014.10.10 08:23:31 5: HMLAN_Send:  hmusb S:SF8B9FF16 stat:  00 t:00000000 d:01 r:F8B9FF16 m:99 8112 2516B5 000000
2014.10.10 08:23:31 5: Triggering hmusb (1 changes)
2014.10.10 08:23:31 5: Notify loop for hmusb CONNECTED
2014.10.10 08:23:31 4: eventTypes: HMLAN hmusb CONNECTED -> CONNECTED
2014.10.10 08:23:32 1: 127.0.0.1:1234 disconnected, waiting to reappear (hmusb)
2014.10.10 08:23:32 5: Triggering hmusb (1 changes)
2014.10.10 08:23:32 5: Notify loop for hmusb DISCONNECTED
2014.10.10 08:23:32 4: eventTypes: HMLAN hmusb DISCONNECTED -> DISCONNECTED
2014.10.10 08:23:32 1: HMLAN_Parse: hmusb new condition disconnected
2014.10.10 08:23:32 5: Triggering hmusb (4 changes)
2014.10.10 08:23:32 1: 127.0.0.1:1234 reappeared (hmusb)
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:A2516B5
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:C
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:Y01,00,
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:Y02,00,
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:Y03,00,
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb I:T1BCA37E4,04,00,00000000
2014.10.10 08:23:32 1: HMLAN_Parse: hmusb new condition init
2014.10.10 08:23:32 5: Triggering hmusb (3 changes)
2014.10.10 08:23:32 5: Notify loop for hmusb cond: init
2014.10.10 08:23:32 4: eventTypes: HMLAN hmusb cond: init -> cond: init
2014.10.10 08:23:32 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:1 disconnected:6 init:6  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:32 4: eventTypes: HMLAN hmusb prot_init: last -> prot_init: last
2014.10.10 08:23:32 5: HMLAN_Send:  hmusb S:SF8BA0306 stat:  00 t:00000000 d:01 r:F8BA0306 m:99 8112 2516B5 000000
2014.10.10 08:23:32 5: Triggering hmusb (1 changes)
2014.10.10 08:23:32 5: Notify loop for hmusb CONNECTED
2014.10.10 08:23:32 4: eventTypes: HMLAN hmusb CONNECTED -> CONNECTED
2014.10.10 08:23:33 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,000004D7,0000

2014.10.10 08:23:33 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:000004D7 IDcnt:0000
2014.10.10 08:23:34 5: HMLAN/RAW: /I00,00,00,00

2014.10.10 08:23:34 5: HMLAN/RAW: /I00,00,00,00

2014.10.10 08:23:34 5: HMLAN/RAW: /I00,00,00,00

2014.10.10 08:23:34 5: HMLAN/RAW: /RF8BA0306,0002,00000000,FF,7FFF,9981122516B5000000

2014.10.10 08:23:34 5: HMLAN_Parse: hmusb R:RF8BA0306 stat:0002 t:00000000 d:FF r:7FFF     m:99 8112 2516B5 000000
2014.10.10 08:23:34 1: HMLAN_Parse: hmusb new condition ok
2014.10.10 08:23:34 5: Triggering hmusb (3 changes)
2014.10.10 08:23:34 5: Notify loop for hmusb cond: ok
2014.10.10 08:23:34 4: eventTypes: HMLAN hmusb cond: ok -> cond: ok
2014.10.10 08:23:34 4: eventTypes: HMLAN hmusb Xmit-Events: timeout:1 ok:2 disconnected:6 init:6  -> Xmit-Events: timeout:.* ok:.* disconnected:.* init:.*
2014.10.10 08:23:34 4: eventTypes: HMLAN hmusb prot_ok: last -> prot_ok: last
2014.10.10 08:23:57 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:23:57 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,00006276,0000

2014.10.10 08:23:57 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:00006276 IDcnt:0000
2014.10.10 08:24:22 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:24:22 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,0000C436,0000

2014.10.10 08:24:22 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:0000C436 IDcnt:0000
2014.10.10 08:24:47 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:24:47 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,000125F5,0000

2014.10.10 08:24:47 5: HMLAN_Parse: hmusb V:03C4 sNo:LEQ0659748 d:2CC883 O:2516B5 t:000125F5 IDcnt:0000
2014.10.10 08:25:12 5: HMLAN_Send:  hmusb I:K
2014.10.10 08:25:12 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0659748,2CC883,2516B5,000187B5,0000







Viele Grüße aus  Oberbayern
Tim (RettungsTim)

HoTi

Hallo,

der performancemonitor hat keine Einträge hinterlassen! Ausfälle weiterhin alle 24h nach FHEM.cfg sichern oder FHEM neustart.

Ich frag mich ob der Beitrag hier mitlerweile nicht besser in der Hardware (Einplatinencomputer) aufgehoben ist.
Ich möchte nicht unbedingt ein neues Thema mit dem gleichen Fehler aufmachen.

Kann ein Moderator bitte diese Thema dorthin verschieben?! Wäre toll.

Viele Grüße
Tim

Viele Grüße aus  Oberbayern
Tim (RettungsTim)

tpm88

Zitat von: RettungsTim am 26 September 2014, 15:44:27
Das werde ich mal probieren mit dem Update. Danke

Gibt es da ein ChanceLog zum update?
Ich muss da nochmal nachbohren - welche Versionen von
- Firmware HM-CFG-USB2  und
- hmland
setzt Du konkret ein?

Hast Du das Update auf die Firmware v0,967 eigentlich durchgeführt? Benutzt Du die neueste Version des hmland (29.05.2014) von git.zerfleddert.org?

Zitat2014-05-14    Michael Gernoth   only reboot by default when firmware-version is < 0.967

Gruss
Tobias
Test FHEM Server on RPi, CUL_HM
Prod FHEM Server on Odroid HC1, HM-USB, JeeLink
Devices: diverse HM, IT1500, 1wire, LaCrosse, MQTT

HoTi

Hallo Tobias,

Die Nachfrage ist ok.

Mit dem alten habe ich ein update gemacht. Gleiche Fehler.
Der neue ist noch auf der alten Version. Aber wie gesagt bei tausch wandert der Fehler nicht mit!

Das update habe ich mit dem homematic Tool am Windows PCs gemacht. War problemlos.

Hmland nach update installiert. Sollte somit aktuell sein.


git clone git://git.zerfleddert.de/hmcfgusb


Vg
Tim
Viele Grüße aus  Oberbayern
Tim (RettungsTim)

tpm88

Hallo Tim,

das ganze ist wirklich sehr merkwürdig. Aber offenbar bist Du nicht der einzige mit dem Problem. Das hier klingt doch sehr ähnlich...
http://forum.fhem.de/index.php/topic,13071.msg196351.html#msg196351

Das Verhalten beginnt doch immer mit folgender Meldung:

HMLAN_Parse: hmusb new condition timeout


Dann gilt es herauszufinden, was dieser "timeout" bedeutet oder wovon er ausgelöst wird.

Nächste mögliche Schritte
- hmland mit Debug Flag -D und Logfile starten, um zu dem Zeitpunkt (nach 24h) möglichst einen Hinweis dort zu erhalten
- notfalls selber mal in den Quellcode vom hmland schauen, was es mit dem "timeout" auf sich hat
- oder ggf. in obigen Thread posten - dort sollte der Entwickler  des hmland (mgernoth) mitlesen

Gruss
Tobias

PS: Ich glaube persönlich, daß das Thema doch besser im Bereich Homematic aufgehoben wäre. Ich denke nicht, dass der CubieTruck (oder dessen Image) das Problem ist. Im Link oben hat jemand dieses oder ein sehr ähnliches Problem mit dem hmland auf der Fritzbox
Test FHEM Server on RPi, CUL_HM
Prod FHEM Server on Odroid HC1, HM-USB, JeeLink
Devices: diverse HM, IT1500, 1wire, LaCrosse, MQTT

HoTi

#20
Kann es sein das hmland alle 24h ein reset macht wenn es nur so gestartet wird?

Zitat
/opt/hmcfgusb/hmland -d -p 1234

Ich probiere es nun so:

Zitat
/opt/hmcfgusb/hmland -r 0 -d -p 1234

Sch**** jetzt habe ich dein Zitat gerafft. Ja der neue Stick war noch auf < 0.967 deswegen macht der ein Restart. Verdammt...

Ok nun teste ich das mal und dann werde ich meinen Test-Aktor anschließen. Aber der alte Stick macht den mist obwohl er die neue SW hat.
Viele Grüße aus  Oberbayern
Tim (RettungsTim)