Problem beim Reconnect des HMLAN nach gewollten Disconnect

Begonnen von StefanD, 09 Februar 2015, 21:09:18

Vorheriges Thema - Nächstes Thema

StefanD

Nachdem mir die Suche und Google keine passenden Treffer geliefert hat, muss ich doch ein neues Thema aufmachen.

Da ich großen Wert darauf lege, dass die grundlegende zeitlich gesteuerte Temperierung der Räume auch ohne FHEM funktioniert, arbeiten meine HM-Thermostate und Regler mit den intern gespeicherten Konfigurationen. Meine Regierung würde mich killen, wenn während meiner (längeren) Abwesenheit das Haus zum Kühlschrank oder Sauna wird, nur weil FHEM, aus welchen Gründen auch immer, nicht läuft... FHEM nutze ich nur im Bedarfsfall zum Übersteuern dieser Konfigurationen. Auch wenn ich die Konfigurationen per FHEM an die HM-Geräte übertragen kann, bevorzuge ich noch das GUI von HM zur Konfiguration. Da zum HMLAN nur eine Verbindung bestehen kann, ändere ich über DEF des HMLAN Device die IP, so dass FHEM nicht mehr damit kommuniziert. Nach dem ich mit dem HM-GUI fertig bin und es geschlossen habe, passe ich die IP in FHEM wieder an. FHEM unternimmt dann, nach den Einträgen im FHEM Logfile nach zu schließen, auch den Versuch, sich wieder zu verbinden, schafft das aber nicht mehr:
2015.02.09 20:34:45 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.02.09 20:34:46 3: Opening HMLAN1 device 192.168.1.201:1000
2015.02.09 20:34:49 3: Can't connect to 192.168.254.201:1000: Connection timed out
2015.02.09 20:35:05 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.02.09 20:35:05 3: Opening HMLAN1 device 192.168.1.20:1000


Erst wenn ich shutdown restart ausführe, klappt es wieder mit der Kommunikation zwischen FHEM und dem HMLAN:

2015.02.09 20:38:13 0: Server shutdown
2015.02.09 20:38:16 1: Including fhem.cfg
2015.02.09 20:38:16 3: telnetPort: port 7072 opened
2015.02.09 20:38:16 3: WEB: port 8083 opened
2015.02.09 20:38:16 3: WEBphone: port 8084 opened
2015.02.09 20:38:16 3: WEBtablet: port 8085 opened
2015.02.09 20:38:16 2: eventTypes: loaded 5282 events from ./log/eventTypes.txt
2015.02.09 20:38:16 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.02.09 20:38:16 3: Opening HMLAN1 device 192.168.1.20:1000
2015.02.09 20:38:16 3: HMLAN1 device opened
2015.02.09 20:38:16 1: HMLAN_Parse: HMLAN1 new condition init


Ich kann mir das nur dadurch erklären, dass die Verbindung durch das Ändern der HM-Konfiguration nicht sauber zurückgesetzt wird, bevor der Neuaufbau/Reconnect versucht wird.

Wäre es nicht eine Option, beim HMLAN Device auch das Disable Attribut einzuführen, mit dem man die Verbindung recht elegant de- und wieder aktivieren kann?

Viele Grüße
Stefan
HW: Intel NUC8i5 mit ESXi7 mit Ubuntu Server 18.04 LTS und FHEM als DockerContainer

LuckyDay


StefanD

Das habe ich vor einiger Zeit schon mal probiert, was mich dabei aber irritiert hat war, dass der state auf opened geblieben ist.

Ich habe das eben mal ausprobiert. Das HM-GUI hat mit gesetztem dummy = 1 mit dem HMLAN verbunden und konnte ein Device umkonfigurieren. Als ich aber dummy auf 0 gesetzt habe, war die Verbindung FEHM <-> HMLAN ltd. Log zwar wieder ok, aber das absetzen von Befehlen funktionierte erst wieder, als ich shutdown restart ausgeführt habe:
2015.02.10 15:57:43 1: HMLAN_Parse: HMLAN1 new condition dummy
2015.02.10 15:59:36 1: 192.168.254.20:1000 reappeared (HMLAN1)
2015.02.10 15:59:36 1: HMLAN_Parse: HMLAN1 new condition init
2015.02.10 15:59:36 1: HMLAN_Parse: HMLAN1 new condition ok
2015.02.10 16:00:00 3: CUL_HM set kg_hr_Warmwasserpumpe_Btn1 on


Tut also nicht so, wie du das beschreibst, bzw. andeutest.  ???

Viele Grüße
Stefan
HW: Intel NUC8i5 mit ESXi7 mit Ubuntu Server 18.04 LTS und FHEM als DockerContainer

stromer-12

Also bei mir klappt es mit dem dummy.
Dummy gesetzt, mit der HM-Software umkonfiguriert, HM-Software beendet und dummy gelöscht.

Gesendet von meinem GT-I9295

FHEM (SVN) auf RPi1B mit HMser | ESPLink
FHEM (SVN) virtuell mit HMLAN | HMUSB | CUL

StefanD

Ok, besten Dank fürs Testen!  :)
Dann muss bei mir der Hase anderweitig im Pfeffer liegen. Werde mal mit Level 5 logging das ganze durchspielen...  :o

Viele Grüße
Stefan
HW: Intel NUC8i5 mit ESXi7 mit Ubuntu Server 18.04 LTS und FHEM als DockerContainer

StefanD

Soderle hier nochmal der Auszug aus dem FHEM-Log mit verbose Level 5:

2015.02.10 16:46:46 5: Triggering global (1 changes)
2015.02.10 16:46:46 5: Notify loop for global ATTR global verbose 5
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem?detail=global
2015.02.10 16:46:46 4: 11282:FHEMWEB:192.168.0.21:61439: /fhem?detail=global / RL:3268 / text/html; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:46:46 4: Connection closed for FHEMWEB:192.168.0.21:61276: EOF
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/style.css
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/jquery-ui.min.css
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/jquery.min.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/jquery-ui.min.js
2015.02.10 16:46:46 4: Connection accepted from FHEMWEB:192.168.0.21:61442
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61442 GET /fhem/pgm2/fhemweb.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/fhemweb_knob.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/fhemweb_colorpicker.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/fhemweb_readingsGroup.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61442 GET /fhem/pgm2/fhemweb_readingsHistory.js
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/images/default/icoEverything.png
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/defaultCommon.css
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/dashboard_style.css
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/images/default/fhemicon.png
2015.02.10 16:46:46 4: HTTP FHEMWEB:192.168.0.21:61442 GET /fhem?cmd={AttrVal(%22global%22,%22room%22,%22%22)}&XHR=1
2015.02.10 16:46:46 5: Cmd: >{AttrVal("global","room","")}<
2015.02.10 16:46:46 4: 11282:FHEMWEB:192.168.0.21:61442: /fhem?cmd={AttrVal(%22global%22,%22room%22,%22%22)}&XHR=1 / RL:28 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:46:47 4: HTTP FHEMWEB:192.168.0.21:61442 GET /fhem?XHR=1&inform=type=status;filter=global;since=1423583205;fmt=JSON&timestamp=1423583214131
2015.02.10 16:46:47 5: HMLAN_Send:  HMLAN1 I:K
2015.02.10 16:46:47 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0383565,<owner>,<owner>,016DACFF,001B,05

2015.02.10 16:46:47 5: HMLAN_Parse: HMLAN1 V:03C4 sNo:LEQ0383565 d:<owner> O:<owner> t:016DACFF IDcnt:001B
2015.02.10 16:46:55 5: HMLAN/RAW: /E2BBE4F,0000,016DCC82,FF,FFC6,5D86702BBE4F000000002958

2015.02.10 16:46:55 5: HMLAN_Parse: HMLAN1 R:E2BBE4F   stat:0000 t:016DCC82 d:FF r:FFC6     m:5D 8670 2BBE4F 000000 002958
2015.02.10 16:46:55 5: HMLAN1 dispatch A0C5D86702BBE4F000000002958::-58:HMLAN1
2015.02.10 16:47:00 4: BlockingCall created child (13519), uses telnetForBlockingFn to connect back
2015.02.10 16:47:00 4: BlockingCall created child (13520), uses telnetForBlockingFn to connect back
2015.02.10 16:47:00 4: Connection accepted from telnet:127.0.0.1:49707
2015.02.10 16:47:00 4: Connection accepted from telnet:127.0.0.1:49706
2015.02.10 16:47:00 5: Cmd: >{PRESENCE_ProcessLocalScan('prse_R2D2|0|absent')}<
2015.02.10 16:47:00 5: Cmd: >{PRESENCE_ProcessLocalScan('prse_Stefans_G3|0|absent')}<
2015.02.10 16:47:04 5: HMLAN/RAW: /E303371,0000,016DEF69,FF,FFC8,30847030337100000000CC24

2015.02.10 16:47:04 5: HMLAN_Parse: HMLAN1 R:E303371   stat:0000 t:016DEF69 d:FF r:FFC8     m:30 8470 303371 000000 00CC24
2015.02.10 16:47:04 5: HMLAN1 dispatch A0C30847030337100000000CC24::-56:HMLAN1
2015.02.10 16:47:05 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem?cmd={AttrVal(%22HMLAN1%22,%22dummy%22,%22%22)}&XHR=1
2015.02.10 16:47:05 5: Cmd: >{AttrVal("HMLAN1","dummy","")}<
2015.02.10 16:47:05 4: 11282:FHEMWEB:192.168.0.21:61436: /fhem?cmd={AttrVal(%22HMLAN1%22,%22dummy%22,%22%22)}&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:05 5: HMLAN/RAW: /E2E5F26,0000,016DF311,FF,FFBA,D386102E5F260000000AA0D20F1800

2015.02.10 16:47:05 5: HMLAN_Parse: HMLAN1 R:E2E5F26   stat:0000 t:016DF311 d:FF r:FFBA     m:D3 8610 2E5F26 000000 0AA0D20F1800
2015.02.10 16:47:05 5: HMLAN1 dispatch A0FD386102E5F260000000AA0D20F1800::-70:HMLAN1
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem&detail=HMLAN1&dev.attrHMLAN1=HMLAN1&cmd.attrHMLAN1=attr&arg.attrHMLAN1=dummy&val.attrHMLAN1=1
2015.02.10 16:47:06 5: Cmd: >attr HMLAN1 dummy 1<
2015.02.10 16:47:06 1: HMLAN_Parse: HMLAN1 new condition dummy
2015.02.10 16:47:06 5: Triggering HMLAN1 (3 changes)
2015.02.10 16:47:06 5: Notify loop for HMLAN1 cond: dummy
2015.02.10 16:47:06 4: eventTypes: HMLAN HMLAN1 cond: dummy -> cond: dummy
2015.02.10 16:47:06 4: eventTypes: HMLAN HMLAN1 Xmit-Events: dummy:1 disconnected:1 ok:1 init:1  -> Xmit-Events: dummy:.* disconnected:.* ok:.* init:.*
2015.02.10 16:47:06 4: eventTypes: HMLAN HMLAN1 prot_dummy: last -> prot_dummy: last
2015.02.10 16:47:06 5: Triggering global (1 changes)
2015.02.10 16:47:06 5: Notify loop for global ATTR HMLAN1 dummy 1
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem?detail=HMLAN1
2015.02.10 16:47:06 4: 11282:FHEMWEB:192.168.0.21:61436: /fhem?detail=HMLAN1 / RL:3658 / text/html; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:06 4: Connection closed for FHEMWEB:192.168.0.21:61305: EOF
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/style.css
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/jquery.min.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/jquery-ui.min.css
2015.02.10 16:47:06 4: Connection accepted from FHEMWEB:192.168.0.21:61443
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61443 GET /fhem/pgm2/jquery-ui.min.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/fhemweb.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/fhemweb_colorpicker.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/fhemweb_knob.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61443 GET /fhem/pgm2/fhemweb_readingsGroup.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/defaultCommon.css
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/fhemweb_readingsHistory.js
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61443 GET /fhem/images/default/icoEverything.png
2015.02.10 16:47:06 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/dashboard_style.css
2015.02.10 16:47:07 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/images/default/fhemicon.png
2015.02.10 16:47:07 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem?cmd={ReadingsVal(%22HMLAN1%22,%22hmPairForSec%22,%22%22)}&XHR=1
2015.02.10 16:47:07 5: Cmd: >{ReadingsVal("HMLAN1","hmPairForSec","")}<
2015.02.10 16:47:07 4: 11282:FHEMWEB:192.168.0.21:61437: /fhem?cmd={ReadingsVal(%22HMLAN1%22,%22hmPairForSec%22,%22%22)}&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:07 4: HTTP FHEMWEB:192.168.0.21:61443 GET /fhem?cmd={AttrVal(%22HMLAN1%22,%22room%22,%22%22)}&XHR=1
2015.02.10 16:47:07 5: Cmd: >{AttrVal("HMLAN1","room","")}<
2015.02.10 16:47:07 4: 11282:FHEMWEB:192.168.0.21:61443: /fhem?cmd={AttrVal(%22HMLAN1%22,%22room%22,%22%22)}&XHR=1 / RL:28 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:07 4: HTTP FHEMWEB:192.168.0.21:61443 GET /fhem?XHR=1&inform=type=status;filter=HMLAN1;since=1423583225;fmt=JSON&timestamp=1423583234438
2015.02.10 16:47:14 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem?cmd={AttrVal(%22HMLAN1%22,%22dummy%22,%22%22)}&XHR=1
2015.02.10 16:47:14 5: Cmd: >{AttrVal("HMLAN1","dummy","")}<
2015.02.10 16:47:14 4: 11282:FHEMWEB:192.168.0.21:61437: /fhem?cmd={AttrVal(%22HMLAN1%22,%22dummy%22,%22%22)}&XHR=1 / RL:22 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:22 4: BlockingCall created child (13543), uses telnetForBlockingFn to connect back
2015.02.10 16:47:22 4: Connection accepted from telnet:127.0.0.1:49709
2015.02.10 16:47:23 5: Cmd: ><
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem&detail=HMLAN1&dev.attrHMLAN1=HMLAN1&cmd.attrHMLAN1=attr&arg.attrHMLAN1=dummy&val.attrHMLAN1=0
2015.02.10 16:47:24 5: Cmd: >attr HMLAN1 dummy 0<
2015.02.10 16:47:24 1: 192.168.0.20:1000 reappeared (HMLAN1)
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:A<owner>
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:C
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+290CAB,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2E0DFA,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BD373,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2B38F4,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BD86C,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+320C10,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28C1A2,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+322BC6,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+303371,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+290B5B,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2E5F26,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28BF2B,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2C88C0,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28BF48,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2D48BF,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2518AF,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28C009,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28BFD9,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BBE4F,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28FB85,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BA442,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2B38E5,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BA7E2,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2ECA58,00,01,1E
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+2BD87C,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+28BF56,00,01,FE1F
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:+290C97,00,01,00
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:Y01,01,<hmkey>
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:Y02,02,<hmkey2>
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:Y03,00,
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 I:T1C6CD67C,04,00,00000000
2015.02.10 16:47:24 1: HMLAN_Parse: HMLAN1 new condition init
2015.02.10 16:47:24 5: Triggering HMLAN1 (3 changes)
2015.02.10 16:47:24 5: Notify loop for HMLAN1 cond: init
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 cond: init -> cond: init
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 Xmit-Events: dummy:1 disconnected:1 ok:1 init:2  -> Xmit-Events: dummy:.* disconnected:.* ok:.* init:.*
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 prot_init: last -> prot_init: last
2015.02.10 16:47:24 5: HMLAN_Send:  HMLAN1 S:S742C70D0 stat:  00 t:00000000 d:01 r:742C70D0 m:99 8112 <owner> 000000
2015.02.10 16:47:24 5: Triggering HMLAN1 (1 changes)
2015.02.10 16:47:24 5: Notify loop for HMLAN1 CONNECTED
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 CONNECTED -> CONNECTED
2015.02.10 16:47:24 5: Triggering global (1 changes)
2015.02.10 16:47:24 5: Notify loop for global ATTR HMLAN1 dummy 0
2015.02.10 16:47:24 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0383565,<owner>,<owner>,016E3D70,001B,05
E2B38E5,0000,016E274E,FF,FFC8,AC86102B38E50000000AA8C80E6440
I00,01,01,00
I00,01,02,00
I00,01,02,00

2015.02.10 16:47:24 5: HMLAN_Parse: HMLAN1 V:03C4 sNo:LEQ0383565 d:<owner> O:<owner> t:016E3D70 IDcnt:001B
2015.02.10 16:47:24 5: HMLAN_Parse: HMLAN1 R:E2B38E5   stat:0000 t:016E274E d:FF r:FFC8     m:AC 8610 2B38E5 000000 0AA8C80E6440
2015.02.10 16:47:24 5: HMLAN1 dispatch A0FAC86102B38E50000000AA8C80E6440::-56:HMLAN1
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem?detail=HMLAN1
2015.02.10 16:47:24 4: 11282:FHEMWEB:192.168.0.21:61437: /fhem?detail=HMLAN1 / RL:3667 / text/html; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:24 5: HMLAN/RAW: /R742C70D0,0002,00000000,FF,7FFF,998112<owner>000000

2015.02.10 16:47:24 5: HMLAN_Parse: HMLAN1 R:R742C70D0 stat:0002 t:00000000 d:FF r:7FFF     m:99 8112 <owner> 000000
2015.02.10 16:47:24 1: HMLAN_Parse: HMLAN1 new condition ok
2015.02.10 16:47:24 5: Triggering HMLAN1 (3 changes)
2015.02.10 16:47:24 5: Notify loop for HMLAN1 cond: ok
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 cond: ok -> cond: ok
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 Xmit-Events: dummy:1 disconnected:1 ok:2 init:2  -> Xmit-Events: dummy:.* disconnected:.* ok:.* init:.*
2015.02.10 16:47:24 4: eventTypes: HMLAN HMLAN1 prot_ok: last -> prot_ok: last
2015.02.10 16:47:24 4: Connection closed for FHEMWEB:192.168.0.21:61443: EOF
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/style.css
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/jquery-ui.min.css
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/jquery.min.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/jquery-ui.min.js
2015.02.10 16:47:24 4: Connection accepted from FHEMWEB:192.168.0.21:61445
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61445 GET /fhem/pgm2/fhemweb.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/fhemweb_colorpicker.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61439 GET /fhem/pgm2/fhemweb_knob.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61437 GET /fhem/pgm2/fhemweb_readingsGroup.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61445 GET /fhem/pgm2/fhemweb_readingsHistory.js
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/images/default/icoEverything.png
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/defaultCommon.css
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/pgm2/dashboard_style.css
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/images/default/fhemicon.png
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem?cmd={ReadingsVal(%22HMLAN1%22,%22hmPairForSec%22,%22%22)}&XHR=1
2015.02.10 16:47:24 5: Cmd: >{ReadingsVal("HMLAN1","hmPairForSec","")}<
2015.02.10 16:47:24 4: 11282:FHEMWEB:192.168.0.21:61436: /fhem?cmd={ReadingsVal(%22HMLAN1%22,%22hmPairForSec%22,%22%22)}&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61445 GET /fhem?cmd={AttrVal(%22HMLAN1%22,%22room%22,%22%22)}&XHR=1
2015.02.10 16:47:24 5: Cmd: >{AttrVal("HMLAN1","room","")}<
2015.02.10 16:47:24 4: 11282:FHEMWEB:192.168.0.21:61445: /fhem?cmd={AttrVal(%22HMLAN1%22,%22room%22,%22%22)}&XHR=1 / RL:28 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:24 4: HTTP FHEMWEB:192.168.0.21:61445 GET /fhem?XHR=1&inform=type=status;filter=HMLAN1;since=1423583243;fmt=JSON&timestamp=1423583251757
2015.02.10 16:47:26 5: HMLAN/RAW: /E2D48BF,0000,016E4506,FF,FFC3,59865A2D48BF000000A8C927

2015.02.10 16:47:26 5: HMLAN_Parse: HMLAN1 R:E2D48BF   stat:0000 t:016E4506 d:FF r:FFC3     m:59 865A 2D48BF 000000 A8C927
2015.02.10 16:47:26 5: HMLAN1 dispatch A0C59865A2D48BF000000A8C927::-61:HMLAN1
2015.02.10 16:47:28 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem?cmd.kg_hr_Warmwasserpumpe_Btn1=set%20kg_hr_Warmwasserpumpe_Btn1%20off&room=Heizung&room=Heizung&XHR=1
2015.02.10 16:47:28 5: Cmd: >set kg_hr_Warmwasserpumpe_Btn1 off<
2015.02.10 16:47:28 5: Triggering kg_hr_Warmwasserpumpe (1 changes)
2015.02.10 16:47:28 5: Notify loop for kg_hr_Warmwasserpumpe CMDs_pending
2015.02.10 16:47:28 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe CMDs_pending -> CMDs_pending
2015.02.10 16:47:28 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe state: CMDs_pending -> state: CMDs_pending
2015.02.10 16:47:28 5: CUL_HM kg_hr_Warmwasserpumpe protEvent:CMDs_pending pending:1
2015.02.10 16:47:28 5: Triggering kg_hr_Warmwasserpumpe_Btn1 (1 changes)
2015.02.10 16:47:28 5: Notify loop for kg_hr_Warmwasserpumpe_Btn1 set_off
2015.02.10 16:47:28 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe_Btn1 set_off -> set_off
2015.02.10 16:47:28 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe_Btn1 state: set_off -> state: set_off
2015.02.10 16:47:28 3: CUL_HM set kg_hr_Warmwasserpumpe_Btn1 off
2015.02.10 16:47:28 5: CUL_HM kg_hr_Warmwasserpumpe protEvent:CMDs_processing... pending:0
2015.02.10 16:47:28 4: 11282:FHEMWEB:192.168.0.21:61436: /fhem?cmd.kg_hr_Warmwasserpumpe_Btn1=set%20kg_hr_Warmwasserpumpe_Btn1%20off&room=Heizung&room=Heizung&XHR=1 / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:28 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem/images/default/set_off.png
2015.02.10 16:47:29 5: HMLAN/RAW: /E2C88C0,0000,016E5123,FF,FFB5,04845E2C88C00000008000130004C0006F08E5FD

2015.02.10 16:47:29 5: HMLAN_Parse: HMLAN1 R:E2C88C0   stat:0000 t:016E5123 d:FF r:FFB5     m:04 845E 2C88C0 000000 8000130004C0006F08E5FD
2015.02.10 16:47:29 5: HMLAN1 dispatch A1404845E2C88C00000008000130004C0006F08E5FD::-75:HMLAN1
2015.02.10 16:47:29 5: Triggering kg_hr_Heizkreispumpe_Pwr (8 changes)
2015.02.10 16:47:29 5: Notify loop for kg_hr_Heizkreispumpe_Pwr energy: 1.9
2015.02.10 16:47:30 4: BlockingCall created child (13552), uses telnetForBlockingFn to connect back
2015.02.10 16:47:30 4: Connection accepted from telnet:127.0.0.1:49711
2015.02.10 16:47:30 4: Connection accepted from telnet:127.0.0.1:49712
2015.02.10 16:47:30 5: HMLAN/RAW: /E320C10,0000,016E5630,FF,FFBD,D5865A320C10000000A8CC25

2015.02.10 16:47:30 5: HMLAN_Parse: HMLAN1 R:E320C10   stat:0000 t:016E5630 d:FF r:FFBD     m:D5 865A 320C10 000000 A8CC25
2015.02.10 16:47:30 5: HMLAN1 dispatch A0CD5865A320C10000000A8CC25::-67:HMLAN1
2015.02.10 16:47:33 4: CUL_HM_Resend: kg_hr_Warmwasserpumpe nr 2
2015.02.10 16:47:36 5: HMLAN/RAW: /E2D48BF,0000,016E6C19,FF,FFC3,A984102D48BF0000000BA8C90E00

2015.02.10 16:47:36 5: HMLAN_Parse: HMLAN1 R:E2D48BF   stat:0000 t:016E6C19 d:FF r:FFC3     m:A9 8410 2D48BF 000000 0BA8C90E00
2015.02.10 16:47:36 5: HMLAN1 dispatch A0EA984102D48BF0000000BA8C90E00::-61:HMLAN1
2015.02.10 16:47:38 4: CUL_HM_Resend: kg_hr_Warmwasserpumpe nr 3
2015.02.10 16:47:43 4: CUL_HM_Resend: kg_hr_Warmwasserpumpe nr 4
2015.02.10 16:47:46 5: HMLAN/RAW: /E2D48BF,0000,016E9330,FF,FFC3,5984702D48BF00000000C927

2015.02.10 16:47:46 5: HMLAN_Parse: HMLAN1 R:E2D48BF   stat:0000 t:016E9330 d:FF r:FFC3     m:59 8470 2D48BF 000000 00C927
2015.02.10 16:47:46 5: HMLAN1 dispatch A0C5984702D48BF00000000C927::-61:HMLAN1
2015.02.10 16:47:49 5: Notify loop for kg_hr_Warmwasserpumpe ResndFail
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe ResndFail -> ResndFail
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe state: ResndFail -> state: ResndFail
2015.02.10 16:47:49 5: Triggering kg_hr_Warmwasserpumpe (1 changes)
2015.02.10 16:47:49 5: Notify loop for kg_hr_Warmwasserpumpe CMDs_done_Errors:1
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe CMDs_done_Errors:1 -> CMDs_done_Errors:.*
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe state: CMDs_done_Errors:1 -> state: CMDs_done_Errors:.*
2015.02.10 16:47:49 5: CUL_HM kg_hr_Warmwasserpumpe protEvent:CMDs_done_Errors:1
2015.02.10 16:47:49 5: Triggering kg_hr_Warmwasserpumpe (1 changes)
2015.02.10 16:47:49 5: Notify loop for kg_hr_Warmwasserpumpe MISSING ACK
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe MISSING ACK -> MISSING ACK
2015.02.10 16:47:49 4: eventTypes: CUL_HM kg_hr_Warmwasserpumpe state: MISSING ACK -> state: MISSING ACK
2015.02.10 16:47:49 5: HMLAN_Send:  HMLAN1 I:K
2015.02.10 16:47:49 5: HMLAN/RAW: /HHM-LAN-IF,03C4,LEQ0383565,<owner>,<owner>,016E9F35,001B,05

2015.02.10 16:47:49 5: HMLAN_Parse: HMLAN1 V:03C4 sNo:LEQ0383565 d:<owner> O:<owner> t:016E9F35 IDcnt:001B
2015.02.10 16:47:49 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem?cmd={AttrVal(%22global%22,%22verbose%22,%22%22)}&XHR=1
2015.02.10 16:47:49 5: Cmd: >{AttrVal("global","verbose","")}<
2015.02.10 16:47:49 4: 11282:FHEMWEB:192.168.0.21:61436: /fhem?cmd={AttrVal(%22global%22,%22verbose%22,%22%22)}&XHR=1 / RL:22 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.02.10 16:47:50 5: HMLAN/RAW: /E320C10,0000,016EA453,FF,FFBD,D58470320C1000000000CD25

2015.02.10 16:47:50 5: HMLAN_Parse: HMLAN1 R:E320C10   stat:0000 t:016EA453 d:FF r:FFBD     m:D5 8470 320C10 000000 00CD25
2015.02.10 16:47:50 5: HMLAN1 dispatch A0CD58470320C1000000000CD25::-67:HMLAN1
2015.02.10 16:47:52 5: HMLAN/RAW: /E290C97,0000,016EABF4,FF,FFC5,CF8610290C970000000AA8CC0E6423

2015.02.10 16:47:52 5: HMLAN_Parse: HMLAN1 R:E290C97   stat:0000 t:016EABF4 d:FF r:FFC5     m:CF 8610 290C97 000000 0AA8CC0E6423
2015.02.10 16:47:52 5: HMLAN1 dispatch A0FCF8610290C970000000AA8CC0E6423::-59:HMLAN1
2015.02.10 16:47:53 5: HMLAN/RAW: /E2BA442,0000,016EAEF7,FF,FFB7,DA86102BA4420000000AA0CB0F0E00

2015.02.10 16:47:53 5: HMLAN_Parse: HMLAN1 R:E2BA442   stat:0000 t:016EAEF7 d:FF r:FFB7     m:DA 8610 2BA442 000000 0AA0CB0F0E00
2015.02.10 16:47:53 5: HMLAN1 dispatch A0FDA86102BA4420000000AA0CB0F0E00::-73:HMLAN1
2015.02.10 16:47:53 4: HTTP FHEMWEB:192.168.0.21:61436 GET /fhem&detail=global&dev.attrglobal=global&cmd.attrglobal=attr&arg.attrglobal=verbose&val.attrglobal=3
2015.02.10 16:47:53 5: Cmd: >attr global verbose 3<


Ich habe den Auszug um alles erleichtert, was nicht im entferntesten mit HMLAN in Verbindung zu bringen war. Die Keys habe ich durch <hmkey> und <hmkey2> ersetzt, ebenso die HMID durch <owner>.

Geschaltet wurde nach dem dummy wieder auf 0 gesetzt wurde kg_hr_Warmwasserpumpe_Btn1. Das Einzige, was ich noch aus dem Log lesen kann ist, dass das Schalten eben nicht funktioniert hat...  :-\

Viele Grüße
Stefan
HW: Intel NUC8i5 mit ESXi7 mit Ubuntu Server 18.04 LTS und FHEM als DockerContainer