HM-CC-TC geht plötzlich ohne Grund auf actuator 81%

Begonnen von ThorstenH, 04 April 2013, 00:47:28

Vorheriges Thema - Nächstes Thema

martinp876

Hallo Thorste,

die Roh-messages aufzeichnen mit
attr global verbose 1
attr global mseclog 1
attr <hmlan> loglevel 1

Gruss
Martin

ThorstenH

Mmmh, weiss gar nicht, ob das jetzt hier hingehört oder ich einen neuen Thread aufmachen müsste...
Jetzt hat meine Frau heute Nacht um 5 Uhr den TC von desired-temp 22°C auf Mond/6°C eingestellt (am Gerät), die Ventile gingen aber nicht zu, der TC hat schön weiter auf 22°C geregelt. Jedenfalls habe ich jetzt ausführliche Logs. In der Grafik habe ich die desired-temp vom Vortag mal von Hand eingezeichnet, da zwischen 0 und 5 Uhr keine desired-temp geloggt wurde (hellgrün).

TC Log:
2013-04-07_04:39:54 thermostat_wohnzimmer humidity: 37
2013-04-07_04:40:14 thermostat_wohnzimmer actuator: 9 %
2013-04-07_04:42:37 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:42:37 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:42:37 thermostat_wohnzimmer humidity: 37
2013-04-07_04:42:57 thermostat_wohnzimmer actuator: 9 %
2013-04-07_04:45:06 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:45:06 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:45:06 thermostat_wohnzimmer humidity: 37
2013-04-07_04:45:26 thermostat_wohnzimmer actuator: 9 %
2013-04-07_04:47:20 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:47:20 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:47:20 thermostat_wohnzimmer humidity: 37
2013-04-07_04:47:27 thermostat_wohnzimmer desired-temp: 6.0
2013-04-07_04:47:27 thermostat_wohnzimmer desired-temp: 6.0
2013-04-07_04:47:28 thermostat_wohnzimmer desired-temp: 6.0
2013-04-07_04:47:40 thermostat_wohnzimmer actuator: 9 %
2013-04-07_04:50:24 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:50:24 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:50:24 thermostat_wohnzimmer humidity: 37
2013-04-07_04:50:44 thermostat_wohnzimmer actuator: 0 %
2013-04-07_04:53:13 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:53:13 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:53:13 thermostat_wohnzimmer humidity: 37
2013-04-07_04:53:33 thermostat_wohnzimmer actuator: 0 %
2013-04-07_04:55:48 thermostat_wohnzimmer T: 22 H: 37
2013-04-07_04:55:48 thermostat_wohnzimmer measured-temp: 22
2013-04-07_04:55:48 thermostat_wohnzimmer humidity: 37
2013-04-07_04:58:09 thermostat_wohnzimmer T: 22.1 H: 37
2013-04-07_04:58:09 thermostat_wohnzimmer measured-temp: 22.1
2013-04-07_04:58:09 thermostat_wohnzimmer humidity: 37
2013-04-07_04:58:28 thermostat_wohnzimmer actuator: 7 %
2013-04-07_05:00:14 thermostat_wohnzimmer T: 22.1 H: 37
2013-04-07_05:00:14 thermostat_wohnzimmer measured-temp: 22.1


(siehe Anhang / see attachement)


fhem Log:
2013.04.07 04:46:13.773 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211C0746 IDcnt:0000
2013.04.07 04:46:24.481 1: HMLAN/RAW: /E1CE75F,0000,211C3114,FF,FFCA,85A2581CE75F1CED2A0022

2013.04.07 04:46:24.481 1: HMLAN_Parse: HMLAN1 S:E1CE75F   stat:0000 t:211C3114 d:FF r:FFCA m:85A2581CE75F1CED2A0022
2013.04.07 04:46:25.697 1: HMLAN/RAW: /E1CED2A,0000,211C3196,FF,FFC3,8582021CED2A1CE75F01011A003E

2013.04.07 04:46:25.697 1: HMLAN_Parse: HMLAN1 S:E1CED2A   stat:0000 t:211C3196 d:FF r:FFC3 m:8582021CED2A1CE75F01011A003E
2013.04.07 04:46:38.783 1: HMLAN_Send:  K
2013.04.07 04:46:38.786 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,211C68FF,0000

2013.04.07 04:46:38.786 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211C68FF IDcnt:0000
2013.04.07 04:47:03.808 1: HMLAN_Send:  K
2013.04.07 04:47:03.811 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,211CCAC4,0000

2013.04.07 04:47:03.811 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211CCAC4 IDcnt:0000
2013.04.07 04:47:11.761 1: HMLAN/RAW: /E1CE123,0000,211CE9CC,FF,FFA4,8886701CE12300000000AD2D

2013.04.07 04:47:11.762 1: HMLAN_Parse: HMLAN1 S:E1CE123   stat:0000 t:211CE9CC d:FF r:FFA4 m:8886701CE12300000000AD2D
2013.04.07 04:47:19.439 1: HMLAN/RAW: /E1BF932,0000,211D07CB,FF,FFC3,FA86701BF93200000000DC25

2013.04.07 04:47:19.439 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:211D07CB d:FF r:FFC3 m:FA86701BF93200000000DC25
2013.04.07 04:47:26.943 1: HMLAN/RAW: /E1BF932,0000,211D251C,FF,FFC1,FBA4101BF932DE747406020C00000000

2013.04.07 04:47:26.943 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:211D251C d:FF r:FFC1 m:FBA4101BF932DE747406020C00000000
2013.04.07 04:47:26.944 1: HMLAN: manual ACK
2013.04.07 04:47:26.944 1: HMLAN: Skip ACK
2013.04.07 04:47:26.947 1: HMLAN: Skip ACK
2013.04.07 04:47:27.585 1: HMLAN/RAW: /E1BF932,0000,211D2624,FF,FFC2,FCA4101BF932DE747406020C00000000
E1BF932,0000,211D2725,FF,FFC0,FDA4101BF932DE747406020C00000000

2013.04.07 04:47:27.585 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:211D2624 d:FF r:FFC2 m:FCA4101BF932DE747406020C00000000
2013.04.07 04:47:27.586 1: HMLAN: manual ACK
2013.04.07 04:47:27.586 1: HMLAN: Skip ACK
2013.04.07 04:47:27.589 1: HMLAN: Skip ACK
2013.04.07 04:47:28.181 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:211D2725 d:FF r:FFC0 m:FDA4101BF932DE747406020C00000000
2013.04.07 04:47:28.181 1: HMLAN: manual ACK
2013.04.07 04:47:28.181 1: HMLAN: Skip ACK
2013.04.07 04:47:28.184 1: HMLAN: Skip ACK
2013.04.07 04:47:28.809 1: HMLAN_Send:  K
2013.04.07 04:47:28.812 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,211D2C70,0000

2013.04.07 04:47:28.812 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211D2C70 IDcnt:0000
2013.04.07 04:47:31.761 1: HMLAN/RAW: /E1CE123,0000,211D37EF,FF,FF9D,88A2581CE1231CF1E30200

2013.04.07 04:47:31.762 1: HMLAN_Parse: HMLAN1 S:E1CE123   stat:0000 t:211D37EF d:FF r:FF9D m:88A2581CE1231CF1E30200
2013.04.07 04:47:32.961 1: HMLAN/RAW: /E1CF1E3,0000,211D3874,FF,FFBB,8882021CF1E31CE123010100002F

2013.04.07 04:47:32.962 1: HMLAN_Parse: HMLAN1 S:E1CF1E3   stat:0000 t:211D3874 d:FF r:FFBB m:8882021CF1E31CE123010100002F
2013.04.07 04:47:39.439 1: HMLAN/RAW: /E1BF932,0000,211D55EE,FF,FFC3,FAA2581BF9321BFC150016

2013.04.07 04:47:39.439 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:211D55EE d:FF r:FFC3 m:FAA2581BF9321BFC150016
2013.04.07 04:47:40.594 1: HMLAN/RAW: /E1BFC15,0000,211D5672,FF,FFC5,FA82021BFC151BF9320101140031

2013.04.07 04:47:40.594 1: HMLAN_Parse: HMLAN1 S:E1BFC15   stat:0000 t:211D5672 d:FF r:FFC5 m:FA82021BFC151BF9320101140031
2013.04.07 04:47:53.821 1: HMLAN_Send:  K
2013.04.07 04:47:53.824 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,211D8E28,0000

2013.04.07 04:47:53.824 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211D8E28 IDcnt:0000
2013.04.07 04:47:55.228 1: HMLAN/RAW: /E1CDFBA,0000,211D939D,FF,FFCB,CD86701CDFBA00000000AD2D

2013.04.07 04:47:55.228 1: HMLAN_Parse: HMLAN1 S:E1CDFBA   stat:0000 t:211D939D d:FF r:FFCB m:CD86701CDFBA00000000AD2D
2013.04.07 04:48:15.228 1: HMLAN/RAW: /E1CDFBA,0000,211DE1C0,FF,FFCB,CDA2581CDFBA1CF1FC0037

2013.04.07 04:48:15.229 1: HMLAN_Parse: HMLAN1 S:E1CDFBA   stat:0000 t:211DE1C0 d:FF r:FFCB m:CDA2581CDFBA1CF1FC0037
2013.04.07 04:48:16.428 1: HMLAN/RAW: /E1CF1FC,0000,211DE244,FF,FFCB,CD82021CF1FC1CDFBA01012A0037

2013.04.07 04:48:16.428 1: HMLAN_Parse: HMLAN1 S:E1CF1FC   stat:0000 t:211DE244 d:FF r:FFCB m:CD82021CF1FC1CDFBA01012A0037
2013.04.07 04:48:18.823 1: HMLAN_Send:  K
2013.04.07 04:48:18.826 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,211DEFD6,0000

2013.04.07 04:48:18.826 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:211DEFD6 IDcnt:0000
2013.04.07 04:48:35.485 1: HMLAN/RAW: /E1CE75F,0000,211E30E4,FF,FFCA,8686701CE75F00000000B234


-------
Was mir noch aufgefallen ist: alle 20 Minuten (ziemlich genau) erkennt fhem, dass der HMLAN weg ist. Könnte ja normal sein, da er der reconnect immer nach 10 Sekunden erfolgt. Komisch ist das aber schon.
2013.04.07 04:30:10.147 1: HMLAN_Parse: HMLAN1 S:E1BF932   stat:0000 t:210D5289 d:FF r:FFC3 m:F3A2581BF9321C0ABF0019
2013.04.07 04:30:11.383 1: HMLAN_Send:  K
2013.04.07 04:30:11.384 1: HMLAN/RAW: /E1C0ABF,0000,210D530E,FF,FFC1,F382021C0ABF1BF9320101140047

2013.04.07 04:30:11.384 1: HMLAN_Parse: HMLAN1 S:E1C0ABF   stat:0000 t:210D530E d:FF r:FFC1 m:F382021C0ABF1BF9320101140047
2013.04.07 04:30:13.012 1: 192.168.1.50:1000 disconnected, waiting to reappear
2013.04.07 04:30:23.290 1: 192.168.1.50:1000 reappeared (HMLAN1)
2013.04.07 04:30:23.291 1: HMLAN_Send:  ADE7474
2013.04.07 04:30:23.291 1: HMLAN_Send:  C
2013.04.07 04:30:23.291 1: HMLAN_Send:  Y01,01,
2013.04.07 04:30:23.291 1: HMLAN_Send:  Y02,00,
2013.04.07 04:30:23.291 1: HMLAN_Send:  Y03,00,
2013.04.07 04:30:23.291 1: HMLAN_Send:  Y03,00,
2013.04.07 04:30:23.291 1: HMLAN_Send:  T18F396BF,04,00,00000000
2013.04.07 04:30:23.558 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0061959,139779,DE7474,210D85EE,0000
E1CDFBA,0000,210D6C19,FF,FFCC,C686701CDFBA00000000AE2D
I00,00,00,00
I00,00,00,00
I00,00,00,00
I00,00,00,00

2013.04.07 04:30:23.559 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:IEQ0061959 d:139779 O:DE7474 m:210D85EE IDcnt:0000
2013.04.07 04:30:23.559 1: HMLAN_Parse: HMLAN1 S:E1CDFBA   stat:0000 t:210D6C19 d:FF r:FFCC m:C686701CDFBA00000000AE2D
2013.04.07 04:30:31.698 1: HMLAN/RAW: /E1CE75F,0000,210DA6BC,FF,FFCA,7FA2581CE75F1CED2A0022

martinp876

Hi Thorsten,

der HMLAN sollte nicht alle 20min verschwinden. Das gibt immer eine totzeit in der Nachrichten verloren gehen koennen. Da kann es zu unterscheiden zwischen HW und FHEM kommen.
Prinzipiell sind 2 Ursachen bekannt, die HMLAN resetten
a) das WOL modul kann tot-zeiten erzeugen. Ist es im Einsatz?
b) lange response-zeiten von ethernet. Du kannst die Situation verbessern wenn du in HMLAN das Attribut respTime auf einen Wert zwischen 2 und 5 stellst. Mehr solltest du aber nicht einstellen.

zum Ventil:
um 4:47 ist der TC auf 6Grad eingestellt worden
4:50 hat er das Kommando 0% an den VD geschickt
4:55 - der VD stellwert fehlt!!!
4:58 - VD stellwert auf 7%

Was ich nicht sehe sind die Werte des VD. Hast du den VD nicht gepairt mit FHEM? Mir fehlen hier die events - oder hast du die in einem separatem logfile? Sollte man m.E. immer zusammen haben.

Wurde am TC etwas umgestellt und ist er sicher auf manuell? Nicht Central oder auto? Die Temp stellt sich immer wieder zurueck in den verschiedenen modes.

Gruss
Martin

ThorstenH

Hi Martin,

--
EDIT:
Was vielleicht noch erwähnenswert ist: ich habe mal zwei Zwischenstecker an fhem gepaired. Die liegen allerdings schon längere Zeit wieder in der Schublade (also nicht erreichbar). Ist das schlimm?

(siehe Anhang / see attachement)

--

hier die Logs der insgesamt 3 VDs.

Der TC ist ganz sicher auf manuell. Kein WOL Modul. Die VDs hatte ich wie anfangs beschrieben eingebunden. Kein hmPairForSec aktiv, nur den VD in den Anlernmodus gebracht. Daraufhin hat fhem per autocreate den VD angelegt. Mache ich das über ein "richtiges" Pairing, so sendet der VD an den TC *und* an fhem/HMLAN. Nicht ausprobiert, aber so war es mit den Fensterkontakten. Und wenn ich fhem/HMLAN mal nicht an hatte, dann blockierten die ziemlich lange im Status "orange", bis der Kontakt dann das Senden an fhem aufgegeben hat. Und ich will ja nur mitschreiben.

Kann ich denn die VD Logs und die TC Logs in eine Datei schreiben lassen? Ich hatte alles so gelassen, wie von fhem angelegt. Aber das könnte ich ja ändern (einfach nur die Pfade in den defines der FileLog Objekte auf einen gemeinsamen Wert ändern?).

"respTime" kann ich umstellen, allerdings passiert um diese Uhrzeit ziemlich wenig in meinem LAN. Aber ich probier's.

Nochmals vielen Dank für die Mühe, die du dir hier und generell mit fhem machst :-)

VD1:
2013-04-07_04:02:39 hm_cc_vd_wohnzimmer_fenster_mitte set_10 %
2013-04-07_04:02:39 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 10 %
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:02:40 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_04:10:13 hm_cc_vd_wohnzimmer_fenster_mitte set_10 %
2013-04-07_04:10:13 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 10 %
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:10:15 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_04:17:46 hm_cc_vd_wohnzimmer_fenster_mitte set_10 %
2013-04-07_04:17:46 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 10 %
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:17:47 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_04:25:20 hm_cc_vd_wohnzimmer_fenster_mitte set_10 %
2013-04-07_04:25:20 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 10 %
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:25:21 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_04:32:46 hm_cc_vd_wohnzimmer_fenster_mitte set_10 %
2013-04-07_04:32:46 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 10 %
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:32:47 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_04:40:13 hm_cc_vd_wohnzimmer_fenster_mitte set_9 %
2013-04-07_04:40:13 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 9 %
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte operState: errorTargetNotMet
2013-04-07_04:40:15 hm_cc_vd_wohnzimmer_fenster_mitte operStateErrCnt: 1
2013-04-07_04:47:39 hm_cc_vd_wohnzimmer_fenster_mitte set_9 %
2013-04-07_04:47:39 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 9 %
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 10 %
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte 10 %
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte operState: errorTargetNotMet
2013-04-07_04:47:40 hm_cc_vd_wohnzimmer_fenster_mitte operStateErrCnt: 1
2013-04-07_05:03:29 hm_cc_vd_wohnzimmer_fenster_mitte set_7 %
2013-04-07_05:03:29 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 7 %
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 7 %
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte 7 %
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_05:03:31 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget
2013-04-07_05:10:54 hm_cc_vd_wohnzimmer_fenster_mitte set_7 %
2013-04-07_05:10:54 hm_cc_vd_wohnzimmer_fenster_mitte ValveDesired: 7 %
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte ValvePosition: 7 %
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte 7 %
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte battery: ok
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte motorErr: ok
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte motor: stop
2013-04-07_05:10:55 hm_cc_vd_wohnzimmer_fenster_mitte operState: onTarget


VD2:
2013-04-07_04:00:21 hm_cc_vd_wohnzimmer_fenster_schrank set_10 %
2013-04-07_04:00:21 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 10 %
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:00:22 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_04:07:35 hm_cc_vd_wohnzimmer_fenster_schrank set_10 %
2013-04-07_04:07:35 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 10 %
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:07:36 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_04:14:47 hm_cc_vd_wohnzimmer_fenster_schrank set_10 %
2013-04-07_04:14:47 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 10 %
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:14:48 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_04:23:01 hm_cc_vd_wohnzimmer_fenster_schrank set_10 %
2013-04-07_04:23:01 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 10 %
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:23:02 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_04:30:10 hm_cc_vd_wohnzimmer_fenster_schrank set_10 %
2013-04-07_04:30:10 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 10 %
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:30:11 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_04:37:16 hm_cc_vd_wohnzimmer_fenster_schrank set_9 %
2013-04-07_04:37:16 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 9 %
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank operState: errorTargetNotMet
2013-04-07_04:37:17 hm_cc_vd_wohnzimmer_fenster_schrank operStateErrCnt: 1
2013-04-07_04:45:25 hm_cc_vd_wohnzimmer_fenster_schrank set_9 %
2013-04-07_04:45:25 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 9 %
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 10 %
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank 10 %
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank operState: errorTargetNotMet
2013-04-07_04:45:27 hm_cc_vd_wohnzimmer_fenster_schrank operStateErrCnt: 1
2013-04-07_04:53:32 hm_cc_vd_wohnzimmer_fenster_schrank set_0 %
2013-04-07_04:53:32 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 0 %
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 0 %
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank 0 %
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_04:53:33 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget
2013-04-07_05:00:33 hm_cc_vd_wohnzimmer_fenster_schrank set_7 %
2013-04-07_05:00:33 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 7 %
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 6 %
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank 6 %
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank operState: errorTargetNotMet
2013-04-07_05:00:34 hm_cc_vd_wohnzimmer_fenster_schrank operStateErrCnt: 1
2013-04-07_05:07:57 hm_cc_vd_wohnzimmer_fenster_schrank set_7 %
2013-04-07_05:07:57 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 7 %
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 6 %
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank 6 %
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank operState: errorTargetNotMet
2013-04-07_05:07:58 hm_cc_vd_wohnzimmer_fenster_schrank operStateErrCnt: 1
2013-04-07_05:16:04 hm_cc_vd_wohnzimmer_fenster_schrank set_7 %
2013-04-07_05:16:04 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 7 %
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 6 %
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank 6 %
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank operState: errorTargetNotMet
2013-04-07_05:16:05 hm_cc_vd_wohnzimmer_fenster_schrank operStateErrCnt: 1
2013-04-07_05:24:09 hm_cc_vd_wohnzimmer_fenster_schrank set_8 %
2013-04-07_05:24:09 hm_cc_vd_wohnzimmer_fenster_schrank ValveDesired: 8 %
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank ValvePosition: 8 %
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank 8 %
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank battery: ok
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank motorErr: ok
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank motor: stop
2013-04-07_05:24:10 hm_cc_vd_wohnzimmer_fenster_schrank operState: onTarget


VD3:
2013-04-07_04:04:42 hm_cc_vd_wohnzimmer_fenster_terasse set_10 %
2013-04-07_04:04:42 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 10 %
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:04:43 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:12:37 hm_cc_vd_wohnzimmer_fenster_terasse set_10 %
2013-04-07_04:12:37 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 10 %
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:12:39 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:20:31 hm_cc_vd_wohnzimmer_fenster_terasse set_10 %
2013-04-07_04:20:31 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 10 %
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:20:32 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:27:19 hm_cc_vd_wohnzimmer_fenster_terasse set_10 %
2013-04-07_04:27:19 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 10 %
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:27:20 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:35:08 hm_cc_vd_wohnzimmer_fenster_terasse set_9 %
2013-04-07_04:35:08 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 9 %
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:35:10 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:42:56 hm_cc_vd_wohnzimmer_fenster_terasse set_9 %
2013-04-07_04:42:56 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 9 %
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:42:58 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:50:43 hm_cc_vd_wohnzimmer_fenster_terasse set_0 %
2013-04-07_04:50:43 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 0 %
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 8 %
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse 8 %
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse operState: errorTargetNotMet
2013-04-07_04:50:44 hm_cc_vd_wohnzimmer_fenster_terasse operStateErrCnt: 1
2013-04-07_04:58:27 hm_cc_vd_wohnzimmer_fenster_terasse set_7 %
2013-04-07_04:58:27 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 7 %
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 0 %
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse 0 %
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse motor: opening
2013-04-07_04:58:28 hm_cc_vd_wohnzimmer_fenster_terasse operState: adjusting
2013-04-07_05:05:50 hm_cc_vd_wohnzimmer_fenster_terasse set_7 %
2013-04-07_05:05:50 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 7 %
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 7 %
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse 7 %
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_05:05:51 hm_cc_vd_wohnzimmer_fenster_terasse operState: onTarget
2013-04-07_05:13:36 hm_cc_vd_wohnzimmer_fenster_terasse set_7 %
2013-04-07_05:13:36 hm_cc_vd_wohnzimmer_fenster_terasse ValveDesired: 7 %
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse ValvePosition: 7 %
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse 7 %
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse battery: ok
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse motorErr: ok
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse motor: stop
2013-04-07_05:13:37 hm_cc_vd_wohnzimmer_fenster_terasse operState: onTarget


ThorstenH

Zu den HMLAN Aussetzern: fhem läuft bei mir auf einer Synology DS412+ mit aktiviertem Festplattenspindown. Nach 20 Minuten Inaktivität fährt die DS die Platten runter und bei Bedarf wieder hoch. Wie oft flusht fhem denn die Logs? Ich werde versuchsweise mal den Spindown abstellen.

EDIT:
Daran lag es nicht. Die HMLAN Aussetzer treten weiterhin auf. Nachdem ich genauer hingesehen habe, muss ich sogar sagen, dass ich dieses Problem weitaus häufiger habe, als nur alle 20 Minuten. das schwankt so von 2 bis 20 Minuten, meist alle paar Minuten ein Aussetzer. :-(

martinp876

Hi Thorsten,

zum HMLAN aussetzer: hast du respTime in HLMAN gesetzt?

Zur VD auswertung:

VD1: Problem um 4:32, 2 mal. Runterregeln um 1%. Koennte ein Rundungsfehler sein....
VD1: Problem um 4:55         regelwert fehlt

VD2: Problem um 4:37, 2 mal. Wie bei VD1
VD2: Problem um 5:00, 3 mal. Wieder 1% aenderung.

VD3: Problem, beginn unbekannt >2%. kann keine Rundungsfehler sein.

Es wurde wohl um 4:53 runtergeregelt. und vor 4:58 wieder hoch . Damit ist VD 2 und 3 einmal auf 0% gegangen. Die Info zu VD1 fehlt, evtl HMLAN disconnect?

VD2 war danach immer noch 1% offTarget und hat sich dann wieder gefangen. Koennte ein Rundungsfehler gewesen sein....

Summary
wenn wir einmal Rundungsfehler unterstellen hatte nur VD3 ein Problem >=2%.
Hat der sich selbst gefangen ?
Woher kommen die 0%? Manueller Eingriff?
Wirklich grosse Fehler sehe ich jetzt nicht.

Gruss
Martin

ThorstenH

Hi Martin,

ja habe ich (auf 3). Keine Änderung, der HMLAN disconnected immer noch genauso oft. Soll ich 5 noch ausprobieren?

Ich kann dir jetzt nicht ganz folgen, was die VD Analyse angeht. Die "0%" kamen doch dadurch, dass meine Frau am TC Mond/6°C um ca. 04:53 Uhr eingestellt hat (Betriebsart immer manuell). Das wäre ja genau richtig, da die Temperatur doch arg über 6°C war (ca. 22°C). Das Problem besteht eigentlich darin, dass kurz darauf alle VDs auf Geheiß des TCs munter weiter geregelt haben um die 22° zu halten. VD1 hat glaube ich noch nicht 1-mal mitbekommen, dass zeitweise actuator 0% war.

Folgende Disconnects hatte ich in diesem Zeitraum:
2013.04.07 04:30:13.012 1: 192.168.1.50:1000 disconnected, waiting to reappear
2013.04.07 04:30:23.290 1: 192.168.1.50:1000 reappeared (HMLAN1)
...
2013.04.07 04:57:58.277 1: 192.168.1.50:1000 disconnected, waiting to reappear
2013.04.07 04:58:08.553 1: 192.168.1.50:1000 reappeared (HMLAN1)
...
2013.04.07 05:13:39.339 1: 192.168.1.50:1000 disconnected, waiting to reappear
2013.04.07 05:13:49.617 1: 192.168.1.50:1000 reappeared (HMLAN1)

martinp876

nein, zeichne einmal auf:

attr global verbose 1
attr global mseclog 1
attr HMLAN1 loglevel 1

und ein paar disconnects aufzeichnen


ThorstenH

Für heute habe ich schon eine Menge aufgezeichnet: (Anhang)

martinp876

Hallo Thorsten,

das ist sehr aufschlussreich, das Verhalten hatte ich noch nicht gesehen. Entweder verpennt HMLAN die Antwort oder es geht etwas am Enthernet schief. Das ist schon eine Enttaeuschung fuer mich. Hier haette ich keine Probleme erwartet.
Ich gehe davon aus, dass alle deine Ethernet links auf full-duplex laufen.

Waere interessant die Ursache zu finden. Dazu ist ein Ethernet-trace notwendig. Kannst du so einen aufzeichnen? Muesstest du mit der FB machen, ein Capture einschalten.

Im allgemeinen Fall muesste man davon ausgehen, dass Nachrichten auf den Ethernet verloren gehen - in erheblichem ausmass. Beunruhigend.

Ich werden parallel in HMLAN ein repeat einbauen.

Gruss
Martin


ThorstenH

Hallo Martin,

da ich in letzter Zeit den Überblick über meine Geräte verloren habe, habe ich alle meine Geräte in einen anderen IP Adressraum verschoben. Nicht das ich irgendwo eine IP doppelt verwendet habe und das der Grund ist.

Mein HMLAN Adapter ist an einer Fritzbox7390 an Port 2 mit 100MBit (Green Mode) angeschlossen. Die Fritzbox7390 ist an Port 1 mit meinem DLink Switch verbunden (1000MBit). Vom Switch geht es zu meiner Synology Diskstation DS412+ auf dem FHEM läuft (perl v5.10.0).

Also ob das jetzt durchgehend full duplex ist, kann ich nicht sagen. Ich werde das noch untersuchen. Inzwischen habe ich wieder ein paar disconnects gehabt, also lag es wohl nicht an einer doppelten IP Vergabe.

Ethernet Trace...auf der Fritzbox? fhem läuft auf der Dosk Station... weiss nicht, wie ich da was aufzeichnen kann.

Grüße
Thorsten

martinp876

Hi,

wie du da aufzeichnen kannst weiss ich leider nicht, kommt darauf an, was du alles am laufen hast.
Zur Verdeutlichung, was ich gesehen habe. Immer wenn ein Disconnect gekommen ist, dann weil die Antwort ausgeblieben ist. Im Fehlerfall ist immer 1ms nach senden der "k" eine Message eines Device eingetroffen(besser:wurde verarbeitet):
Zitat00:09:31.937 1: HMLAN_Send:  K
00:09:31.938 1: HMLAN_Parse: HMLAN1 S:E1CED2A   stat:0000 t:2A6BBDA7 d:FF r:FFC2 m:8A82021CED2A1CE75F0101060040
00:09:37.020 1: 192.168.1.50:1000 disconnected, waiting to reappear

Dann kommt keine Antwort des HMLAN.
Moegliche Ursachen:
1 "k" wird nicht gesendet
2 hmlan empfaengt "k" nicht
3 hmlan verarbeitet "k" nicht
4 hmlan sendet antwort nicht
5 Server empfaengt antwort nicht
6 Server verwirft antwort vor FHEM

Wenn du es schaffst auf dem Ethernet zu monitoren koennen wir feststellen wer was real sendet.
Es haengt von deinen resources ab, ein Monitor port zu schalten.

Einbauen werde ich das wiederholen der "k" in jedem Fall, muss es noch testen. Evtl heute Abend.
Gruss
Martin

ThorstenH

Ich habe tcpdump auf der Disk Station installiert. Ich würde sagen hiermit:
tcpdump -i eth0 -s 0 -w $filename 'host 192.168.74.50'
sollte es möglich sein, einen dump zu erstellen, oder? Ich teste das mal und melde mich dann.
(192.168.74.50 ist mein HMLAN Adapter)

ThorstenH

Hi Martin,

jetzt kann ich einen Netzwerkdump schreiben, sehe aber, dass seit gestern abend kein disconnect mehr aufgetreten ist. Mein letztes update war ungefähr am "2013.04.12 22:45". Kann es sein dass du da schon diesen repeat eingebaut hast? Machst du einen Eintrag ins log wenn ein repeat stattgefunden hat?

Oder soll ich auf das 5.4 Release runterladen und damit sniffen?

Grüße
Thorsten

martinp876

Hi Thorsten,

ja,ein repeat ist schon drin.

Der Dump sollte funktionieren. Aufzeichnen kannst du besser mit der alten Version, geht aber auchmit der neuen,suchen ist nur ein bisschen anstrengender.

Gruss
Martin