Seit Update vom 05.02. ständige disconnected Meldungen vom HMLAN

C. Zimmermann · 17 Februar 2013, 10:03:46

Ich häng mich hier mal dran:
Seit SVN 2711 (aktuell 2744) disconnected mein HMLAN und verbindet sich nicht wieder. Ein FHEM Neustart oder Fritzbox Neustart (DHCP,FHEM) helfen leider nicht, ich muss manuell den Stecker kurz ziehen.
Ein Hintergrundprozess des Servers (Fritz) kann ich ausschließen, das Problem trat um 20:45:40 und wieder um 01:06:28 auf.

Hab nun wie oben beschrieben das Logging eingeschaltet

Zitatattr global mseclog 1
attr global verbose 1
attr <hmlan> hmProtocolEvents 1
attr <hmlan> loglevel 1

Sobald ich ein Disconnect Log habe, reiche ich das nach.

Grüße

C. Zimmermann · 17 Februar 2013, 10:43:49

Das ging ja schnell, während dem FHEM Update ist er mal wieder abgeraucht. Hier das Log:

Code Auswählen

2013.02.17 10:01:43.790 1: HMLAN_Parse: HML S:RE7633430 stat:0001 t:000EFEA4 d:FF r:FFB8 m:27800216A0511AF7C300
2013.02.17 10:01:43.806 1: RCV L:0A N:27 F:80 CMD:02 SRC:HeizungSchlafzimmer DST:1AF7C3 00 (ACK) (,RPTEN)
2013.02.17 10:01:43.890 1: HMLAN_Send:  SE763353D,00,00000000,01,E763353D,28A0111AF7C316A051020225
2013.02.17 10:01:43.896 1: SND L:0C N:28 F:A0 CMD:11 SRC:1AF7C3 DST:HeizungSchlafzimmer 020225 (SET CHANNEL:0x02 VALUE:0x25) (,BIDI,RPTEN)
2013.02.17 10:01:44.185 1: HMLAN/RAW: /RE763353D,0001,000F0038,FF,FFB9,28800216A0511AF7C30102250048

2013.02.17 10:01:44.188 1: HMLAN_Parse: HML S:RE763353D stat:0001 t:000F0038 d:FF r:FFB9 m:28800216A0511AF7C30102250048
2013.02.17 10:01:44.205 1: RCV L:0E N:28 F:80 CMD:02 SRC:HeizungSchlafzimmer DST:1AF7C3 0102250048 (ACK_STATUS CHANNEL:0x02 STATUS:0x25 UP:0x00 DOWN:0x00 LOWBAT:0x00 RSSI:0x48) (,RPTEN)
2013.02.17 10:01:51.336 0: Server shutdown
2013.02.17 10:01:54.906 1: Including fhem.cfg
2013.02.17 10:01:57.797 1: COC device is none, commands will be echoed only
2013.02.17 10:02:01.658 1: Including ./log/fhem.save
2013.02.17 10:02:02.833 0: Server started with 150 defined entities (version Fhem 5.3 (DEVELOPMENT), $Id: fhem.pl 2707 2013-02-12 12:56:55Z rudolfkoenig $, pid 12838)
2013.02.17 10:02:02.851 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0062139,13997F,1AF7C3,000F3552,0005
E16A241,0000,000F2C52,FF,FFB1,F1867016A24100000000C434
I00,00,00,00
I00,00,00,00
I00,00,00,00
I00,00,00,00

2013.02.17 10:02:02.853 1: HMLAN_Parse: HML V:03C1 sNo:IEQ0062139 d:13997F O:1AF7C3 m:000F3552 IDcnt:0005
2013.02.17 10:02:02.855 1: HMLAN_Parse: HML S:E16A241   stat:0000 t:000F2C52 d:FF r:FFB1 m:F1867016A24100000000C434
2013.02.17 10:02:02.871 1: RCV L:0C N:F1 F:86 CMD:70 SRC:HeizungBuero DST:broadcast 00C434 (WeatherEvent TEMP:0x00C4 HUM:0x34) (,WAKEMEUP,CFG,RPTEN)
2013.02.17 10:02:04.326 1: HMLAN/RAW: /E16A051,0000,000F4B94,FF,FFB8,CDA25816A0511611850000
E161185,0000,000F4C13,FF,FFB3,CD820216118516A0510101000033

2013.02.17 10:02:04.328 1: HMLAN_Parse: HML S:E16A051   stat:0000 t:000F4B94 d:FF r:FFB8 m:CDA25816A0511611850000
2013.02.17 10:02:04.343 1: RCV L:0B N:CD F:A2 CMD:58 SRC:HeizungSchlafzimmer DST:StellantriebSchlafzimmer 0000 (ClimateEvent CMD:0x00 ValvePos:0x00) (,WAKEMEUP,BIDI,RPTEN)
2013.02.17 10:02:04.443 1: HMLAN_Parse: HML S:E161185   stat:0000 t:000F4C13 d:FF r:FFB3 m:CD820216118516A0510101000033
2013.02.17 10:02:04.459 1: RCV L:0E N:CD F:82 CMD:02 SRC:StellantriebSchlafzimmer DST:HeizungSchlafzimmer 0101000033 (ACK_STATUS CHANNEL:0x01 STATUS:0x00 UP:0x00 DOWN:0x00 LOWBAT:0x00 RSSI:0x33) (,WAKEMEUP,RPTEN)
2013.02.17 10:02:15.481 1: HMLAN/RAW: /E16A241,0000,000F7A75,FF,FFB6,F1A25816A241161554035F

2013.02.17 10:02:15.483 1: HMLAN_Parse: HML S:E16A241   stat:0000 t:000F7A75 d:FF r:FFB6 m:F1A25816A241161554035F
2013.02.17 10:02:15.499 1: RCV L:0B N:F1 F:A2 CMD:58 SRC:HeizungBuero DST:StellantriebBuero 035F (ClimateEvent CMD:0x03 ValvePos:0x5F) (,WAKEMEUP,BIDI,RPTEN)
2013.02.17 10:02:15.613 1: HMLAN/RAW: /E161554,0000,000F7AF8,FF,FFC6,F1820216155416A241010156203A

2013.02.17 10:02:15.614 1: HMLAN_Parse: HML S:E161554   stat:0000 t:000F7AF8 d:FF r:FFC6 m:F1820216155416A241010156203A
2013.02.17 10:02:15.630 1: RCV L:0E N:F1 F:82 CMD:02 SRC:StellantriebBuero DST:HeizungBuero 010156203A (ACK_STATUS CHANNEL:0x01 STATUS:0x56 UP:0x20 DOWN:0x20 LOWBAT:0x20 RSSI:0x3A) (,WAKEMEUP,RPTEN)
2013.02.17 10:02:22.788 1: HMLAN_Send:  K
2013.02.17 10:02:22.794 1: HMLAN/RAW: /HHM-LAN-IF,03C1,IEQ0062139,13997F,1AF7C3,000F970E,0000

2013.02.17 10:02:22.796 1: HMLAN_Parse: HML V:03C1 sNo:IEQ0062139 d:13997F O:1AF7C3 m:000F970E IDcnt:0000
2013.02.17 10:02:45.480 1: update check Releases => local: Fhem 5.3 (DEVELOPMENT) remote: Fhem 5.3 (DEVELOPMENT)
2013.02.17 10:02:45.980 1: update saving statefile
2013.02.17 10:11:26.339 1: backup done: FHEM-20130217_100246.tar.gz (15407992 Bytes)
2013.02.17 10:11:27.719 1: update 8 file(s) have been updated.
2013.02.17 10:11:31.865 1: HMLAN_Send:  K
2013.02.17 10:11:31.878 1: 192.168.178.20:1000 disconnected, waiting to reappear
2013.02.17 10:11:37.537 1: 192.168.178.44:7072 disconnected, waiting to reappear
2013.02.17 10:11:42.640 1: FHEM2FHEM 192.168.178.44:7072 reappeared (ds1)
2013.02.17 10:37:09.593 1: HMLAN_Send:  +184436,00,00,
2013.02.17 10:37:09.595 1: HMLAN_Send:  SE783A516,00,00000000,01,E783A516,01A0111AF7C31844360201000000
2013.02.17 10:37:09.598 1: SND L:0E N:01 F:A0 CMD:11 SRC:1AF7C3 DST:LichtWohnzimmerDimmer 0201000000 (SET CHANNEL:0x01 VALUE:0x00 RAMPTIME:0x0000) (,BIDI,RPTEN)
2013.02.17 10:37:11.603 1: HMLAN_Send:  SE783ACED,00,00000000,01,E783ACED,01A0111AF7C31844360201000000
2013.02.17 10:37:15.131 1: HMLAN_Send:  +17E43C,00,00,
2013.02.17 10:37:15.133 1: HMLAN_Send:  SE783BAB7,00,00000000,01,E783BAB7,02A0111AF7C317E43C0201000000
2013.02.17 10:37:15.136 1: SND L:0E N:02 F:A0 CMD:11 SRC:1AF7C3 DST:JalousieWohnzimmer 0201000000 (SET CHANNEL:0x01 VALUE:0x00 RAMPTIME:0x0000) (,BIDI,RPTEN)
2013.02.17 10:37:16.487 1: HMLAN_Send:  SE783C001,00,00000000,01,E783C001,01A0111AF7C31844360201000000
2013.02.17 10:37:17.139 1: HMLAN_Send:  SE783C28E,00,00000000,01,E783C28E,02A0111AF7C317E43C0201000000
2013.02.17 10:37:18.425 1: HMLAN_Send:  +17591E,00,00,
2013.02.17 10:37:18.427 1: HMLAN_Send:  SE783C796,00,00000000,01,E783C796,03A0111AF7C317591E0201C80000
2013.02.17 10:37:18.430 1: SND L:0E N:03 F:A0 CMD:11 SRC:1AF7C3 DST:LichtEsszimmer 0201C80000 (SET CHANNEL:0x01 VALUE:0xC8 RAMPTIME:0x0000) (,BIDI,RPTEN)
2013.02.17 10:37:20.434 1: HMLAN_Send:  SE783CF6D,00,00000000,01,E783CF6D,03A0111AF7C317591E0201C80000
2013.02.17 10:37:21.860 1: HMLAN_Send:  SE783D4FF,00,00000000,01,E783D4FF,02A0111AF7C317E43C0201000000
2013.02.17 10:37:25.153 1: HMLAN_Send:  SE783E1DB,00,00000000,01,E783E1DB,03A0111AF7C317591E0201C80000

martinp876 · 17 Februar 2013, 11:08:16

wo ist der Disconnect?

Da ist einer nach einem update. Da kann HMLAN jetzt wenig tun - FHEM sichert seine Daten - single-threated, speichert daten, geht ins internet.
Eine outage von 9 Minuten - da kommt jeder keep-alive zu spaet.

Waehrend einem update ist FHEM tot - auch der keep-alive.

habe ich etwas übersehen? Sprichst du von etwas anderem?

C. Zimmermann · 17 Februar 2013, 11:21:18

Sorry hast vollkommen recht.
Der HMLAN hat die IP 192.168.178.20 ergo
2013.02.17 10:11:31.878 1: 192.168.178.20:1000 disconnected, waiting to reappear
spiegelt den Disc wieder. Dass die Daten außenrum bei einem Update nicht optimal sind, hatte ich nicht bedacht. Sobald ich wieder einen regulären Disc hab, poste ichs hier.

C. Zimmermann · 17 Februar 2013, 12:22:15

Nachtrag: Hab gerade feststellen müssen, dass ich auf dem FHEM Pi fälschlicherweise kein FHEM2FHEM für den HMLAN verwende, sondern direkt diesen anspreche. (Da ich diesen Fehler erst seit dem Cul_HM & Configabgeschnitten Bug drin habe, vermute ich, der HMLAN wird einfach durch die zwei auf ihn zugreifenden Installationen geflooded und steigt dadurch aus). Es liegt also wohl eher an meiner defekten Konfiguration als an HMLAN.
Vielen Dank für deine Mühe Martin!

Steffen · 18 Februar 2013, 05:57:15

Hallo!

So sieht es bei mir ständig aus, hier nur mal ein beispiel:
2013.02.17 09:40:25 2: dummy set ZuHause off
2013.02.17 09:41:25 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 09:52:16 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 09:52:26 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 10:00:00 2: CUL_HM set Rollo_Wz off rxt:1
2013.02.17 10:18:43 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 10:18:51 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 10:28:27 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 10:28:37 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 10:49:24 2: CUL_HM set Wz_DLampeDecke 65 rxt:1
2013.02.17 15:06:12 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 15:06:17 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 16:47:23 2: dummy set ZuHause on
2013.02.17 17:06:46 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 17:06:56 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 19:07:25 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 19:07:31 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 19:53:47 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 19:53:52 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 20:43:54 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 20:44:04 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 22:20:22 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 22:20:28 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 22:58:49 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 22:58:59 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.17 23:00:00 2: CUL_HM set Rollo_Wz on rxt:1
2013.02.17 23:32:46 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.17 23:32:56 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.18 01:45:28 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.18 01:45:38 1: 192.168.178.26:1000 reappeared (HMLAN1)
2013.02.18 03:58:11 1: 192.168.178.26:1000 disconnected, waiting to reappear
2013.02.18 03:58:16 1: 192.168.178.26:1000 reappeared (HMLAN1)

und das schon eine sehr lange Zeit so, habe auch schon Test weise WOL entfernt weil ich gehört hatte könnte auch was damit zu tun haben haben,
aber genau das Gleiche.
System:
Qnap ts119 mit Debian
Fhem 5.3 (DEVELOPMENT), $Id: fhem.pl 2707 2013-02-12 12:56:55Z rudolfkoenig $, pid 16934
HMLAN

Vielleicht kennt jemand ja doch eine Lösung???

Mfg Steffen

martinp876 · 18 Februar 2013, 07:33:30

kannst du einmal die messages loggen?

attr global mseclog 1
attr global verbose 1
attr <hmlan> hmProtocolEvents 1
attr <hmlan> loglevel 1

Gruss
Martin

Steffen · 18 Februar 2013, 17:47:33

Zitat von: martinp876 schrieb am Mo, 18 Februar 2013 07:33kannst du einmal die messages loggen?

attr global mseclog 1
attr global verbose 1
attr <hmlan> hmProtocolEvents 1
attr <hmlan> loglevel 1

Gruss
Martin

Hallo!

Konnte erst jetzt ein Log erstellen, anbei als Text.datei!
Hoffe das reicht schon mal?!
Danke schon mal für deine Hilfe...
Mfg Steffen

martinp876 · 19 Februar 2013, 08:45:23

Den log verstehe ich nicht wirklich.

restart 11:04
Zwischen 11:31 und 15:37 einigen disconnects - aber da waren keine logs eingeschaltet? Oder es hat garnichts funktioniert.
Waren wohl eher keine logs an - von 11:04 bis 11:30 war alles ok.

Die Logs wurden um 17:38 eingeschaltet und dann bis 17:42 geloggt.
hmProtocolEvents ist auch nicht aus.

Du musst schon einen Fehlerfall mit den traces wie beschrieben loggen - was soll ich den sonst ansehen?
Sorry, falls das nicht klar war

Gruss
Martin

Steffen · 19 Februar 2013, 19:41:11

Zitat von: martinp876 schrieb am Di, 19 Februar 2013 08:45Den log verstehe ich nicht wirklich.

restart 11:04
Zwischen 11:31 und 15:37 einigen disconnects - aber da waren keine logs eingeschaltet? Oder es hat garnichts funktioniert.
Waren wohl eher keine logs an - von 11:04 bis 11:30 war alles ok.

Die Logs wurden um 17:38 eingeschaltet und dann bis 17:42 geloggt.
hmProtocolEvents ist auch nicht aus.

Du musst schon einen Fehlerfall mit den traces wie beschrieben loggen - was soll ich den sonst ansehen?
Sorry, falls das nicht klar war

Gruss
Martin

Hallo!
Ja sorry, das war noch vor dem Log, dachte könntest damit schon mal was anfagen.
So habe jetzt nochmal so eingestellt und hoffe es ist jetzt das Richtige?!
In Anlage:log cfg
Danke für deine geduld:-)
Mfg Steffen

martinp876 · 20 Februar 2013, 07:57:15

Hi Steffen,

ja, damit kann ich etwas anfangen.
Das Problem in deinem Fall ist nicht ein ausbleibendes keep-alive. Es gibt bei dir mit unter delays bei den Antworten den HMLAN.
Normal antwortet der HMLAN in <10ms - meist ist die Antwort nach 4ms verarbeitet.
In deinem System kommt es vor, dass die Antwort 200 oder auch 600ms ausbleibt. Nach 1sec starte ich ein reconnect.
Dies verkuerzt die Outage wenn der HMLAN sich kurzfristig verabschiedet hat.

In deinem system scheinen nun delays ueber 1sec haeufig vorzukommen. Kann das ethernet ausgelastet sein oder deine CPU an grenzen stossen? 1 sec ist schon eine Hausnummer in einem lokael Netz fuer einen quasi-ping.

Im Anhang eine SW mit erweitertem Fenster. Evtl kannst du einmal loggen und wir koennen versuchen festzustennen, wie lange dein System so braucht

Gruss
Martin

Jumbo · 20 Februar 2013, 08:14:24

Ich hab dann auch hier noch ein paar disconnects :

Code Auswählen

2013.02.17 20:37:03.017 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:82E46CA9 IDcnt:0000
2013.02.17 20:37:34.913 1: HMLAN_Send:  K
2013.02.17 20:37:34.917 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,82E4CE67,0000

2013.02.17 20:37:34.918 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:82E4CE67 IDcnt:0000
2013.02.17 20:37:57.417 1: 192.168.1.56:1000 disconnected, waiting to reappear
2013.02.17 20:38:02.449 1: 192.168.1.56:1000 reappeared (HMLAN1)
2013.02.17 20:38:02.512 1: HMLAN_Send:  A123ABC
2013.02.17 20:38:02.513 1: HMLAN_Send:  C
2013.02.17 20:38:02.514 1: HMLAN_Send:  Y01,01,
2013.02.17 20:38:02.514 1: HMLAN_Send:  Y02,00,
2013.02.17 20:38:02.515 1: HMLAN_Send:  Y03,00,
2013.02.17 20:38:02.515 1: HMLAN_Send:  Y03,00,
2013.02.17 20:38:02.516 1: HMLAN_Send:  T18B3E00A,04,00,00000000
2013.02.17 20:38:02.536 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,82E555C7,0000
I00,00,00,00

2013.02.17 20:38:02.537 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:82E555C7 IDcnt:0000
2013.02.17 20:38:02.538 1: HMLAN/RAW: /I00,00,00,00
I00,00,00,00
I00,00,00,00

2013.02.17 20:38:27.530 1: HMLAN_Send:  K
2013.02.17 20:38:27.534 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,82E5B7B7,0000

2013.02.17 20:38:27.535 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:82E5B7B7 IDcnt:0000
2013.02.17 20:38:52.563 1: HMLAN_Send:  K
2013.02.17 20:38:52.567 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,82E61976,0000

Code Auswählen

2013.02.18 04:11:42.285 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:84849E52 IDcnt:0000
2013.02.18 04:12:07.313 1: HMLAN_Send:  K
2013.02.18 04:12:07.317 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,84850011,0000

2013.02.18 04:12:07.318 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:84850011 IDcnt:0000
2013.02.18 04:12:29.405 1: 192.168.1.56:1000 disconnected, waiting to reappear
2013.02.18 04:12:34.443 1: 192.168.1.56:1000 reappeared (HMLAN1)
2013.02.18 04:12:34.444 1: HMLAN_Send:  A123ABC
2013.02.18 04:12:34.444 1: HMLAN_Send:  C
2013.02.18 04:12:34.445 1: HMLAN_Send:  Y01,01,
2013.02.18 04:12:34.445 1: HMLAN_Send:  Y02,00,
2013.02.18 04:12:34.446 1: HMLAN_Send:  Y03,00,
2013.02.18 04:12:34.446 1: HMLAN_Send:  Y03,00,
2013.02.18 04:12:34.447 1: HMLAN_Send:  T18B44A92,04,00,00000000
2013.02.18 04:12:34.469 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,848588AD,0000

2013.02.18 04:12:34.502 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:848588AD IDcnt:0000
2013.02.18 04:12:37.440 1: HMLAN/RAW: /I00,00,00,00
I00,00,00,00
I00,00,00,00
I00,00,00,00

2013.02.18 04:12:59.459 1: HMLAN_Send:  K
2013.02.18 04:12:59.463 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,8485EA5B,0000

2013.02.18 04:12:59.464 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:8485EA5B IDcnt:0000
2013.02.18 04:13:24.481 1: HMLAN_Send:  K
2013.02.18 04:13:24.485 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,84864C10,0000

Code Auswählen

2013.02.18 07:10:40.804 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:85287F18 IDcnt:0000
2013.02.18 07:11:05.812 1: HMLAN_Send:  K
2013.02.18 07:11:05.816 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,8528E0C3,0000

2013.02.18 07:11:05.816 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:8528E0C3 IDcnt:0000
2013.02.18 07:11:27.079 1: 192.168.1.56:1000 disconnected, waiting to reappear
2013.02.18 07:11:32.112 1: 192.168.1.56:1000 reappeared (HMLAN1)
2013.02.18 07:11:32.215 1: HMLAN_Send:  A123ABC
2013.02.18 07:11:32.216 1: HMLAN_Send:  C
2013.02.18 07:11:32.216 1: HMLAN_Send:  Y01,01,
2013.02.18 07:11:32.217 1: HMLAN_Send:  Y02,00,
2013.02.18 07:11:32.218 1: HMLAN_Send:  Y03,00,
2013.02.18 07:11:32.218 1: HMLAN_Send:  Y03,00,
2013.02.18 07:11:32.219 1: HMLAN_Send:  T18B47484,04,00,00000000
2013.02.18 07:11:32.239 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,852965E0,0000
I00,00,00,00

2013.02.18 07:11:32.240 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:852965E0 IDcnt:0000
2013.02.18 07:11:32.463 1: HMLAN/RAW: /I00,00,00,00
I00,00,00,00
I00,00,00,00

2013.02.18 07:11:57.223 1: HMLAN_Send:  K
2013.02.18 07:11:57.226 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,8529C7ED,0000

2013.02.18 07:11:57.227 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:8529C7ED IDcnt:0000
2013.02.18 07:12:22.235 1: HMLAN_Send:  K
2013.02.18 07:12:22.239 1: HMLAN/RAW: /HHM-LAN-IF,03C1,JEQ0315823,1C6536,123ABC,852A2998,0000

2013.02.18 07:12:22.240 1: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0315823 d:1C6536 O:123ABC m:852A2998 IDcnt:0000
2013.02.18 07:12:34.159 1: HMLAN/RAW: /E1B4688,0000,852A581C,FF,FFB2,12A4101B4688123ABC0601C800

die hab ich so kreuz und quer durch den Tag.

ne ahnung was das sein kann ?

Danke

kossmann · 20 Februar 2013, 08:55:49

Zitat von: martinp876 schrieb am Mi, 20 Februar 2013 07:571 sec ist schon eine Hausnummer in einem lokael Netz fuer einen quasi-ping.

Hallo Martrin,
mit "Hausnummer" umschreibst du das ganze etwas zu schön. Das ist eine Katastrophe! In 1000ms bin ich 3 mal in Australien (kompletter RoundTrip).

Hallo Steffen,
auf welcher Hardware läuft FHEM bei dir und wie sieht die Verkabelung zum HMLAN aus? Bei mir sind zwischen eeeBox und HMLAN zwei Switche und die entsprechenden Kabel. Zum Vergleich: Ein ping <IP des HMLAN> liefert Zeiten von <0,5ms.
Probiere vom FHEM-System (worauf auch immer es läuft) bitte mal diverse pings auf diverse Geräte in deinem Netz (PC, Smart-TV, Router, HMLAN, ...) und poste die Laufzeiten.

Steffen · 20 Februar 2013, 09:22:13

Zitat von: kossmann schrieb am Mi, 20 Februar 2013 08:55
Zitat von: martinp876 schrieb am Mi, 20 Februar 2013 07:571 sec ist schon eine Hausnummer in einem lokael Netz fuer einen quasi-ping.
Hallo Martrin,
mit "Hausnummer" umschreibst du das ganze etwas zu schön. Das ist eine Katastrophe! In 1000ms bin ich 3 mal in Australien (kompletter RoundTrip).

Hallo Steffen,
auf welcher Hardware läuft FHEM bei dir und wie sieht die Verkabelung zum HMLAN aus? Bei mir sind zwischen eeeBox und HMLAN zwei Switche und die entsprechenden Kabel. Zum Vergleich: Ein ping <IP des HMLAN> liefert Zeiten von <0,5ms.
Probiere vom FHEM-System (worauf auch immer es läuft) bitte mal diverse pings auf diverse Geräte in deinem Netz (PC, Smart-TV, Router, HMLAN, ...) und poste die Laufzeiten.

Hallo!

Hier mal ein ping vom pc:

Microsoft Windows [Version 6.1.7601]
Copyright (c) 2009 Microsoft Corporation. Alle Rechte vorbehalten.

C:\Users\Administrator>ping 192.168.178.19 """TV"""

Ping wird ausgeführt für 192.168.178.19 mit 32 Bytes Daten:
Antwort von 192.168.178.19: Bytes=32 Zeit=3ms TTL=64
Antwort von 192.168.178.19: Bytes=32 Zeit=3ms TTL=64
Antwort von 192.168.178.19: Bytes=32 Zeit=4ms TTL=64
Antwort von 192.168.178.19: Bytes=32 Zeit=3ms TTL=64

Ping-Statistik für 192.168.178.19:
Pakete: Gesendet = 4, Empfangen = 4, Verloren = 0
(0% Verlust),
Ca. Zeitangaben in Millisek.:
Minimum = 3ms, Maximum = 4ms, Mittelwert = 3ms

C:\Users\Administrator>ping 192.168.178.26 """HMLAM"""

Ping wird ausgeführt für 192.168.178.26 mit 32 Bytes Daten:
Antwort von 192.168.178.26: Bytes=32 Zeit<1ms TTL=128
Antwort von 192.168.178.26: Bytes=32 Zeit<1ms TTL=128
Antwort von 192.168.178.26: Bytes=32 Zeit<1ms TTL=128
Antwort von 192.168.178.26: Bytes=32 Zeit<1ms TTL=128

Ping-Statistik für 192.168.178.26:
Pakete: Gesendet = 4, Empfangen = 4, Verloren = 0
(0% Verlust),
Ca. Zeitangaben in Millisek.:
Minimum = 0ms, Maximum = 0ms, Mittelwert = 0ms

C:\Users\Administrator>ping 192.168.178.58 """QNAP TS 119 II"""

Ping wird ausgeführt für 192.168.178.58 mit 32 Bytes Daten:
Antwort von 192.168.178.58: Bytes=32 Zeit<1ms TTL=64
Antwort von 192.168.178.58: Bytes=32 Zeit<1ms TTL=64
Antwort von 192.168.178.58: Bytes=32 Zeit<1ms TTL=64
Antwort von 192.168.178.58: Bytes=32 Zeit<1ms TTL=64

Ping-Statistik für 192.168.178.58:
Pakete: Gesendet = 4, Empfangen = 4, Verloren = 0
(0% Verlust),
Ca. Zeitangaben in Millisek.:
Minimum = 0ms, Maximum = 0ms, Mittelwert = 0ms

C:\Users\Administrator>ping 192.168.178.1 """Fritzbox""" aber über dLan 200avplus(ethernet über Strom)

Ping wird ausgeführt für 192.168.178.1 mit 32 Bytes Daten:
Antwort von 192.168.178.1: Bytes=32 Zeit=4ms TTL=64
Antwort von 192.168.178.1: Bytes=32 Zeit=3ms TTL=64
Antwort von 192.168.178.1: Bytes=32 Zeit=3ms TTL=64
Antwort von 192.168.178.1: Bytes=32 Zeit=3ms TTL=64

Ping-Statistik für 192.168.178.1:
Pakete: Gesendet = 4, Empfangen = 4, Verloren = 0
(0% Verlust),
Ca. Zeitangaben in Millisek.:
Minimum = 3ms, Maximum = 4ms, Mittelwert = 3ms

C:\Users\Administrator>

Hier jetzt das ping vom Qnap(Debian):

root@NASC87667:~# ping 192.168.178.26
PING 192.168.178.26 (192.168.178.26) 56(84) bytes of data.
64 bytes from 192.168.178.26: icmp_req=1 ttl=128 time=302 ms
64 bytes from 192.168.178.26: icmp_req=2 ttl=128 time=0.318 ms
64 bytes from 192.168.178.26: icmp_req=3 ttl=128 time=0.329 ms
64 bytes from 192.168.178.26: icmp_req=4 ttl=128 time=0.335 ms
64 bytes from 192.168.178.26: icmp_req=5 ttl=128 time=0.342 ms
64 bytes from 192.168.178.26: icmp_req=6 ttl=128 time=0.337 ms
64 bytes from 192.168.178.26: icmp_req=7 ttl=128 time=0.355 ms
64 bytes from 192.168.178.26: icmp_req=8 ttl=128 time=0.298 ms
64 bytes from 192.168.178.26: icmp_req=9 ttl=128 time=0.336 ms
64 bytes from 192.168.178.26: icmp_req=10 ttl=128 time=0.377 ms
64 bytes from 192.168.178.26: icmp_req=11 ttl=128 time=0.347 ms
64 bytes from 192.168.178.26: icmp_req=12 ttl=128 time=0.369 ms
64 bytes from 192.168.178.26: icmp_req=13 ttl=128 time=0.340 ms
64 bytes from 192.168.178.26: icmp_req=14 ttl=128 time=0.302 ms
64 bytes from 192.168.178.26: icmp_req=15 ttl=128 time=0.336 ms
64 bytes from 192.168.178.26: icmp_req=16 ttl=128 time=0.347 ms
64 bytes from 192.168.178.26: icmp_req=17 ttl=128 time=0.303 ms
64 bytes from 192.168.178.26: icmp_req=18 ttl=128 time=0.338 ms
64 bytes from 192.168.178.26: icmp_req=19 ttl=128 time=0.334 ms
64 bytes from 192.168.178.26: icmp_req=20 ttl=128 time=0.319 ms
64 bytes from 192.168.178.26: icmp_req=21 ttl=128 time=0.325 ms
64 bytes from 192.168.178.26: icmp_req=22 ttl=128 time=0.366 ms
64 bytes from 192.168.178.26: icmp_req=23 ttl=128 time=0.359 ms
64 bytes from 192.168.178.26: icmp_req=24 ttl=128 time=0.373 ms
64 bytes from 192.168.178.26: icmp_req=25 ttl=128 time=0.348 ms
64 bytes from 192.168.178.26: icmp_req=26 ttl=128 time=0.316 ms
64 bytes from 192.168.178.26: icmp_req=27 ttl=128 time=0.401 ms
64 bytes from 192.168.178.26: icmp_req=28 ttl=128 time=0.347 ms

PING 192.168.178.1 (192.168.178.1) 56(84) bytes of data.
64 bytes from 192.168.178.1: icmp_req=1 ttl=64 time=3.44 ms
64 bytes from 192.168.178.1: icmp_req=2 ttl=64 time=3.38 ms
64 bytes from 192.168.178.1: icmp_req=3 ttl=64 time=3.52 ms
64 bytes from 192.168.178.1: icmp_req=4 ttl=64 time=3.42 ms
64 bytes from 192.168.178.1: icmp_req=5 ttl=64 time=3.37 ms
64 bytes from 192.168.178.1: icmp_req=6 ttl=64 time=3.30 ms
64 bytes from 192.168.178.1: icmp_req=7 ttl=64 time=4.79 ms
64 bytes from 192.168.178.1: icmp_req=8 ttl=64 time=3.36 ms
64 bytes from 192.168.178.1: icmp_req=9 ttl=64 time=4.12 ms
64 bytes from 192.168.178.1: icmp_req=10 ttl=64 time=4.00 ms
64 bytes from 192.168.178.1: icmp_req=11 ttl=64 time=3.38 ms
64 bytes from 192.168.178.1: icmp_req=12 ttl=64 time=4.03 ms

...habe ein switch(Gigabit), was zwischen HMLAN und Qnap(fhem) sitzt!

Mfg Steffen

Martin Thomas Schrott · 20 Februar 2013, 09:25:10

Hi zusammen,

jetzt bin ich neugierig, könnt ihr mir verraten, wie ich meinen hmlan pingen kann, wenn fhem verbunden ist? Ich habe fhem extern lauen und den hmlan über das Internet verbunden und hatte noch nie Probleme mit irgendwelchen delays. Würde jetzt gerne nachsehen wie lange ich hin und zurück brauche ;-)
LG
M