Bekomme keine Geräte mehr gepairt

Begonnen von merasil, 27 April 2019, 13:55:48

Vorheriges Thema - Nächstes Thema

Nitaro

Gute Frage.
Ich habe zwei Max!Cube umgeflasht auf Homematic mit der a-culfw.
Bei beiden Cubes tritt das Problem auf. Dann habe ich in dem Thread dafür das Problem geschildert,
mir wurde aber nur geantwortet das es kein Problem geben sollte.
Mit einem selbstgebauten nanoCUL mit a-culfw tritt der Fehler nicht auf.

frank

Zitat von: frank am 30 September 2019, 22:57:00
ich würde mal ein getconfig im clima chn mit cul und cube sniffen und vergleichen.
zeig doch mal.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

Nitaro

Verbose 5 sagt über den nanoCUL (also wo es funktioniert)
Zitat
2019.10.01 09:40:22 4: CUL_Parse: nanoCUL A 0B CF 8010 6A1F49 00A100 030032 -49
2019.10.01 09:40:22 5: nanoCUL: dispatch A0BCF80106A1F4900A1000300::-49:nanoCUL
2019.10.01 09:40:22 5: CUL_HM HM_6A1F49 protEvent:CMDs_done

Und über den Cube (wo es nicht geht)
2019.10.01 09:44:34 5: Cube_Ankleide sending As0BC1A00100A1006A1F490403
2019.10.01 09:44:34 5: CUL 6A1F49 dly:98ms
2019.10.01 09:44:34 5: SW: As0BC1A00100A1006A1F490403
2019.10.01 09:44:34 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:2
2019.10.01 09:44:34 5: CUL/RAW: /A09C0B11200A1006A1F491C
A0AC080026A1F4900A100002A


Leider nicht mehr  :(


MadMax-FHEM

Nicht verbose 5 sondern "sniffen"! ;)

https://wiki.fhem.de/wiki/Homematic_Nachrichten_sniffen

Wobei (nochmal?) der Hinweis: ein CUL ist für Homematic eh nicht so und die aCUL-FW für den CUL ist eben eine Portierung auf arm (soweit ich weiß), vielleicht ist da auch nicht alles identisch/gleich...

Gruß, Joachim
FHEM PI3B+ Bullseye: HM-CFG-USB, 40x HM, ZWave-USB, 13x ZWave, EnOcean-PI, 15x EnOcean, HUE/deCONZ, CO2, ESP-Multisensor, Shelly, alexa-fhem, ...
FHEM PI2 Buster: HM-CFG-USB, 25x HM, ZWave-USB, 4x ZWave, EnOcean-PI, 3x EnOcean, Shelly, ha-bridge, ...
FHEM PI3 Buster (Test)

Nitaro

Ich weiß jetzt gar nicht warum ich vom sniffen abgekommen bin,
mache ich wenn ich wieder zu Hause (noch-)mal.

Der nanoCUL macht ja gar keine Probleme. Nur die Cubes.
Durchaus möglich dass es da Unterschiede gibt.

Aber nochmal die Frage: Was ist denn ein gut funktionierendes natives Device für Homematic ?


Otto123

Viele Grüße aus Leipzig  ⇉  nächster Stammtisch an der Lindennaundorfer Mühle
RaspberryPi B B+ B2 B3 B3+ ZeroW,HMLAN,HMUART,Homematic,Fritz!Box 7590,WRT3200ACS-OpenWrt,Sonos,VU+,Arduino nano,ESP8266,MQTT,Zigbee,deconz

Nitaro

#66
Den HM-MOD-RPI-PCB habe ich bestellt, wurde auch schon geliefert.
Habe ich aber noch nicht "eingebaut". Im moment habe ich die RTs auf
dem nanoCUL und die Tempsensoren und FKs auf die Cubes verteilt (mit IOgrp).
So funktioniert ja erstmal alles, nur sollte eigentlich alles nur über die Cubes
laufen, so der eigentliche Plan.

Und warum das nicht geht ist jetzt so ein persönliches Ding das herauszufinden,
sonst krieg ich das nicht aus dem Kopf  ;D Der ein oder andere kennt das bestimmt.

Nitaro

Hallo zusammen,

ich habe das Sniffen eingestellt wie im Wiki 
attr global verbose 1
attr global mseclog 1
attr <cul> verbose 4


Das log leider nicht viel her.
Hier der Fehlschlag (Clima Channel Register Read:Timeout)
2019.10.05 11:10:32.941 4: CUL_Parse: Cube_Ankleide A 0F C7 8610 6A1F49 000000 0A60C90C000038 -46
2019.10.05 11:10:41.612 4: CUL_Parse: Cube_Ankleide A 0C 7D 8470 2009D4 00A100 00C93517 -62.5
2019.10.05 11:10:54.494 4: CUL_Parse: Cube_Ankleide A 0C 60 8470 2009D2 00A100 00D63FF8 -78
2019.10.05 11:11:10.598 4: CUL_Parse: Cube_Ankleide A 0A C8 8002 6A1F49 00A100 0037 -46.5
2019.10.05 11:11:10.724 4: CUL_Parse: Cube_Ankleide A 0F AC 8610 6A0A87 000000 0AA8DA0C000021 -57.5
2019.10.05 11:11:11.075 4: CUL_Parse: Cube_Ankleide A 0E C9 8010 6A1F49 00A100 010000000037 -46.5
2019.10.05 11:11:11.341 4: CUL_Parse: Cube_Ankleide A 0E CA 8010 6A1F49 00A100 020800000037 -46.5
2019.10.05 11:11:11.813 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:12.061 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:12.308 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:13.323 4: CUL_Parse: Cube_Ankleide A 0C 7E 8470 2009D4 00A100 00C83419 -61.5
2019.10.05 11:11:14.313 4: CUL_Parse: Cube_Ankleide A 0A CC 8002 6A1F49 00A100 0038 -46
2019.10.05 11:11:14.786 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:15.036 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:15.281 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:17.287 4: CUL_Parse: Cube_Ankleide A 0A CC 8002 6A1F49 00A100 0037 -46.5
2019.10.05 11:11:17.758 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050038 -46
2019.10.05 11:11:18.008 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:18.255 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050038 -46
2019.10.05 11:11:20.259 4: CUL_Parse: Cube_Ankleide A 0A CC 8002 6A1F49 00A100 0037 -46.5
2019.10.05 11:11:20.732 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:20.979 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:21.226 4: CUL_Parse: Cube_Ankleide A 1A CB A010 6A1F49 00A100 03012A22093D18030016073000640F050037 -46.5
2019.10.05 11:11:24.471 4: CUL_Parse: Cube_Ankleide A 0C B9 8470 2009D3 00A100 00CA3D28 -54


Und hier der Erfolg über den nanoCUL
2019.10.05 11:20:49.999 4: CUL_Parse: nanoCUL A 0A CC 8002 6A1F49 00A100 0044 -40
2019.10.05 11:20:50.287 4: CUL_Parse: nanoCUL A 0E CD 8010 6A1F49 00A100 010000000044 -40
2019.10.05 11:20:50.575 4: CUL_Parse: nanoCUL A 0E CE 8010 6A1F49 00A100 020800000044 -40
2019.10.05 11:20:50.879 4: CUL_Parse: nanoCUL A 1A CF A010 6A1F49 00A100 03012A22093D18030016073000640F050044 -40
2019.10.05 11:20:51.135 4: CUL_Parse: nanoCUL A 1A D0 A010 6A1F49 00A100 03100000090E4454586C54E4590845204544 -40
2019.10.05 11:20:51.391 4: CUL_Parse: nanoCUL A 1A D1 A010 6A1F49 00A100 031F20452045204520452045204520452043 -40.5
2019.10.05 11:20:51.647 4: CUL_Parse: nanoCUL A 1A D2 A010 6A1F49 00A100 032E4454586C54E459084520452045204543 -40.5
2019.10.05 11:20:51.919 4: CUL_Parse: nanoCUL A 1A D3 A010 6A1F49 00A100 033D2045204520452045204520443C585A43 -40.5
2019.10.05 11:20:52.175 4: CUL_Parse: nanoCUL A 1A D4 A010 6A1F49 00A100 034C44A854E4590845204520452045204543 -40.5
2019.10.05 11:20:52.431 4: CUL_Parse: nanoCUL A 1A D5 A010 6A1F49 00A100 035B20452045204520443C585A44A854E443 -40.5
2019.10.05 11:20:52.687 4: CUL_Parse: nanoCUL A 1A D6 A010 6A1F49 00A100 036A59084520452045204520452045204544 -40
2019.10.05 11:20:52.943 4: CUL_Parse: nanoCUL A 1A D7 A010 6A1F49 00A100 0379204520443C585A44A854E45908452043 -40.5
2019.10.05 11:20:53.199 4: CUL_Parse: nanoCUL A 1A D8 A010 6A1F49 00A100 038845204520452045204520452045204444 -40
2019.10.05 11:20:53.471 4: CUL_Parse: nanoCUL A 1A D9 A010 6A1F49 00A100 03973C585A44A854E4590845204520452044 -40
2019.10.05 11:20:53.727 4: CUL_Parse: nanoCUL A 1A DA A010 6A1F49 00A100 03A645204520452045204520443C585A4444 -40
2019.10.05 11:20:53.983 4: CUL_Parse: nanoCUL A 1A DB A010 6A1F49 00A100 03B5A854E459084520452045204520452044 -40
2019.10.05 11:20:54.240 4: CUL_Parse: nanoCUL A 17 DC A010 6A1F49 00A100 03C445204520452012212D12212C44 -40
2019.10.05 11:20:54.479 4: CUL_Parse: nanoCUL A 0B DD 8010 6A1F49 00A100 030044 -40


Mir ist dabei aber folgendes aufgefallen:
Ist der nanoCUL in fhem definiert, funktioniert ein getConfig des Clima Channels über den Cube einwandfrei.
Ist der nanoCUL in fhem nicht definiert (gelöscht über Delete this Device), führt ein getConfig über den Cube zum Timeout.
Das sieht so aus, als würde es alleine an der Präsenz des nanoCULs liegen auch wenn die RTs über die Cubes funken.

frank

die logs sind leider unvollständig.
es fehlen mindestens alle gesendeten msgs. hast du "gefiltert"?

unklar ist auch die einstellung von attr IOgrp des rt. hier wird das sendende io eingestellt. empfangen können immer alle io im system. am besten jeweils ein prefered io einstellen, um sicher zu stellen, dass jeweils ein bestimmtes io sendet.

mach jetzt mal einen versuch mit nur einem cube im system, also alle anderen io löschen und die vccu anpassen, dann setze diesen als prefered io am rt. dann mit verbose=5 am cube alles aus fhem.log posten.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

Nitaro

Ok, los gehts. Gefiltert hatte ich nichts, nur den Block genommen wo das HM_6A1F49 gelogged wurde.

Verbose jeweils 5, mseclog 1, VCCU IOlist Cube_Ankleide, HM_6A1F49 IOgrp VCCU:Cube_Ankleide.
Cube_Anleide ist das alleinige IO Device im System

2019.10.05 15:05:34.485 3: CUL_HM set HM_6A1F49_Clima getConfig
2019.10.05 15:05:34.486 5: Cube_Ankleide sending As0927B11200A1006A1F49
2019.10.05 15:05:34.486 5: SW: As0927B11200A1006A1F49
2019.10.05 15:05:34.488 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:6
2019.10.05 15:05:34.498 4: WEB_192.168.1.125_52100 GET /fhem?detail=HM_6A1F49_Clima&fw_id=; BUFLEN:0
2019.10.05 15:05:34.521 4: WEB: /fhem?detail=HM_6A1F49_Clima&fw_id= / RL:6771 / text/html; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:34.612 4: WEB_192.168.1.125_52100 GET /fhem?cmd=%7BReadingsVal(%22HM_6A1F49_Clima%22%2C%22burstXmit%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:05:34.613 5: Cmd: >{ReadingsVal("HM_6A1F49_Clima","burstXmit","")}<
2019.10.05 15:05:34.613 4: WEB: /fhem?cmd=%7BReadingsVal(%22HM_6A1F49_Clima%22%2C%22burstXmit%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:34.616 4: WEB_192.168.1.125_52100 GET /fhem?cmd=%7BAttrVal(%22HM_6A1F49_Clima%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:05:34.617 5: Cmd: >{AttrVal("HM_6A1F49_Clima","room","")}<
2019.10.05 15:05:34.617 4: WEB: /fhem?cmd=%7BAttrVal(%22HM_6A1F49_Clima%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:31 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:34.725 4: WEB_192.168.1.125_52100 GET /fhem?XHR=1&inform=type=status;filter=HM_6A1F49_Clima;since=1570280733;fmt=JSON&fw_id=311&timestamp=1570280734904; BUFLEN:0
2019.10.05 15:05:35.069 5: CUL/RAW: /A0A2780026A1F4900A100003B

2019.10.05 15:05:35.069 4: CUL_Parse: Cube_Ankleide A 0A 27 8002 6A1F49 00A100 003B -44.5
2019.10.05 15:05:35.070 5: Cube_Ankleide: dispatch A0A2780026A1F4900A10000::-44.5:Cube_Ankleide
2019.10.05 15:05:35.072 5: Cube_Ankleide sending As0B28A00100A1006A1F490403
2019.10.05 15:05:35.072 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:35.170 5: SW: As0B28A00100A1006A1F490403
2019.10.05 15:05:35.172 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:5
2019.10.05 15:05:35.565 5: CUL/RAW: /A0E2880106A1F4900A10001000000003A

2019.10.05 15:05:35.565 4: CUL_Parse: Cube_Ankleide A 0E 28 8010 6A1F49 00A100 01000000003A -45
2019.10.05 15:05:35.565 5: Cube_Ankleide: dispatch A0E2880106A1F4900A1000100000000::-45:Cube_Ankleide
2019.10.05 15:05:35.567 5: Cube_Ankleide sending As1029A00100A1006A1F4904040000000001
2019.10.05 15:05:35.568 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:35.666 5: SW: As1029A00100A1006A1F4904040000000001
2019.10.05 15:05:35.668 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:4
2019.10.05 15:05:35.834 5: LaCrosseGateway: dispatch OK 9 1 1 4 196 65
2019.10.05 15:05:35.836 5: Starting notify loop for LaCrosse_01, 1 event(s), first is humidity: 65
2019.10.05 15:05:35.836 5: createNotifyHash
2019.10.05 15:05:35.839 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:35.840 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:35.842 5: End notify loop for LaCrosse_01
2019.10.05 15:05:36.060 5: CUL/RAW: /A0E2980106A1F4900A10002080000003A

2019.10.05 15:05:36.060 4: CUL_Parse: Cube_Ankleide A 0E 29 8010 6A1F49 00A100 02080000003A -45
2019.10.05 15:05:36.061 5: Cube_Ankleide: dispatch A0E2980106A1F4900A1000208000000::-45:Cube_Ankleide
2019.10.05 15:05:36.063 5: Cube_Ankleide sending As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:36.063 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:36.161 5: SW: As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:36.163 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:36.556 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:36.556 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:36.556 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:36.558 5: Cube_Ankleide sending As0A2A800200A1006A1F4900
2019.10.05 15:05:36.558 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:36.656 5: SW: As0A2A800200A1006A1F4900
2019.10.05 15:05:36.658 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:36.658 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:36.688 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:36.688 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:36.689 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:36.689 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:37.051 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:37.051 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:37.052 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:37.054 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:37.054 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:37.152 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:37.154 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:37.154 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:37.178 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:37.178 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:37.179 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:37.180 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:37.547 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:37.547 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:37.547 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:37.548 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:37.548 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:37.647 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:37.649 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:37.650 4: CUL_HM HM_6A1F49 dupe: repeat 2 ack, dont process
2019.10.05 15:05:39.054 4: CUL_HM_Resend: HM_6A1F49 nr 2
2019.10.05 15:05:39.055 5: Cube_Ankleide sending As092CB11200A1006A1F49
2019.10.05 15:05:39.055 5: SW: As092CB11200A1006A1F49
2019.10.05 15:05:39.057 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:39.449 4: Connection closed for WEB_192.168.1.125_52100: EOF
2019.10.05 15:05:39.467 4: WEB_192.168.1.125_52098 GET /fhem?detail=HM_6A1F49; BUFLEN:0
2019.10.05 15:05:39.493 4: WEB: /fhem?detail=HM_6A1F49 / RL:7941 / text/html; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:39.597 4: WEB_192.168.1.125_52098 GET /fhem?cmd=%7BReadingsVal(%22HM_6A1F49%22%2C%22assignHmKey%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:05:39.598 5: Cmd: >{ReadingsVal("HM_6A1F49","assignHmKey","")}<
2019.10.05 15:05:39.598 4: WEB: /fhem?cmd=%7BReadingsVal(%22HM_6A1F49%22%2C%22assignHmKey%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:39.600 4: Connection accepted from WEB_192.168.1.125_52103
2019.10.05 15:05:39.600 4: WEB_192.168.1.125_52098 GET /fhem?cmd=%7BAttrVal(%22HM_6A1F49%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:05:39.600 5: Cmd: >{AttrVal("HM_6A1F49","room","")}<
2019.10.05 15:05:39.601 4: WEB: /fhem?cmd=%7BAttrVal(%22HM_6A1F49%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:41 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:05:39.699 4: WEB_192.168.1.125_52098 GET /fhem?XHR=1&inform=type=status;filter=HM_6A1F49;since=1570280738;fmt=JSON&fw_id=310&timestamp=1570280739887; BUFLEN:0
2019.10.05 15:05:39.776 5: CUL/RAW: /A0A2C80026A1F4900A100003A

2019.10.05 15:05:39.777 4: CUL_Parse: Cube_Ankleide A 0A 2C 8002 6A1F49 00A100 003A -45
2019.10.05 15:05:39.777 5: Cube_Ankleide: dispatch A0A2C80026A1F4900A10000::-45:Cube_Ankleide
2019.10.05 15:05:39.778 5: Cube_Ankleide sending As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:39.778 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:39.877 5: SW: As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:39.882 5: LaCrosseGateway: dispatch OK 9 1 1 4 196 65
2019.10.05 15:05:40.099 4: Connection accepted from WEB_192.168.1.125_52104
2019.10.05 15:05:40.271 5: LaCrosseGateway: dispatch OK 9 10 1 4 148 58
2019.10.05 15:05:40.273 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:40.274 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:40.274 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:40.275 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:43, rec:42
2019.10.05 15:05:40.275 5: Cube_Ankleide sending As0A2A800200A1006A1F4900
2019.10.05 15:05:40.275 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:40.374 5: SW: As0A2A800200A1006A1F4900
2019.10.05 15:05:40.376 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:40.376 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:40.401 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003B

2019.10.05 15:05:40.401 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003B -44.5
2019.10.05 15:05:40.402 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-44.5:Cube_Ankleide
2019.10.05 15:05:40.402 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:40.767 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:40.768 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:40.768 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:40.770 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:40.770 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:40.868 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:40.870 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:40.870 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:40.894 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:40.895 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:40.895 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:40.896 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:41.263 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:41.263 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:41.264 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:41.264 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:41.265 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:41.364 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:41.365 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:41.366 4: CUL_HM HM_6A1F49 dupe: repeat 2 ack, dont process
2019.10.05 15:05:41.670 5: LaCrosseGateway: dispatch OK 9 39 1 4 200 59
2019.10.05 15:05:42.058 5: LaCrosseGateway: dispatch OK 9 56 1 4 200 59
2019.10.05 15:05:42.697 5: LaCrosseGateway: dispatch OK WS 0 4 4 204 50 255 255 255 255 255 255 255 255 0 3 247 255 255 255 255 255 255 255 255 255
2019.10.05 15:05:42.699 5: Starting notify loop for BME280, 1 event(s), first is temps: 22.8
2019.10.05 15:05:42.699 5: createNotifyHash
2019.10.05 15:05:42.702 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:42.703 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:42.704 5: End notify loop for BME280
2019.10.05 15:05:42.705 5: LaCrosseGateway: dispatch OK VALUES LGW 14762105 UpTimeSeconds=50742,UpTimeText=0Tg. 14Std. 5Min. 42Sek. ,WIFI=XCore,ReceivedFrames=21882,FramesPerMinute=28,RSSI=-76,FreeHeap=26544,LD.Min=0.60,LD.Avg=0.62,LD.Max=24.65,OLED=none
2019.10.05 15:05:42.724 5: LaCrosseGateway: dispatch OK 9 17 130 4 193 125
2019.10.05 15:05:42.726 5: Starting notify loop for LaCrosse_07, 1 event(s), first is temps2: 21.7
2019.10.05 15:05:42.726 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:42.727 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:42.729 5: End notify loop for LaCrosse_07
2019.10.05 15:05:42.770 4: CUL_HM_Resend: HM_6A1F49 nr 3
2019.10.05 15:05:42.771 5: Cube_Ankleide sending As092CB11200A1006A1F49
2019.10.05 15:05:42.771 5: SW: As092CB11200A1006A1F49
2019.10.05 15:05:42.773 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:43.492 5: CUL/RAW: /A0A2C80026A1F4900A100003A

2019.10.05 15:05:43.493 4: CUL_Parse: Cube_Ankleide A 0A 2C 8002 6A1F49 00A100 003A -45
2019.10.05 15:05:43.493 5: Cube_Ankleide: dispatch A0A2C80026A1F4900A10000::-45:Cube_Ankleide
2019.10.05 15:05:43.494 5: Cube_Ankleide sending As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:43.494 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:43.593 5: SW: As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:43.870 5: LaCrosseGateway: dispatch OK 9 1 1 4 196 65
2019.10.05 15:05:43.988 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:43.988 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:43.988 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:43.989 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:43, rec:42
2019.10.05 15:05:43.990 5: Cube_Ankleide sending As0A2A800200A1006A1F4900
2019.10.05 15:05:43.990 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:44.088 5: SW: As0A2A800200A1006A1F4900
2019.10.05 15:05:44.090 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:44.091 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:44.115 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:44.115 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:44.116 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:44.116 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:44.483 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:44.484 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:44.486 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:44.488 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:44.488 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:44.586 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:44.588 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:44.588 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:44.611 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453B

2019.10.05 15:05:44.612 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453B -44.5
2019.10.05 15:05:44.612 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-44.5:Cube_Ankleide
2019.10.05 15:05:44.613 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:44.614 4: Connection closed for WEB_192.168.1.125_52103: EOF
2019.10.05 15:05:44.979 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:44.979 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:44.980 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:44.980 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:44.981 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:45.080 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:45.082 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:45.082 4: CUL_HM HM_6A1F49 dupe: repeat 2 ack, dont process
2019.10.05 15:05:45.227 5: CUL/RAW: /A0C3584702009D16A0B1400E1341D

2019.10.05 15:05:45.227 4: CUL_Parse: Cube_Ankleide A 0C 35 8470 2009D1 6A0B14 00E1341D -59.5
2019.10.05 15:05:45.227 5: Cube_Ankleide: dispatch A0C3584702009D16A0B1400E134::-59.5:Cube_Ankleide
2019.10.05 15:05:45.229 5: Starting notify loop for HM_2009D1, 1 event(s), first is temperature: 22.5
2019.10.05 15:05:45.230 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:45.231 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:45.243 5: End notify loop for HM_2009D1
2019.10.05 15:05:45.474 5: CUL/RAW: /A0C3584702009D16A0A8700E1341D

2019.10.05 15:05:45.475 4: CUL_Parse: Cube_Ankleide A 0C 35 8470 2009D1 6A0A87 00E1341D -59.5
2019.10.05 15:05:45.475 5: Cube_Ankleide: dispatch A0C3584702009D16A0A8700E134::-59.5:Cube_Ankleide
2019.10.05 15:05:46.489 4: CUL_HM_Resend: HM_6A1F49 nr 4
2019.10.05 15:05:46.489 5: Cube_Ankleide sending As092CB11200A1006A1F49
2019.10.05 15:05:46.489 5: SW: As092CB11200A1006A1F49
2019.10.05 15:05:46.491 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:47.208 5: CUL/RAW: /A0A2C80026A1F4900A100003A

2019.10.05 15:05:47.209 4: CUL_Parse: Cube_Ankleide A 0A 2C 8002 6A1F49 00A100 003A -45
2019.10.05 15:05:47.209 5: Cube_Ankleide: dispatch A0A2C80026A1F4900A10000::-45:Cube_Ankleide
2019.10.05 15:05:47.210 5: Cube_Ankleide sending As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:47.211 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:47.309 5: SW: As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:47.704 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:47.704 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:47.705 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:47.706 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:43, rec:42
2019.10.05 15:05:47.706 5: Cube_Ankleide sending As0A2A800200A1006A1F4900
2019.10.05 15:05:47.707 5: CUL 6A1F49 dly:98ms
2019.10.05 15:05:47.805 5: SW: As0A2A800200A1006A1F4900
2019.10.05 15:05:47.807 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:47.807 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:47.831 5: CUL/RAW: /A1A2AA0106A1F4900A10003012A22093D18030016073000640F05003A

2019.10.05 15:05:47.832 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:47.832 5: Cube_Ankleide: dispatch A1A2AA0106A1F4900A10003012A22093D18030016073000640F0500::-45:Cube_Ankleide
2019.10.05 15:05:47.833 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:48.167 5: LaCrosseGateway: dispatch OK 9 53 1 4 201 57
2019.10.05 15:05:48.200 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:48.200 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:48.200 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:48.202 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:48.202 5: CUL 6A1F49 dly:97ms
2019.10.05 15:05:48.300 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:48.302 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:48.303 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:05:48.333 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:48.333 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:48.334 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:48.334 4: CUL_HM HM_6A1F49 dupe: dont process
2019.10.05 15:05:48.430 5: LaCrosseGateway: dispatch OK 9 10 1 4 148 58
2019.10.05 15:05:48.695 5: CUL/RAW: /A1A2BA0106A1F4900A10003100000090E4454586C54E459084520453A

2019.10.05 15:05:48.695 4: CUL_Parse: Cube_Ankleide A 1A 2B A010 6A1F49 00A100 03100000090E4454586C54E459084520453A -45
2019.10.05 15:05:48.695 5: Cube_Ankleide: dispatch A1A2BA0106A1F4900A10003100000090E4454586C54E45908452045::-45:Cube_Ankleide
2019.10.05 15:05:48.696 5: Cube_Ankleide sending As0A2B800200A1006A1F4900
2019.10.05 15:05:48.696 5: CUL 6A1F49 dly:99ms
2019.10.05 15:05:48.795 5: SW: As0A2B800200A1006A1F4900
2019.10.05 15:05:48.797 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:05:48.798 4: CUL_HM HM_6A1F49 dupe: repeat 2 ack, dont process
2019.10.05 15:05:50.203 5: Starting notify loop for HM_6A1F49, 1 event(s), first is ResndFail
2019.10.05 15:05:50.204 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:50.205 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:50.211 5: End notify loop for HM_6A1F49
2019.10.05 15:05:50.212 5: Starting notify loop for HM_6A1F49, 1 event(s), first is CMDs_done_Errors:1
2019.10.05 15:05:50.212 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:50.213 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:50.219 5: End notify loop for HM_6A1F49
2019.10.05 15:05:50.219 5: CUL_HM HM_6A1F49 protEvent:CMDs_done_Errors:1
2019.10.05 15:05:50.219 5: Starting notify loop for HM_6A1F49, 1 event(s), first is RESPONSE TIMEOUT:RegisterRead
2019.10.05 15:05:50.220 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:05:50.220 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:05:50.226 5: End notify loop for HM_6A1F49


Verbose jeweils 5, mseclog 1, VCCU IOlist nanoCUL, HM_6A1F49 IOgrp VCCU:nanoCUL.
nanoCUL ist das alleinige IO Device im System

2019.10.05 15:12:24.084 3: CUL_HM set HM_6A1F49_Clima getConfig
2019.10.05 15:12:24.085 5: nanoCUL sending As09CAB11200A1006A1F49
2019.10.05 15:12:24.085 5: SW: As09CAB11200A1006A1F49
2019.10.05 15:12:24.087 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:3
2019.10.05 15:12:24.093 4: WEB_192.168.1.125_52161 GET /fhem?detail=HM_6A1F49_Clima&fw_id=; BUFLEN:0
2019.10.05 15:12:24.116 4: WEB: /fhem?detail=HM_6A1F49_Clima&fw_id= / RL:6758 / text/html; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:24.201 4: WEB_192.168.1.125_52161 GET /fhem?cmd=%7BReadingsVal(%22HM_6A1F49_Clima%22%2C%22burstXmit%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:12:24.201 5: Cmd: >{ReadingsVal("HM_6A1F49_Clima","burstXmit","")}<
2019.10.05 15:12:24.202 4: WEB: /fhem?cmd=%7BReadingsVal(%22HM_6A1F49_Clima%22%2C%22burstXmit%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:24.203 4: WEB_192.168.1.125_52160 GET /fhem?cmd=%7BAttrVal(%22HM_6A1F49_Clima%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:12:24.203 5: Cmd: >{AttrVal("HM_6A1F49_Clima","room","")}<
2019.10.05 15:12:24.204 4: WEB: /fhem?cmd=%7BAttrVal(%22HM_6A1F49_Clima%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:31 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:24.304 4: WEB_192.168.1.125_52161 GET /fhem?XHR=1&inform=type=status;filter=HM_6A1F49_Clima;since=1570281143;fmt=JSON&fw_id=311&timestamp=1570281144492; BUFLEN:0
2019.10.05 15:12:24.582 5: LaCrosseGateway: dispatch OK 9 1 1 4 196 65
2019.10.05 15:12:24.584 5: Starting notify loop for LaCrosse_01, 1 event(s), first is temps: 22.0
2019.10.05 15:12:24.584 5: createNotifyHash
2019.10.05 15:12:24.587 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:12:24.588 5: Triggering Kaelte_Gaeste_WC
2019.10.05 15:12:24.588 4: Kaelte_Gaeste_WC exec IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "open")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt) ELSE (
IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)
ELSE
(set Kaelte_G_WC ok)
)
2019.10.05 15:12:24.588 5: Cmd: >IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "open")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt) ELSE (
IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)
ELSE
(set Kaelte_G_WC ok)
)<
2019.10.05 15:12:24.589 5: Cmd: >{if(ReadingValIf('LaCrosse_01','temps','') < "20.0" and InternalIf('HM_FD0445','STATE','') eq "open"){fhem('set Tab_Wohnzimmer speak "Kältewarnung Gäste WC"');fhem('set Kaelte_G_WC zukalt')}else{fhem('IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted") (set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)ELSE(set Kaelte_G_WC ok)')}}<
2019.10.05 15:12:24.590 5: Cmd: >IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted") (set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)ELSE(set Kaelte_G_WC ok)<
2019.10.05 15:12:24.591 5: Cmd: >{if(ReadingValIf('LaCrosse_01','temps','') < "20.0" and InternalIf('HM_FD0445','STATE','') eq "tilted"){fhem('set Tab_Wohnzimmer speak "Kältewarnung Gäste WC"');fhem('set Kaelte_G_WC zukalt')}else{fhem('set Kaelte_G_WC ok')}}<
2019.10.05 15:12:24.591 5: Cmd: >set Kaelte_G_WC ok<
2019.10.05 15:12:24.592 4: dummy set Kaelte_G_WC ok
2019.10.05 15:12:24.592 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:12:24.593 5: End notify loop for LaCrosse_01
2019.10.05 15:12:24.598 5: CUL/RAW: /A0
2019.10.05 15:12:24.614 5: CUL/RAW: A0/ACA80026A1F4900A1000046

2019.10.05 15:12:24.614 4: CUL_Parse: nanoCUL A 0A CA 8002 6A1F49 00A100 0046 -39
2019.10.05 15:12:24.615 5: nanoCUL: dispatch A0ACA80026A1F4900A10000::-39:nanoCUL
2019.10.05 15:12:24.617 5: nanoCUL sending As0BCBA00100A1006A1F490403
2019.10.05 15:12:24.617 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:24.715 5: SW: As0BCBA00100A1006A1F490403
2019.10.05 15:12:24.717 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:2
2019.10.05 15:12:24.886 5: CUL/RAW: /A0ECB80106A1F490
2019.10.05 15:12:24.902 5: CUL/RAW: A0ECB80106A1F490/0A100010000000047

2019.10.05 15:12:24.902 4: CUL_Parse: nanoCUL A 0E CB 8010 6A1F49 00A100 010000000047 -38.5
2019.10.05 15:12:24.903 5: nanoCUL: dispatch A0ECB80106A1F4900A1000100000000::-38.5:nanoCUL
2019.10.05 15:12:24.905 5: nanoCUL sending As10CCA00100A1006A1F4904040000000001
2019.10.05 15:12:24.905 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:25.003 5: SW: As10CCA00100A1006A1F4904040000000001
2019.10.05 15:12:25.005 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:1
2019.10.05 15:12:25.006 5: CUL/RAW: /A0C3B84702009D16A0B1400DF3517

2019.10.05 15:12:25.007 4: CUL_Parse: nanoCUL A 0C 3B 8470 2009D1 6A0B14 00DF3517 -62.5
2019.10.05 15:12:25.007 5: nanoCUL: dispatch A0C3B84702009D16A0B1400DF35::-62.5:nanoCUL
2019.10.05 15:12:25.009 5: Starting notify loop for HM_2009D1, 2 event(s), first is humidity: 53
2019.10.05 15:12:25.009 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:12:25.011 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:12:25.012 5: End notify loop for HM_2009D1
2019.10.05 15:12:25.052 4: PROPLANTA Wetter_Proplanta: HtmlAcquire.594 237490 characters captured
2019.10.05 15:12:25.059 4: PROPLANTA Wetter_Proplanta: Run.703 Start HTML parsing of captured page
2019.10.05 15:12:25.094 5: CUL/RAW: /A0C3B84702009D16A0A8700DF3516

2019.10.05 15:12:25.094 4: CUL_Parse: nanoCUL A 0C 3B 8470 2009D1 6A0A87 00DF3516 -63
2019.10.05 15:12:25.095 5: nanoCUL: dispatch A0C3B84702009D16A0A8700DF35::-63:nanoCUL
2019.10.05 15:12:25.174 5: CUL/RAW: /A0ECC8
2019.10.05 15:12:25.190 5: CUL/RAW: A0ECC8/0106A1F4900A100020800000046

2019.10.05 15:12:25.190 4: CUL_Parse: nanoCUL A 0E CC 8010 6A1F49 00A100 020800000046 -39
2019.10.05 15:12:25.191 5: nanoCUL: dispatch A0ECC80106A1F4900A1000208000000::-39:nanoCUL
2019.10.05 15:12:25.193 5: nanoCUL sending As10CDA00100A1006A1F4900040000000007
2019.10.05 15:12:25.194 5: CUL 6A1F49 dly:96ms
2019.10.05 15:12:25.291 5: SW: As10CDA00100A1006A1F4900040000000007
2019.10.05 15:12:25.293 5: CUL_HM HM_6A1F49 protEvent:CMDs_processing... pending:0
2019.10.05 15:12:25.478 5: CUL/RAW: /A1ACDA0106A1F4900A10003012
2019.10.05 15:12:25.494 5: CUL/RAW: A1ACDA0106A1F4900A10003012/A22093D18030016073000640F050046

2019.10.05 15:12:25.494 4: CUL_Parse: nanoCUL A 1A CD A010 6A1F49 00A100 03012A22093D18030016073000640F050046 -39
2019.10.05 15:12:25.495 5: nanoCUL: dispatch A1ACDA0106A1F4900A10003012A22093D18030016073000640F0500::-39:nanoCUL
2019.10.05 15:12:25.497 5: nanoCUL sending As0ACD800200A1006A1F4900
2019.10.05 15:12:25.497 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:25.595 5: SW: As0ACD800200A1006A1F4900
2019.10.05 15:12:25.596 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:25.734 5: CUL/RAW: /A1ACEA0106A1F490
2019.10.05 15:12:25.750 5: CUL/RAW: A1ACEA0106A1F490/0A10003100000090E4454586C54E4590845204546

2019.10.05 15:12:25.750 4: CUL_Parse: nanoCUL A 1A CE A010 6A1F49 00A100 03100000090E4454586C54E4590845204546 -39
2019.10.05 15:12:25.751 5: nanoCUL: dispatch A1ACEA0106A1F4900A10003100000090E4454586C54E45908452045::-39:nanoCUL
2019.10.05 15:12:25.753 5: nanoCUL sending As0ACE800200A1006A1F4900
2019.10.05 15:12:25.753 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:25.851 5: SW: As0ACE800200A1006A1F4900
2019.10.05 15:12:25.852 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:25.854 4: WEB_192.168.1.125_52160 GET /fhem?detail=HM_6A1F49; BUFLEN:0
2019.10.05 15:12:25.880 4: WEB: /fhem?detail=HM_6A1F49 / RL:7881 / text/html; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:25.881 4: Connection closed for WEB_192.168.1.125_52161: EOF
2019.10.05 15:12:25.962 4: WEB_192.168.1.125_52160 GET /fhem?cmd=%7BReadingsVal(%22HM_6A1F49%22%2C%22assignHmKey%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:12:25.962 5: Cmd: >{ReadingsVal("HM_6A1F49","assignHmKey","")}<
2019.10.05 15:12:25.962 4: WEB: /fhem?cmd=%7BReadingsVal(%22HM_6A1F49%22%2C%22assignHmKey%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:25.969 4: WEB_192.168.1.125_52160 GET /fhem?cmd=%7BAttrVal(%22HM_6A1F49%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.10.05 15:12:25.969 5: Cmd: >{AttrVal("HM_6A1F49","room","")}<
2019.10.05 15:12:25.970 4: WEB: /fhem?cmd=%7BAttrVal(%22HM_6A1F49%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:41 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/ Cache-Control: no-cache, no-store, must-revalidate

2019.10.05 15:12:25.990 5: CUL/RAW: /A1ACFA
2019.10.05 15:12:26.006 5: CUL/RAW: A1ACFA/0106A1F4900A100031F20452045204520452045204520452046

2019.10.05 15:12:26.006 4: CUL_Parse: nanoCUL A 1A CF A010 6A1F49 00A100 031F20452045204520452045204520452046 -39
2019.10.05 15:12:26.007 5: nanoCUL: dispatch A1ACFA0106A1F4900A100031F204520452045204520452045204520::-39:nanoCUL
2019.10.05 15:12:26.009 5: nanoCUL sending As0ACF800200A1006A1F4900
2019.10.05 15:12:26.009 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:26.107 5: SW: As0ACF800200A1006A1F4900
2019.10.05 15:12:26.109 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:26.110 4: WEB_192.168.1.125_52160 GET /fhem?XHR=1&inform=type=status;filter=HM_6A1F49;since=1570281144;fmt=JSON&fw_id=310&timestamp=1570281146257; BUFLEN:0
2019.10.05 15:12:26.262 5: CUL/RAW: /A1AD0A0106A1F4900A100032E4454586C54E459084520452045204546
2019.10.05 15:12:26.278 5: CUL/RAW: A1AD0A0106A1F4900A100032E4454586C54E459084520452045204546/

2019.10.05 15:12:26.278 4: CUL_Parse: nanoCUL A 1A D0 A010 6A1F49 00A100 032E4454586C54E459084520452045204546 -39
2019.10.05 15:12:26.279 5: nanoCUL: dispatch A1AD0A0106A1F4900A100032E4454586C54E4590845204520452045::-39:nanoCUL
2019.10.05 15:12:26.280 5: nanoCUL sending As0AD0800200A1006A1F4900
2019.10.05 15:12:26.280 5: CUL 6A1F49 dly:98ms
2019.10.05 15:12:26.379 5: SW: As0AD0800200A1006A1F4900
2019.10.05 15:12:26.380 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:26.382 5: LaCrosseGateway: dispatch OK 9 39 1 4 200 59
2019.10.05 15:12:26.518 5: CUL/RAW: /A1AD1A0106A1F4900A100033D2045204520452045204520
2019.10.05 15:12:26.534 5: CUL/RAW: A1AD1A0106A1F4900A100033D2045204520452045204520/443C585A46

2019.10.05 15:12:26.534 4: CUL_Parse: nanoCUL A 1A D1 A010 6A1F49 00A100 033D2045204520452045204520443C585A46 -39
2019.10.05 15:12:26.535 5: nanoCUL: dispatch A1AD1A0106A1F4900A100033D2045204520452045204520443C585A::-39:nanoCUL
2019.10.05 15:12:26.536 5: nanoCUL sending As0AD1800200A1006A1F4900
2019.10.05 15:12:26.537 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:26.635 5: SW: As0AD1800200A1006A1F4900
2019.10.05 15:12:26.637 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:26.774 5: CUL/RAW: /A1AD2A0106A1F4900A100034C44A854E45908
2019.10.05 15:12:26.790 5: CUL/RAW: A1AD2A0106A1F4900A100034C44A854E45908/45204520452045204546

2019.10.05 15:12:26.791 4: CUL_Parse: nanoCUL A 1A D2 A010 6A1F49 00A100 034C44A854E4590845204520452045204546 -39
2019.10.05 15:12:26.791 5: nanoCUL: dispatch A1AD2A0106A1F4900A100034C44A854E45908452045204520452045::-39:nanoCUL
2019.10.05 15:12:26.793 5: nanoCUL sending As0AD2800200A1006A1F4900
2019.10.05 15:12:26.793 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:26.811 4: PROPLANTA Wetter_Proplanta: HtmlAcquire.575 Start capturing of https://www.proplanta.de/Wetter/profi-wetter.php?SITEID=60&PLZ=48159&STADT=48159&WETTERaufrufen=stadt&Wtp=&SUCHE=Wetter&wT=11
2019.10.05 15:12:26.891 5: SW: As0AD2800200A1006A1F4900
2019.10.05 15:12:26.893 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:27.030 5: CUL/RAW: /A1AD3A0106A1F4900A100035B20
2019.10.05 15:12:27.046 5: CUL/RAW: A1AD3A0106A1F4900A100035B20/452045204520443C585A44A854E446

2019.10.05 15:12:27.047 4: CUL_Parse: nanoCUL A 1A D3 A010 6A1F49 00A100 035B20452045204520443C585A44A854E446 -39
2019.10.05 15:12:27.047 5: nanoCUL: dispatch A1AD3A0106A1F4900A100035B20452045204520443C585A44A854E4::-39:nanoCUL
2019.10.05 15:12:27.049 5: nanoCUL sending As0AD3800200A1006A1F4900
2019.10.05 15:12:27.049 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:27.147 5: SW: As0AD3800200A1006A1F4900
2019.10.05 15:12:27.149 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:27.286 5: CUL/RAW: /A1AD4A0106A1F4900
2019.10.05 15:12:27.302 5: CUL/RAW: A1AD4A0106A1F4900/A100036A59084520452045204520452045204547

2019.10.05 15:12:27.303 4: CUL_Parse: nanoCUL A 1A D4 A010 6A1F49 00A100 036A59084520452045204520452045204547 -38.5
2019.10.05 15:12:27.303 5: nanoCUL: dispatch A1AD4A0106A1F4900A100036A590845204520452045204520452045::-38.5:nanoCUL
2019.10.05 15:12:27.304 5: nanoCUL sending As0AD4800200A1006A1F4900
2019.10.05 15:12:27.305 5: CUL 6A1F49 dly:98ms
2019.10.05 15:12:27.403 5: SW: As0AD4800200A1006A1F4900
2019.10.05 15:12:27.405 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:27.407 5: CUL/RAW: /A0F2E86106A0B140000000AA8E30B0000ED

2019.10.05 15:12:27.407 4: CUL_Parse: nanoCUL A 0F 2E 8610 6A0B14 000000 0AA8E30B0000ED -83.5
2019.10.05 15:12:27.407 5: nanoCUL: dispatch A0F2E86106A0B140000000AA8E30B0000::-83.5:nanoCUL
2019.10.05 15:12:27.542 5: CUL/RAW: /A1AD5A
2019.10.05 15:12:27.558 5: CUL/RAW: A1AD5A/0106A1F4900A1000379204520443C585A44A854E45908452046

2019.10.05 15:12:27.559 4: CUL_Parse: nanoCUL A 1A D5 A010 6A1F49 00A100 0379204520443C585A44A854E45908452046 -39
2019.10.05 15:12:27.559 5: nanoCUL: dispatch A1AD5A0106A1F4900A1000379204520443C585A44A854E459084520::-39:nanoCUL
2019.10.05 15:12:27.561 5: nanoCUL sending As0AD5800200A1006A1F4900
2019.10.05 15:12:27.561 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:27.659 5: SW: As0AD5800200A1006A1F4900
2019.10.05 15:12:27.661 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:27.670 4: PROPLANTA Wetter_Proplanta: HtmlAcquire.594 233326 characters captured
2019.10.05 15:12:27.678 4: PROPLANTA Wetter_Proplanta: Run.703 Start HTML parsing of captured page
2019.10.05 15:12:27.757 5: LaCrosseGateway: dispatch OK 9 17 130 4 193 125
2019.10.05 15:12:27.814 5: CUL/RAW: /A1AD6A0106A1F4900A100038845204520452045204520452045204446
2019.10.05 15:12:27.830 5: CUL/RAW: A1AD6A0106A1F4900A100038845204520452045204520452045204446
/

2019.10.05 15:12:27.831 4: CUL_Parse: nanoCUL A 1A D6 A010 6A1F49 00A100 038845204520452045204520452045204446 -39
2019.10.05 15:12:27.831 5: nanoCUL: dispatch A1AD6A0106A1F4900A1000388452045204520452045204520452044::-39:nanoCUL
2019.10.05 15:12:27.833 5: nanoCUL sending As0AD6800200A1006A1F4900
2019.10.05 15:12:27.833 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:27.931 5: SW: As0AD6800200A1006A1F4900
2019.10.05 15:12:27.933 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:28.070 5: CUL/RAW: /A1AD7A0106A1F4900A10003973C585A44A854E4590845204
2019.10.05 15:12:28.086 5: CUL/RAW: A1AD7A0106A1F4900A10003973C585A44A854E4590845204/520452046

2019.10.05 15:12:28.086 4: CUL_Parse: nanoCUL A 1A D7 A010 6A1F49 00A100 03973C585A44A854E4590845204520452046 -39
2019.10.05 15:12:28.087 5: nanoCUL: dispatch A1AD7A0106A1F4900A10003973C585A44A854E45908452045204520::-39:nanoCUL
2019.10.05 15:12:28.088 5: nanoCUL sending As0AD7800200A1006A1F4900
2019.10.05 15:12:28.088 5: CUL 6A1F49 dly:98ms
2019.10.05 15:12:28.187 5: SW: As0AD7800200A1006A1F4900
2019.10.05 15:12:28.189 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:28.326 5: CUL/RAW: /A1AD8A0106A1F4900A10003A64520452045204
2019.10.05 15:12:28.342 5: CUL/RAW: A1AD8A0106A1F4900A10003A64520452045204/5204520443C585A4446

2019.10.05 15:12:28.343 4: CUL_Parse: nanoCUL A 1A D8 A010 6A1F49 00A100 03A645204520452045204520443C585A4446 -39
2019.10.05 15:12:28.343 5: nanoCUL: dispatch A1AD8A0106A1F4900A10003A645204520452045204520443C585A44::-39:nanoCUL
2019.10.05 15:12:28.345 5: nanoCUL sending As0AD8800200A1006A1F4900
2019.10.05 15:12:28.345 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:28.443 5: SW: As0AD8800200A1006A1F4900
2019.10.05 15:12:28.445 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:28.582 5: CUL/RAW: /A1AD9A0106A1F4900A10003B5A85
2019.10.05 15:12:28.598 5: CUL/RAW: A1AD9A0106A1F4900A10003B5A85/4E459084520452045204520452046

2019.10.05 15:12:28.599 4: CUL_Parse: nanoCUL A 1A D9 A010 6A1F49 00A100 03B5A854E459084520452045204520452046 -39
2019.10.05 15:12:28.599 5: nanoCUL: dispatch A1AD9A0106A1F4900A10003B5A854E4590845204520452045204520::-39:nanoCUL
2019.10.05 15:12:28.602 5: nanoCUL sending As0AD9800200A1006A1F4900
2019.10.05 15:12:28.602 5: CUL 6A1F49 dly:96ms
2019.10.05 15:12:28.699 5: SW: As0AD9800200A1006A1F4900
2019.10.05 15:12:28.701 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:28.702 5: LaCrosseGateway: dispatch OK 9 1 1 4 195 65
2019.10.05 15:12:28.704 5: Starting notify loop for LaCrosse_01, 1 event(s), first is temps: 21.9
2019.10.05 15:12:28.704 5: createNotifyHash
2019.10.05 15:12:28.706 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:12:28.707 5: Triggering Kaelte_Gaeste_WC
2019.10.05 15:12:28.707 4: Kaelte_Gaeste_WC exec IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "open")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt) ELSE (
IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)
ELSE
(set Kaelte_G_WC ok)
)
2019.10.05 15:12:28.707 5: Cmd: >IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "open")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt) ELSE (
IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted")
(set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)
ELSE
(set Kaelte_G_WC ok)
)<
2019.10.05 15:12:28.708 5: Cmd: >{if(ReadingValIf('LaCrosse_01','temps','') < "20.0" and InternalIf('HM_FD0445','STATE','') eq "open"){fhem('set Tab_Wohnzimmer speak "Kältewarnung Gäste WC"');fhem('set Kaelte_G_WC zukalt')}else{fhem('IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted") (set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)ELSE(set Kaelte_G_WC ok)')}}<
2019.10.05 15:12:28.708 5: Cmd: >IF ([LaCrosse_01:temps] < "20.0" and [HM_FD0445] eq "tilted") (set Tab_Wohnzimmer speak "Kältewarnung Gäste WC",set Kaelte_G_WC zukalt)ELSE(set Kaelte_G_WC ok)<
2019.10.05 15:12:28.709 5: Cmd: >{if(ReadingValIf('LaCrosse_01','temps','') < "20.0" and InternalIf('HM_FD0445','STATE','') eq "tilted"){fhem('set Tab_Wohnzimmer speak "Kältewarnung Gäste WC"');fhem('set Kaelte_G_WC zukalt')}else{fhem('set Kaelte_G_WC ok')}}<
2019.10.05 15:12:28.709 5: Cmd: >set Kaelte_G_WC ok<
2019.10.05 15:12:28.709 4: dummy set Kaelte_G_WC ok
2019.10.05 15:12:28.710 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:12:28.710 5: End notify loop for LaCrosse_01
2019.10.05 15:12:28.839 5: CUL/RAW: /A17DAA0106A1F4900A10003C44520
2019.10.05 15:12:28.854 5: CUL/RAW: A17DAA0106A1F4900A10003C44520/4520452012212D12212B46

2019.10.05 15:12:28.855 4: CUL_Parse: nanoCUL A 17 DA A010 6A1F49 00A100 03C445204520452012212D12212B46 -39
2019.10.05 15:12:28.855 5: nanoCUL: dispatch A17DAA0106A1F4900A10003C445204520452012212D12212B::-39:nanoCUL
2019.10.05 15:12:28.857 5: nanoCUL sending As0ADA800200A1006A1F4900
2019.10.05 15:12:28.857 5: CUL 6A1F49 dly:97ms
2019.10.05 15:12:28.955 5: SW: As0ADA800200A1006A1F4900
2019.10.05 15:12:28.957 5: CUL_HM HM_6A1F49 sent ACK:2
2019.10.05 15:12:29.095 5: CUL/RAW: /A0BDB80106A1F4900A100030046

2019.10.05 15:12:29.095 4: CUL_Parse: nanoCUL A 0B DB 8010 6A1F49 00A100 030046 -39
2019.10.05 15:12:29.095 5: nanoCUL: dispatch A0BDB80106A1F4900A1000300::-39:nanoCUL
2019.10.05 15:12:29.104 5: CUL_HM HM_6A1F49 protEvent:CMDs_done
2019.10.05 15:12:29.105 5: Starting notify loop for HM_6A1F49, 1 event(s), first is CMDs_done
2019.10.05 15:12:29.105 5: BatterieStatus: not on any display, ignoring notify
2019.10.05 15:12:29.106 5: Motor_Status: not on any display, ignoring notify
2019.10.05 15:12:29.113 5: End notify loop for HM_6A1F49


frank

global verbose 5 war natürlich nicht gewünscht. hier mal die entscheidenden abschnitte zusammengefasst:

2019.10.05 15:05:34.485 3: CUL_HM set HM_6A1F49_Clima getConfig
2019.10.05 15:05:34.486 5: SW: As0927B11200A1006A1F49
2019.10.05 15:05:35.069 4: CUL_Parse: Cube_Ankleide A 0A 27 8002 6A1F49 00A100 003B -44.5
2019.10.05 15:05:35.170 5: SW: As0B28A00100A1006A1F490403
2019.10.05 15:05:35.565 4: CUL_Parse: Cube_Ankleide A 0E 28 8010 6A1F49 00A100 01000000003A -45
2019.10.05 15:05:35.666 5: SW: As1029A00100A1006A1F4904040000000001
2019.10.05 15:05:36.060 4: CUL_Parse: Cube_Ankleide A 0E 29 8010 6A1F49 00A100 02080000003A -45

2019.10.05 15:05:36.161 5: SW: As102AA00100A1006A1F4900040000000007
2019.10.05 15:05:36.556 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45
2019.10.05 15:05:36.656 5: SW: As0A2A800200A1006A1F4900

2019.10.05 15:05:36.688 4: CUL_Parse: Cube_Ankleide A 1A 2A A010 6A1F49 00A100 03012A22093D18030016073000640F05003A -45


##############################

2019.10.05 15:12:24.084 3: CUL_HM set HM_6A1F49_Clima getConfig
2019.10.05 15:12:24.085 5: SW: As09CAB11200A1006A1F49
2019.10.05 15:12:24.614 4: CUL_Parse: nanoCUL A 0A CA 8002 6A1F49 00A100 0046 -39
2019.10.05 15:12:24.715 5: SW: As0BCBA00100A1006A1F490403
2019.10.05 15:12:24.902 4: CUL_Parse: nanoCUL A 0E CB 8010 6A1F49 00A100 010000000047 -38.5
2019.10.05 15:12:25.003 5: SW: As10CCA00100A1006A1F4904040000000001
2019.10.05 15:12:25.190 4: CUL_Parse: nanoCUL A 0E CC 8010 6A1F49 00A100 020800000046 -39

2019.10.05 15:12:25.291 5: SW: As10CDA00100A1006A1F4900040000000007
2019.10.05 15:12:25.494 4: CUL_Parse: nanoCUL A 1A CD A010 6A1F49 00A100 03012A22093D18030016073000640F050046 -39
2019.10.05 15:12:25.595 5: SW: As0ACD800200A1006A1F4900

2019.10.05 15:12:25.750 4: CUL_Parse: nanoCUL A 1A CE A010 6A1F49 00A100 03100000090E4454586C54E4590845204546 -39



fazit: die latenz mit cube ist so schlecht, dass das timing beim 4. gesendeten befehl von fhem (SW:) nicht mehr funktioniert. hier wird liste 7 abgefragt, die durch ihre länge bedingt, aus vielen teilantworten des rt besteht, die jeweils mit einem ack von fhem beantwortet werden müssen.

bei der 2. teilantwort (jeweils letzte zeile) wiederholt der rt bereits die erste teilantwort, weil das ack wahrscheinlich nicht rechtzeitig ankam.

die antwortzeiten bei den befehlen 2-4 liegen mit cube bei ca. 400ms, mit cul bei ca. 200ms. also deutlich schlechter.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

Nitaro

Vielen Dank !
Der Cube und der nanoCUL sind im selben Raum, also gleiche Entfernung zum RT (Raum nebenan).
Jetzt bleibt also die spannende Frage warum das beim Cube so lange dauert. Laut der anderen
Thread Anfrage sollte es zu keinen Problemen kommen.

frank

angenommen, es liegt nicht an der fw, dann muss die zeitdifferenz durch die anbindung des cubes entstehen.

also der weg des signals von fhem bis zur fw im cube. diese strecke wird 2 mal durchlaufen bei der antwortzeit.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

Nitaro


Beide sind via LAN angeschlossen, 1Gbit/s, keine hohen Latenzen, keine IP Konflikte.
Works as designed quasi. Mein fhem läuft auf einem corei5 "Server",die Eventlast halte
ich mich event-on-change-reading gering. Da fällt mir jetzt erstmal nichts ein was da für
die hohe Antwortzeit verantwortlich sein könnte.

frank

Zitat1Gbit/s
dem hmlan io von homematic würde das gar nicht gefallen.
was sagt denn die BA des cube zum lan?
eventuell mal "drosseln" mit besser passendem switch / managed switch.

wenn ich richtig verstanden habe, könnte man auch usb nutzen. falls ja, würde ich das mal testen.

Zitatcorei5 "Server"
das sagt mir leider gar nichts.
wenn es mit "containern" zu tun hat, könnte das "durchreichen" der schnittstelle ein problem sein.

eventlast kann nicht das problem sein, sonst wäre der cul auch betroffen.


irgendwo muss die verzögerung ja herkommen.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html