FHEM Forum

FHEM - Hausautomations-Systeme => Homematic => Thema gestartet von: joachimm am 04 Oktober 2017, 11:52:05

Titel: Aktueller Status nur nach get Update
Beitrag von: joachimm am 04 Oktober 2017, 11:52:05
Hallo,

ich habe mit HMCCUDEV  ein ein neues Device angelegt. Änderungen im STATE werden nur nach get <device> update angezeigt (Entweder auf dem HMCCUDEV oder HMCCU). Ich finde das einfach nicht...

Vielen Dank
Joachim
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Barit am 04 Oktober 2017, 15:24:53
Was für ein Device hast du neu denn neu angelegt hast und welches Protokoll verwendet es (BidCos-RF, HmIP-RF, etc.)?
Vielleicht hilft auch schon dieser Thread weiter:
https://forum.fhem.de/index.php/topic,40189.msg641541.html#msg641541 (https://forum.fhem.de/index.php/topic,40189.msg641541.html#msg641541)

Die Suchfunktion des Forums hilft ggf. auch.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 04 Oktober 2017, 16:39:48
Das passende Protokoll muss aktiviert und der RPC Server gestartet sein
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 05 Oktober 2017, 10:05:27
Vielen Dank,

das habe ich gemacht. Das geht ja auch eine Zeit lang... Dann nur noch mit "get update". Würde Ihr bitte mal einen Blick darauf werfen? Eigentlich habe ich alles nach "Best Practice" gemacht.... denke ich zumindest.
Das Device schaltet aber einwandfrei....
Stoppe und starte ich den RPC... geht das wieder für eine Zeit (10min) einwandfrei...

edit: habe auch den internen RPC probiert. Das gleiche Phänomen.

CCU
define d_ccu HMCCU 10.1.1.27
attr d_ccu ccuflags extrpc
attr d_ccu cmdIcon on:general_an off:general_aus
attr d_ccu eventMap /rpcserver on:on/rpcserver off:off/
attr d_ccu rpcinterfaces BidCos-RF
attr d_ccu rpcport 2001
attr d_ccu rpcserver on
attr d_ccu stateFormat rpcstate/state

#RPC
define d_ccu_rpc HMCCURPC 10.1.1.27
attr d_ccu_rpc stateFormat rpcstate/state
attr d_ccu_rpc verbose 2



Steckdosenschalter

define HM_TV HMCCUDEV TV
attr HM_TV IODev d_ccu
attr HM_TV ccureadingfilter (STATE|LOWBAT|ON_TIME)
attr HM_TV ccureadings 1
attr HM_TV devStateIcon on:10px-kreis-gruen off:10px-kreis-rot Initialized:10px-kreis-gelb
attr HM_TV event-on-change-reading .*
attr HM_TV statechannel 1
attr HM_TV statevals on:true,off:false
attr HM_TV substitute STATE!true:on,false:off,1:on,0:off


Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 05 Oktober 2017, 12:42:08
Wenn die Aktualisierung nach 10 Minuten ausbleibt: was steht dann im FHEM Log? Irgendwelche Meldungen von HMCCU oder HMCCURPC?

Ich vermute, dass die Netzwerkverbindung zur CCU abbricht. Benutzt Du WLAN?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 05 Oktober 2017, 19:30:12
Nein, die CCU ist am LAN und verliert auch nicht die Connectivität. Und die Funkttion ist ja gegeben. Er aktualisiert nur nicht. Bin echt ratlos...
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 05 Oktober 2017, 19:38:36
Ohne Fehlermeldung im FHEM Log?
FHEM ist auch im LAN und nicht im WLAN?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 05 Oktober 2017, 19:43:38

17.10.05 19:16:03.997 2: HMCCU: Received no events from interface CB2001 for 600 seconds
2017.10.05 19:16:44.277 4: CUL_Parse: CUL_0 H007600595173F6 -79
2017.10.05 19:24:45.147 4: CUL_Parse: CUL_0 K01873083EA -85
2017.10.05 19:26:03.186 2: HMCCU: Received no events from interface CB2001 for 600 seconds
2017.10.05 19:28:30.010 4: CUL_Parse: CUL_0 K715581580C -68
2017.10.05 19:33:36.181 4: CUL_Parse: CUL_0 K01863083F6 -79
2017.10.05 19:36:33.193 4: CUL_Parse: CUL_0 K01863083E0 -90
2017.10.05 19:37:36.330 4: CUL_Parse: CUL_0 H007600595173F8 -78


Nein, keine Fehler zu sehen. CCU ist im LAN. Schalten tut es ja...
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 06 Oktober 2017, 08:16:12
Entweder du hast nur wenige Geräte angemeldet und deshalb gibt es für 10 Minuten kein Event. Oder die CCU vergisst aus welchen Gründen auch immer FHEM als Abnehmer der Events.

Du kannst mal prüfen, ob in /var/log/messages auf der CCU irgendwelche Fehlermeldungen stehen.

Wenn der Fall eintritt: startest du dann nur den RPC Server neu oder auch die CCU?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 06 Oktober 2017, 10:16:08
Ich danke schon mal für die Hilfe. In /var/log/messages sind keine Einträge. Um wieder in Funktion zu gehen starte ich einfach den RPC neu. Dann gehts wieder für 5min...

Ich setze mal auf einem anderen Raspi das System neu auf. Mal sehen was dann ist...

Danke
Joachim
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 09 Oktober 2017, 14:31:07
Hallo,

muss ich noch mal aufgreifen. Ich habe ein neues System aufgesetzt. Funktioniert auch nicht. Nach genau 10min. keine Aktualisierung. Meine CCU ist auf einem anderen Raspberry installiert (Raspimatic). Kann es daran liegen? Würde mich aber wundern, denn der läuft besser als org. CCU2

Danke
Joachim
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 09 Oktober 2017, 16:31:31
Welche (Typ) und wie viele Homematic Geräte hast Du in FHEM definiert?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 09 Oktober 2017, 16:59:33
Hallo,

3x HM-CC-RT-DN
1x HM-LC-Sw1-Pl-2

das mit den genau 10min stimmt doch nicht so. Jetzt gings mal für 15min. Wenn ich den RPC neu starte ist wieder alles gut. Da muss doch bei mir irgendwas anders sein....*verzweifel*
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 09 Oktober 2017, 17:38:06
Habe noch mal die Kommunikation mit tshark getraced..

Ab Zeile 593 funktioniert es nicht mehr. Hier stellt der RPC seinen Dienst ein...


562 350.034355202    10.1.1.40 → 10.1.1.27    TCP 83 [TCP segment of a reassembled PDU]
  563 350.035212071    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [ACK] Seq=539 Ack=18 Win=29312 Len=0 TSval=10853574 TSecr=641175
  564 350.035283164    10.1.1.40 → 10.1.1.27    HTTP/XML 776 HTTP/1.1 200 OK
  565 350.036085971    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [ACK] Seq=539 Ack=728 Win=30720 Len=0 TSval=10853574 TSecr=641175
  566 350.036816071    10.1.1.27 → 10.1.1.40    HTTP/XML 604 POST /fh2001 HTTP/1.1
  567 350.044478780    10.1.1.40 → 10.1.1.27    TCP 83 [TCP segment of a reassembled PDU]
  568 350.091320866    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [ACK] Seq=1077 Ack=745 Win=30720 Len=0 TSval=10853580 TSecr=641176
  569 350.091393313    10.1.1.40 → 10.1.1.27    HTTP/XML 776 HTTP/1.1 200 OK
  570 350.092127892    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [ACK] Seq=1077 Ack=1455 Win=32128 Len=0 TSval=10853580 TSecr=641181
  571 360.055683579    10.1.1.40 → 10.1.1.27    TCP 66 7411 → 41418 [FIN, ACK] Seq=1455 Ack=1077 Win=31232 Len=0 TSval=642177 TSecr=10853580
  572 360.101341455    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [ACK] Seq=1077 Ack=1456 Win=32128 Len=0 TSval=10854581 TSecr=642177
  573 365.025497154    10.1.1.27 → 10.1.1.40    HTTP/XML 604 POST /fh2001 HTTP/1.1
  574 365.025579914    10.1.1.40 → 10.1.1.27    TCP 54 7411 → 41418 [RST] Seq=1456 Win=0 Len=0
  575 365.025500904    10.1.1.27 → 10.1.1.40    TCP 66 41418 → 7411 [FIN, ACK] Seq=1615 Ack=1456 Win=32128 Len=0 TSval=10855073 TSecr=642177
  576 365.025658299    10.1.1.40 → 10.1.1.27    TCP 54 7411 → 41418 [RST] Seq=1456 Win=0 Len=0
  577 365.025502467    10.1.1.27 → 10.1.1.40    TCP 74 41420 → 7411 [SYN] Seq=0 Win=29200 Len=0 MSS=1460 SACK_PERM=1 TSval=10855073 TSecr=0 WS=128
  578 365.025738298    10.1.1.40 → 10.1.1.27    TCP 74 7411 → 41420 [SYN, ACK] Seq=0 Ack=1 Win=28960 Len=0 MSS=1460 SACK_PERM=1 TSval=642674 TSecr=10855073 WS=128
  579 365.026282982    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=1 Ack=1 Win=29312 Len=0 TSval=10855073 TSecr=642674
  580 365.026490168    10.1.1.27 → 10.1.1.40    HTTP/XML 604 POST /fh2001 HTTP/1.1
  581 365.026530585    10.1.1.40 → 10.1.1.27    TCP 66 7411 → 41420 [ACK] Seq=1 Ack=539 Win=30080 Len=0 TSval=642674 TSecr=10855073
  582 365.035181309    10.1.1.40 → 10.1.1.27    TCP 83 [TCP segment of a reassembled PDU]
  583 365.036023908    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=539 Ack=18 Win=29312 Len=0 TSval=10855074 TSecr=642675
  584 365.036095209    10.1.1.40 → 10.1.1.27    HTTP/XML 776 HTTP/1.1 200 OK
  585 365.036910464    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=539 Ack=728 Win=30720 Len=0 TSval=10855074 TSecr=642675
  586 365.037654574    10.1.1.27 → 10.1.1.40    HTTP/XML 604 POST /fh2001 HTTP/1.1
  587 365.055278885    10.1.1.40 → 10.1.1.27    TCP 83 [TCP segment of a reassembled PDU]
  588 365.101314623    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=1077 Ack=745 Win=30720 Len=0 TSval=10855081 TSecr=642677
  589 365.101405352    10.1.1.40 → 10.1.1.27    HTTP/XML 776 HTTP/1.1 200 OK
  590 365.102154253    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=1077 Ack=1455 Win=32128 Len=0 TSval=10855081 TSecr=642682
  591 367.179217549    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [FIN, ACK] Seq=1077 Ack=1455 Win=32128 Len=0 TSval=10855288 TSecr=642682
  592 367.179668223    10.1.1.40 → 10.1.1.27    TCP 66 7411 → 41420 [FIN, ACK] Seq=1455 Ack=1078 Win=31232 Len=0 TSval=642890 TSecr=10855288
  593 367.180432020    10.1.1.27 → 10.1.1.40    TCP 66 41420 → 7411 [ACK] Seq=1078 Ack=1456 Win=32128 Len=0 TSval=10855288 TSecr=642890
  594 370.465431647 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  595 400.468406075 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  596 430.478368023 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  597 449.811235979    10.1.1.27 → 224.0.0.22   IGMPv3 60 Membership Report / Join group 239.255.255.250 for any sources
  598 460.477341255 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  599 490.474322022 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  600 520.474311453 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2
  601 550.484296450 Synology_3e:ae:dd → Broadcast    ARP 60 Who has 10.1.1.27? Tell 10.1.1.2

Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 09 Oktober 2017, 18:31:54
Ok, die Thermostate müssten auf jeden Fall regelmäßig Events liefern. HMCCU macht nach dem Start des RPC Servers ein globales get update. Ich vermute, das interpretierst Du als funktionierende Kommunikation.

Ich kenne mich mit tshark nicht aus, vermute aber, dass 45994 und 8181 TCP Ports sind. Port 8181 ist der tclrega Port auf der CCU. Darüber werden Homematic Scripts ausgeführt (eben z.B. get update).

RPC-Verkehr (das wären Updates, die von der CCU kommen) verwendet andere Ports.

Bitte poste mal die Logeinträge aus dem FHEM Log vom Start des RPC Servers bis zur ersten Meldung, dass keine Events kommen.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 09 Oktober 2017, 19:50:53
Es ist wohl tatsächlich so, das sich Geräte immer wieder mal melden müssen. Ich habe noch ein Thermostat dazu genommen. Es scheint jetzt zu funktionieren. Nur mit Schaltern und einem Thermostat gings nicht. Aber noch beobachte ich...

EDIT:
Nein leider doch nicht. Der RPC ist jetzt aber ca. 1h gelaufen. Keine Einträge mehr im Logfile von den Devices. ....Sch...ade

Wie heißt denn der dazugehörige Prozess?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: joachimm am 10 Oktober 2017, 13:40:36
vermutlich trifft es diejenigen, die CCU als Software auf einem RPi laufen haben. Sobald für eine Zeit X der RPC-Server keine Verbindung zur CCU initiiert, funktioniert zwar die Bedienung der Geräte, aber der Status wird nicht aktualisiert. Der RPC Server stellt seine Funktion ein. Dies wird auch nicht als Status angezeigt.

Workaround:
In FHEM ein Dummy HMCCUDEV erstellen und periodisch (alle 2min) eine Aktion ausführen lassen.  Läuft seit gestern einwandfrei. Die alte, sowie die neue Installation von FHEM. Ist halt so...

Joachim
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 10 Oktober 2017, 16:49:40
Da gibt es einige mit dieser Konstellation und von denen hat sich bisher keiner beschwert.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Revi am 30 Januar 2018, 22:01:09
Zitat von: joachimm am 10 Oktober 2017, 13:40:36
vermutlich trifft es diejenigen, die CCU als Software auf einem RPi laufen haben. Sobald für eine Zeit X der RPC-Server keine Verbindung zur CCU initiiert, funktioniert zwar die Bedienung der Geräte, aber der Status wird nicht aktualisiert. Der RPC Server stellt seine Funktion ein. Dies wird auch nicht als Status angezeigt.

Workaround:
In FHEM ein Dummy HMCCUDEV erstellen und periodisch (alle 2min) eine Aktion ausführen lassen.  Läuft seit gestern einwandfrei. Die alte, sowie die neue Installation von FHEM. Ist halt so...

Joachim


Ich habe auch meine CCU auf einem RasPi laufen und das aktualisierungsproblem.
Welche Aktion lässt Du hier z.B. ausführen?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 22 Februar 2018, 16:55:26
Auch mich würde der Workaround interessieren da ich ebenfalls von dem Problem betroffen zu sein scheine. Leider erhalte ich aber zusätzlich nach den 10 Minuten beim ersten Absetzen eines Befehls (beispielsweise Änderung der Temperatur) eine Fehlermeldung:

HMCCUDEV: HMIP_Device Execution of CCU script or command failed

Ich werde dann auf eine Seite mit diesem Fehler weitergeleitet und bekomme den Logeintrag. Der Befehl wird im Hintergrund aber trotzdem nach kurzer Verzögerung ohne weiteres Zutun ausgeführt. Nun folgende Befehle werden wieder sauber verarbeitet ohne, dass die genannte Fehlermeldung angezeigt wird. Das Problem tritt nun nach weiteren 10 Minuten ohne Kommunikation sehr wahrscheinlich erneut auf.

Es läuft RaspMatic auf einem zusätzlichen Raspberry Pi 3.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 22 Februar 2018, 18:56:17
Fragen:

Läuft die CCU auf dem gleichen Raspi wie FHEM? Wenn nein, sind die Raspis per WLAN im Netz?

Wie sieht Definiton des Gerätes in FHEM aus, bei dem das Setzen der Temperatur zum Script Fehler führt (list)?

Wie sieht die Ausgabe von "get deviceinfo" für das o.g. Gerät aus?

Was meinst Du mit "Temperatur setzen"? Wie sieht der entsprechende Set-Befehl exakt aus?

Ist der RPC Server korrekt konfiguriert (rpcinterfaces auf richtige Schnittstelle(n) gesetzt)?
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 23 Februar 2018, 12:59:38
Zitat von: zap am 22 Februar 2018, 18:56:17
Fragen:

Was meinst Du mit "Temperatur setzen"? Wie sieht der entsprechende Set-Befehl exakt aus?

Ist der RPC Server korrekt konfiguriert (rpcinterfaces auf richtige Schnittstelle(n) gesetzt)?

1. Die beiden Systeme laufen auf zwei verschiedenen Raspberry Pi 3, beide jeweils ausschließlich per LAN Verbunden.

2. List vom entsprechenden Gerät, per Autocreate erstellt:
Internals:
   DEF        000393C9A4F405
   IODev      raspiCCU2
   NAME       HMIP_Radiator_Thermostat_Livingroom
   NR         31
   STATE      17.0
   TYPE       HMCCUDEV
   ccuaddr    000393C9A4F405
   ccudevstate active
   ccuif      HmIP-RF
   ccuname    HMIP-Radiator-Thermostat-Livingroom
   ccutype    HMIP-eTRV
   channels   8
   firmware   1.6.3
   statevals  devstate
   READINGS:
     2018-02-23 12:35:31   0.LOW_BAT       ok
     2018-02-23 12:35:31   1.ACTUAL_TEMPERATURE 19.8
     2018-02-23 12:35:31   1.BOOST_MODE    0
     2018-02-23 12:35:31   1.BOOST_TIME    0
     2018-02-23 12:35:31   1.SET_POINT_MODE 0
     2018-02-23 12:35:31   1.SET_POINT_TEMPERATURE 17.0
     2018-02-23 12:35:31   1.WINDOW_STATE  closed
     2018-02-23 12:35:31   control         17.0
     2018-02-23 12:35:31   hmstate         17.0
     2018-02-23 12:35:31   state           17.0
     2018-02-23 12:35:31   valve_position  0
   hmccu:
     dp:
       0.CONFIG_PENDING:
         OVAL       false
         VAL        false
       0.DUTY_CYCLE:
         OVAL       0
         VAL        0
       0.LOW_BAT:
         OSVAL      ok
         OVAL       0
         SVAL       ok
         VAL        0
       0.OPERATING_VOLTAGE:
         OVAL       2.5
         VAL        2.5
       0.RSSI_DEVICE:
         OVAL       -57
         VAL        -57
       0.RSSI_PEER:
         OVAL       -60
         VAL        -61
       0.UNREACH:
         OVAL       0
         VAL        0
       0.UPDATE_PENDING:
         OVAL       false
         VAL        false
       1.ACTIVE_PROFILE:
         OVAL       1
         VAL        1
       1.ACTUAL_TEMPERATURE:
         OSVAL      19.8
         OVAL       19.8
         SVAL       19.8
         VAL        19.8
       1.BOOST_MODE:
         OSVAL      0
         OVAL       0
         SVAL       0
         VAL        0
       1.BOOST_TIME:
         OSVAL      0
         OVAL       0
         SVAL       0
         VAL        0
       1.FROST_PROTECTION:
         OVAL       0
         VAL        0
       1.LEVEL:
         OSVAL      0
         OVAL       0.0
         SVAL       0
         VAL        0.0
       1.PARTY_MODE:
         OVAL       0
         VAL        0
       1.PARTY_SET_POINT_TEMPERATURE:
         OVAL       0.000000
         VAL        0.000000
       1.PARTY_TIME_END:
         OVAL       
         VAL       
       1.PARTY_TIME_START:
         OVAL       
         VAL       
       1.SET_POINT_MODE:
         OSVAL      1
         OVAL       1
         SVAL       0
         VAL        0
       1.SET_POINT_TEMPERATURE:
         OSVAL      17.0
         OVAL       17.0
         SVAL       17.0
         VAL        17.0
       1.SWITCH_POINT_OCCURED:
         OVAL       0
         VAL        0
       1.VALVE_STATE:
         OVAL       4
         VAL        4
       1.WINDOW_STATE:
         OSVAL      closed
         OVAL       0
         SVAL       closed
         VAL        0
Attributes:
   IODev      raspiCCU2
   alias      Heizkörperthermostat
   ccureadingfilter ^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
   ccureadingname 1.LEVEL:valve_position
   ccuscaleval LEVEL:0:1:0:100
   controldatapoint 1.SET_POINT_TEMPERATURE
   eventMap   /datapoint 1.BOOST_MODE true:Boost/datapoint 1.CONTROL_MODE 0:Auto/datapoint 1.CONTROL_MODE 1:Manual/datapoint 1.CONTROL_MODE 2:Holiday/datapoint 1.SET_POINT_TEMPERATURE 4.5:off/datapoint 1.SET_POINT_TEMPERATURE 30.5:on/
   group      3 Thermostate
   icon       hm-cc-rt-dn
   room       14_Wohnzimmer
   statedatapoint 1.SET_POINT_TEMPERATURE
   stripnumber 1
   substexcl  control
   substitute SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
   webCmd     control:Boost:Auto:Manual:Holiday:on:off
   widgetOverride control:slider,4.5,0.5,30.5,1


3. get deviceinfo:
CHN 000393C9A4F405:0 HMIP-Radiator-Thermostat-Livingroom:0
  DPT {b} HmIP-RF.000393C9A4F405:0.CONFIG_PENDING = false [RE]
  DPT {b} HmIP-RF.000393C9A4F405:0.DUTY_CYCLE = false [RE]
  DPT {b} HmIP-RF.000393C9A4F405:0.LOW_BAT = false [RE]
  DPT {f} HmIP-RF.000393C9A4F405:0.OPERATING_VOLTAGE = 2.500000 [RE]
  DPT {n} HmIP-RF.000393C9A4F405:0.RSSI_DEVICE = 199 [RE]
  DPT {n} HmIP-RF.000393C9A4F405:0.RSSI_PEER = 195 [RE]
  DPT {b} HmIP-RF.000393C9A4F405:0.UNREACH = false [RE]
  DPT {b} HmIP-RF.000393C9A4F405:0.UPDATE_PENDING = false [RE]
CHN 000393C9A4F405:1 HMIP-eTRV 000393C9A4F405:1
  DPT {i} HmIP-RF.000393C9A4F405:1.ACTIVE_PROFILE = 1 [WE]
  DPT {f} HmIP-RF.000393C9A4F405:1.ACTUAL_TEMPERATURE = 19.800000 [RE]
  DPT {b} HmIP-RF.000393C9A4F405:1.BOOST_MODE = false [WE]
  DPT {i} HmIP-RF.000393C9A4F405:1.BOOST_TIME = 0 [RE]
  DPT {f} HmIP-RF.000393C9A4F405:1.CONTROL_DIFFERENTIAL_TEMPERATURE =  [WE]
  DPT {i} HmIP-RF.000393C9A4F405:1.CONTROL_MODE =  [WE]
  DPT {i} HmIP-RF.000393C9A4F405:1.DURATION_UNIT =  [W]
  DPT {i} HmIP-RF.000393C9A4F405:1.DURATION_VALUE =  [W]
  DPT {b} HmIP-RF.000393C9A4F405:1.FROST_PROTECTION = false [RE]
  DPT {f} HmIP-RF.000393C9A4F405:1.LEVEL = 0.000000 [RWE]
  DPT {b} HmIP-RF.000393C9A4F405:1.PARTY_MODE = false [RE]
  DPT {f} HmIP-RF.000393C9A4F405:1.PARTY_SET_POINT_TEMPERATURE = 0.000000 [RE]
  DPT {s} HmIP-RF.000393C9A4F405:1.PARTY_TIME_END =  [RWE]
  DPT {s} HmIP-RF.000393C9A4F405:1.PARTY_TIME_START =  [RWE]
  DPT {i} HmIP-RF.000393C9A4F405:1.SET_POINT_MODE = 0 [RWE]
  DPT {f} HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE = 17.000000 [RWE]
  DPT {b} HmIP-RF.000393C9A4F405:1.SWITCH_POINT_OCCURED = false [RE]
  DPT {b} HmIP-RF.000393C9A4F405:1.VALVE_ADAPTION =  [WE]
  DPT {i} HmIP-RF.000393C9A4F405:1.VALVE_STATE = 4 [RE]
  DPT {i} HmIP-RF.000393C9A4F405:1.WINDOW_STATE = 0 [WE]


4. Es war wirklich nur ein Beispiel. Das Problem tritt auf wenn ich beispielsweise nach einiger Zeit die Temperatur über den Slider ändere, also per control. Aber ein explizites Beispiel sieht so aus:
set HMIP_Radiator_Thermostat_Livingroom Manual; set HMIP_Radiator_Thermostat_Livingroom control 17.0
Es reicht aber in dem Fall bereits aus, dass ich auf "Auto" stelle um den Fehler zu bekommen.
set HMIP_Radiator_Thermostat_Livingroom Auto

Nach einiger Zeit tritt der Fehler beim abschicken des Befehls auf, danach kann ich das beliebig oft wiederholen ohne Fehler. Bestes Beispiel ist der Slider vom Gerät selbst. Einige Zeit keine Änderungen durchgeführt, Fehler. Danach kann ich die Temperatur beliebig oft fehlerlos ändern, bis wieder Zeit X abgelaufen ist. Offenbar nicht immer 10 Minuten und vor allem nicht immer nach einiger Zeit ohne Updates und Befehle aber doch häufig genug.

5. Was genau meinst du? Soweit ich verstanden habe wird doch der RPC automatisch erzeugt, daran geändert habe ich nichts außer dem verbose um die wiederkehrende 600 Sekunden Meldung im Log zu entkommen. Die Schnittstellen sind im Server gesetzt, nicht noch einmal explizit im _rpc. Hier in Verwendung für HomeMatic und HomeMatic IP:
rpcinterfaces: BidCos-RF,HmIP-RF

Wenn etwas fehlt oder Fragen unbeantwortet geblieben sind, immer her damit, ich antworte dann zeitnah.

Vielen Dank für deine Hilfe!
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 23 Februar 2018, 17:51:44
Wenn die automatische Aktualisierung ausbleibt, kann die Ursache auch auf CCU Seite liegen. Du könntest mal auf der CCU in /var/log/messages nach Fehlermeldungen schauen, auch bzgl. des nicht funktionierenden Set Befehls.

Welchen RPC-Server verwendest Du bzw. was ist beim Attribut ccuflags im IO Device eingestellt?

Der beschriebene Effekt (funktioniert erst mal nicht, im Wiederholungsfall dann doch) hört sich fast wie ein Netzwerkproblem an. Würde ich aber bei WLAN vermuten, das du ja nicht verwendest.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 25 Februar 2018, 10:21:06
Ich habe in der CCU2 nur eine einzige Fehlermeldung, die dann aber zu einem Zeitpunkt der zu einem der Fehler in FHEM passt. Ansonsten bekomme ich in FHEM trotzdem besagte Fehler, ohne das in der CCU2 etwas geloggt wird.
FHEM Fehler und Zeitpunkt:
2018.02.22 16:27:02 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed
2018.02.22 16:27:02 3: set HMIP_Radiator_Thermostat_Livingroom Boost; get HMIP_Radiator_Thermostat_Livingroom update : HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed


CCU2 zum ähnlichen Zeitpunkt:
Feb 22 16:27:18 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =setValue Params = {"000393C9A4F405:1","BOOST_MODE",true} result= [faultCode:-1,faultString:"Generic error"] [iseXmlRpc.cpp:2605]
Feb 22 16:27:18 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallSetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1502]
Feb 22 16:27:18 homematic-raspi local0.err ReGaHss: Error: IseHssDP::WriteValue: CallSetValue failed; address = 000393C9A4F405:1 [iseDOMdpHSS.cpp:77]


Es ist ansonsten wie beschrieben aber so, dass der Fehler in FHEM trotzdem auftritt, dann aber offenbar ohne Eintrag in der messages der CCU2.

Den externen RPC-Server verwende ich. Eingetragen ist folgendes:
ccuflags extrpc

Wie zuvor geschrieben, es funktioniert auch beim ersten Absetzen des Befehls trotz dem Fehler. Egal ob ich den Fehler bekomme oder nicht, es funktioniert. Das Hauptproblem ist aber, dass seit dem letzten Update von HMCCU (es müsste 4.2 installiert sein) auf eine Seite weitergeleitet werde die nur noch diesen Fehler anzeigt, also von der eigentlichen Seite in FHEM (beispiel meinem Thermostat) weitergeleitet wird. Zuvor wurde lediglich ein Eintrag im Log erstellt, nun gibt es eine Fehlermeldung, die die ganze Browserseite füllt. Aber vollkommen egal ob der Fehler angezeigt wird, der Befehl wird trotzdem korrekt verarbeitet, es benötigt lediglich 1-3 Sekunden länger als ohne.

Ich habe vermutet, dass ich das gleiche Problem habe wie die anderen in diesem Thread, weshalb ich hier gepostet und keinen eigenen erstellt habe.
Das was aber auffällig ist, dass FHEM vor dem Weiterleiten immer eine merkliche Zeit benötigt hat den Befehl zu verarbeiten, was jetzt eben in der Weiterleitung endet, im Hintergrund aber weiterhin beim ersten Mal trotz dem Fehler verarbeitet wird.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 25 Februar 2018, 18:44:11
Das Verhalten ist echt seltsam. Die Fehlermeldung im Log der CCU hat vermutlich nichts damit zu tun. Die kommt von einem RPC Call (setValue). Der wird von HMCCU aber gar nicht verwendet.

Du kannst mal den neuen RPC Server verwenden. Dazu ccuflags auf procrpc setzen (extrpc entfernen). Dann FHEM mal neu starten.

Ich befürchte aber, dass das Dein Problem nicht lösen wird.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 26 Februar 2018, 09:38:49
Das dachte ich mir, ist wie geschrieben auch der einzige Eintrag der Überhaupt im CCU2 Log zu finden ist und eine Fehlermeldung beinhaltet.

Den neuen RPC aktiviere ich im Anschluss an diesen Post und melde mich dann in den kommenden Tagen wieder mit einem Update (auch, wenn es sich zum positiven verändert hat).

Hast du denn eine Idee woher das Problem kommen kann oder was ich zusätzlich noch testen könnte um es zu beheben? Ich habe aktuell nur 1 HomeMatic und 3 HomeMatic IP Tür-/ Fensterkontakte im Einsatz und ein HomeMatic IP Heizkörperthermostat, also vermutlich zusätzlich sehr wenige Geräte. Komme von Qivicon, bin etwas gebrandmarkt von denen was Smart Home angeht...
Leider sorgt das Verhalten doch immer mehr für Probleme, sowohl wenn Automatismen im Hintergrund laufen (sollen) als auch wenn halt Bedienung direkt in der Oberfläche stattfinden. Ich verstehe aktuell auch nicht warum ich plötzlich weitergeleitet werde wenn der Fehler auftritt und nicht wie zuvor nur ein Eintrag im Log erstellt wird und das Ändern der Temperatur beispielsweise einfach eine Sekunde länger dauert wie zuvor...

Edit: procrpc läuft nun, funktioniert auf den ersten Blick. Ich melde mich in den kommenden Tagen mit einem Update! Vielen Dank für die Unterstützung!

Edit 2: Hm, der Fehler ist in der Tat nicht behoben und entgegen meiner bisherigen Beobachtung aktuell auch nicht auf einen Zeitraum eingeschränkt. Ich habe eben die Temperatur nach einem vollständigen Neustart drei Mal hintereinander geändert, wo die ersten beiden Änderungen sauber durchgegangen sind, hat die dritte Änderung erneut einen Fehler ausgelöst...
2018.02.26 09:54:36 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed

Edit 3: Nun gibt es offenbar häufig Fehler beim Ändern von Parametern...
2018.02.26 09:57:49 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 26 Februar 2018, 11:57:50
setze mal für das Device ccuflags auf trace, führe den set Befehl aus und schicke oder poste die Ausgabe im Logfile.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 26 Februar 2018, 12:33:27
Ich habe das Device Flag gesetzt und einfach ein paar mal die Temperatur per Slider geändert, ich habe jedes Mal gewartet bis die Temperatur am Thermostat angekommen ist ehe ich erneut den Slider verschoben habe. Beim letzten Verschieben im Log ist der Fehler aufgetreten, kein einziges Mal davor. Ich habe ihn in ein separates Code kopiert, steht aber so auch im langen Log.

2018.02.26 12:29:05 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed

Edit: Problem mit dem Post, offenbar der maximalen Länge...

Edit 2:
Log mit dem Fehler, das Ändern über den Slider war zuvor mehrfach ohne Fehler möglich.

2018.02.26 12:28:59 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:28:59 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 12:28:59 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:28:59 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 12:29:01 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:29:01 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=SET_POINT_TEMPERATURE
2018.02.26 12:29:01 2: HMCCUDEV: SetDatapoint: param=HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE, value=18.5
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Addr=000393C9A4F405:1 Name=HMIP-eTRV 000393C9A4F405:1
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Script response =
undef
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Script =
http://10.0.10.11:8181/do.exe?r1=dom.GetObject("HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE").State(18.5)
2018.02.26 12:29:05 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 12:29:05 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=UNREACH, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=UNREACH, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_DEVICE, value=-54
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_DEVICE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=OPERATING_VOLTAGE, value=2.5
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=OPERATING_VOLTAGE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=DUTY_CYCLE, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=DUTY_CYCLE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_PEER, value=-55
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_PEER, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=LOW_BAT, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=LOW_BAT, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=0.LOW_BAT, orgvalue=0 value=ok peer=null
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_MODE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.ACTIVE_PROFILE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.LEVEL match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.BOOST_TIME match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_END match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.BOOST_MODE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 12:29:05 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=FROST_PROTECTION, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=FROST_PROTECTION, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=PARTY_MODE, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=PARTY_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_TEMPERATURE, value=18.5
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_TEMPERATURE, orgvalue=18.5 value=18.5 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_TIME, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_TIME, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_TIME, orgvalue=0 value=0 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=VALVE_STATE, value=4
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=VALVE_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_MODE, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_MODE, orgvalue=0 value=0 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=WINDOW_STATE, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=WINDOW_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.WINDOW_STATE, orgvalue=0 value=closed peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_MODE, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_MODE, orgvalue=0 value=0 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=LEVEL, value=0.0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=LEVEL, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=valve_position, orgvalue=0.0 value=0 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTUAL_TEMPERATURE, value=23.2
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTUAL_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.ACTUAL_TEMPERATURE, orgvalue=23.2 value=23.2 peer=null
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTIVE_PROFILE, value=1
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTIVE_PROFILE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SWITCH_POINT_OCCURED, value=0
2018.02.26 12:29:05 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SWITCH_POINT_OCCURED, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 12:29:05 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 12:29:05 2: HMCCUDEV:     check result false
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_MODE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.ACTIVE_PROFILE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.LEVEL match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.BOOST_TIME match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_END match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.BOOST_MODE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 1.PARTY_SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 12:29:05 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL


Edit 3:
Ich hoffe es reicht dieser eine Eintrag, ansonsten kann ich gerne einen weiteren ohne Fehler posten.
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 26 Februar 2018, 15:48:23
Wenn dir das hilft, ist das sehr gut! Mir ist allerdings rätselhaft wieso der Fehler nur beliebig häufig auftritt und nicht reproduzierbar bei jedem Ändern.

Ich möchte ebenfalls noch einmal erwähnen dass es vollkommen egal ist welcher Befehl vom Gerät verarbeitet wird. Ich habe eben lediglich boosten wollen und erneut den Fehler bekommen. Ich habe den Boost aus dem Gerät selbst verwendet:
eventMap   /datapoint 1.BOOST_MODE true:Boost/datapoint 1.CONTROL_MODE 0:Auto/datapoint 1.CONTROL_MODE 1:Manual/datapoint 1.CONTROL_MODE 2:Holiday/datapoint 1.SET_POINT_TEMPERATURE 4.5:off/datapoint 1.SET_POINT_TEMPERATURE 30.5:on/

Das Gerät ist ein Heizkörperthermostat in der ersten Revision von HomeMatic IP. Wie geschrieben habe ich das mit AutoCreate erzeugt.

Internals:
   DEF        000393C9A4F405
   IODev      raspiCCU2
   NAME       HMIP_Radiator_Thermostat_Livingroom
   NR         31
   STATE      23.5
   TYPE       HMCCUDEV
   ccuaddr    000393C9A4F405
   ccudevstate active
   ccuif      HmIP-RF
   ccuname    HMIP-Radiator-Thermostat-Livingroom
   ccutype    HMIP-eTRV
   channels   8
   firmware   1.6.3
   statevals  devstate
   READINGS:
     2018-02-26 15:40:19   0.LOW_BAT       ok
     2018-02-26 15:40:19   1.ACTUAL_TEMPERATURE 20.1
     2018-02-26 15:40:19   1.BOOST_MODE    1
     2018-02-26 15:40:19   1.BOOST_TIME    515
     2018-02-26 15:40:19   1.SET_POINT_MODE 0
     2018-02-26 15:40:19   1.SET_POINT_TEMPERATURE 23.5
     2018-02-26 15:40:19   1.WINDOW_STATE  closed
     2018-02-26 15:40:19   control         23.5
     2018-02-26 15:40:19   hmstate         23.5
     2018-02-26 15:40:19   state           23.5
     2018-02-26 15:40:19   valve_position  80
   hmccu:
     dp:
       0.CONFIG_PENDING:
         OVAL       false
         VAL        false
       0.DUTY_CYCLE:
         OVAL       0
         VAL        0
       0.LOW_BAT:
         OSVAL      ok
         OVAL       0
         SVAL       ok
         VAL        0
       0.OPERATING_VOLTAGE:
         OVAL       2.5
         VAL        2.5
       0.RSSI_DEVICE:
         OVAL       -53
         VAL        -55
       0.RSSI_PEER:
         OVAL       -55
         VAL        -54
       0.UNREACH:
         OVAL       0
         VAL        0
       0.UPDATE_PENDING:
         OVAL       false
         VAL        false
       1.ACTIVE_PROFILE:
         OVAL       1
         VAL        1
       1.ACTUAL_TEMPERATURE:
         OSVAL      20.1
         OVAL       20.1
         SVAL       20.1
         VAL        20.1
       1.BOOST_MODE:
         OSVAL      1
         OVAL       1
         SVAL       1
         VAL        1
       1.BOOST_TIME:
         OSVAL      600
         OVAL       600
         SVAL       515
         VAL        515
       1.FROST_PROTECTION:
         OVAL       0
         VAL        0
       1.LEVEL:
         OSVAL      80
         OVAL       0.8
         SVAL       80
         VAL        0.8
       1.PARTY_MODE:
         OVAL       0
         VAL        0
       1.PARTY_SET_POINT_TEMPERATURE:
         OVAL       0.000000
         VAL        0.000000
       1.PARTY_TIME_END:
         OVAL       
         VAL       
       1.PARTY_TIME_START:
         OVAL       
         VAL       
       1.SET_POINT_MODE:
         OSVAL      0
         OVAL       0
         SVAL       0
         VAL        0
       1.SET_POINT_TEMPERATURE:
         OSVAL      23.5
         OVAL       23.5
         SVAL       23.5
         VAL        23.5
       1.SWITCH_POINT_OCCURED:
         OVAL       0
         VAL        0
       1.VALVE_STATE:
         OVAL       4
         VAL        4
       1.WINDOW_STATE:
         OSVAL      closed
         OVAL       0
         SVAL       closed
         VAL        0
Attributes:
   IODev      raspiCCU2
   alias      Heizkörperthermostat
   ccureadingfilter ^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
   ccureadingname 1.LEVEL:valve_position
   ccuscaleval LEVEL:0:1:0:100
   controldatapoint 1.SET_POINT_TEMPERATURE
   eventMap   /datapoint 1.BOOST_MODE true:Boost/datapoint 1.CONTROL_MODE 0:Auto/datapoint 1.CONTROL_MODE 1:Manual/datapoint 1.CONTROL_MODE 2:Holiday/datapoint 1.SET_POINT_TEMPERATURE 4.5:off/datapoint 1.SET_POINT_TEMPERATURE 30.5:on/
   group      3 Thermostate
   icon       hm-cc-rt-dn
   room       14_Wohnzimmer
   statedatapoint 1.SET_POINT_TEMPERATURE
   stripnumber 1
   substexcl  control
   substitute SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
   webCmd     control:Boost:Auto:Manual:Holiday:on:off
   widgetOverride control:slider,4.5,0.5,30.5,1
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 26 Februar 2018, 15:49:34
Ist mir ein Rätsel, warum das set datapoint fehlschlägt. Syntaktisch ist alles korrekt beim Script, das an die CCU geschickt wird.

Ich habe leider kein HmIP Thermostat und kann das nicht nachstellen.

Vielleicht gibt es jemanden, bei dem das funktioniert oder sich auch so verhält ???
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 26 Februar 2018, 16:02:07
Ah nu ist dein Post verschwunden...

Das ist nicht gut. Es gibt also aktuell keine Möglichkeit irgendetwas dagegen zu unternehmen? Das Problem ist, dass ich dadurch in einem notify weiterführende Probleme bekomme, weshalb ich jetzt auch aktiv geworden bin. Zuvor habe ich es als Unschönheit im Log abgetan da der Befehl ja trotzdem verarbeitet wird, nun allerdings laufe ich weiterführend durch den Fehler selbst auf Fehler weil irgendwie nichts mehr geschieht.
Intern scheint es irgendwo zu haken weshalb ich mit einem "sleep" als Workaround nicht gegen die Verzögerung des Fehlers ankomme.

Aktuell booste ich nach dem Lüften per FHEM, möchte daraufhin dann auslesen wie lange ich booste (über 1.BOOST_TIME), was funktioniert solange der Fehler nicht auftritt um dann damit weiter zu arbeiten. Interessanterweise sorgt der Fehler aber dafür, dass ich keine Rückgabe mehr erhalte, egal was ich tue. Selbst ein sleep über 10 Sekunden im Ablauf hilft mir nicht mehr. Irgendwie blockiert der Fehler scheinbar sämtliche Kommunikation von / zu FHEM zur CCU2. Sehr ungünstig...

Edit:
Ich nehme dann zusätzlich an, dass es kein Problem ist wie ich gedacht habe bezüglich dem Abbruch der Verbindung FHEM <-> CCU2, oder? Normalerweise schalte ich ja nicht wild umher, daher hat es immer so gewirkt als würde es nur auftreten wenn ich nach einiger Zeit einen neuen Befehl absetze...

Edit 2:
Es sieht so aus als hätte Rewe2000 im Nachbarthread das gleiche Problem...
Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: zap am 26 Februar 2018, 17:17:05
Die Timestamps geben mir zu denken:

2018.02.26 12:29:01 2: HMCCUDEV: SetDatapoint: param=HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE, value=18.5
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Addr=000393C9A4F405:1 Name=HMIP-eTRV 000393C9A4F405:1
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Script response =
undef
2018.02.26 12:29:05 2: HMCCUDEV: SetDatapoint: Script =
http://10.0.10.11:8181/do.exe?r1=dom.GetObject("HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE").State(18.5)
2018.02.26 12:29:05 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed


Zwischen dem Absetzen des Befehls und der Antwort bzw. dem Fehler liegen 4 Sekunden. Das ist lange. Scheint mir eher ein Timeout zu sein.

Ist es immer so, dass auch bei einem Fehler der Befehl verzögert trotzdem ausgeführt wird? Das würde auf einen Timeout hindeuten. Der Befehl wird per HTTP-Post an die CCU geschickt. Normalerweise ist der Default Timeout 3 Minuten (und nicht 4 Sekunden). Jedenfalls kehrt der Post-Request ergebnislos zurück, was zu der Fehlermeldung führt. Die CCU verarbeitet den Befehl aber trotzdem, wenn auch verzögert.

Ich bin mir ziemlich sicher, dass es ein Timeout ist. set datapoint benutzt doch kein HTTP Post sondern nutzt GetFileFromURL() von FHEM. Und der Timeout dieser Funktion sind 4 Sekunden.

Du könntest mal die CCU neu starten. Vielleicht hat sie Performance Probleme. Danach muss Du auch FHEM bzw. den RPC-Server neu starten.


Titel: Antw:Aktueller Status nur nach get Update
Beitrag von: Xervek am 26 Februar 2018, 17:54:07
Ich kann dir leider nicht sagen, was das verursacht. Ich habe die CCU2 (RaspMatic) jetzt einmal neu gestartet, danach den Pi auf dem FHEM läuft, beides also einmal frisch. Der Fehler tritt jedoch auch jetzt direkt nach dem Neustart beider Pi's weiterhin unverändert sporadisch auf. Direkt im Anschluss wieder einfach kurz den Slider verschoben und zwischen 22.0° und 23.0° herum geschaltet. Nach 4x Schalten ist der Fehler aufgetreten, dafür jetzt bereits seit 20+ Schaltungen danach nicht mehr, also vollkommen unberechenbar.

Bisher war es immer so, dass der Befehl im Anschluss trotzdem verarbeitet wurde, es ist nicht einmal vorgekommen, dass der Befehl ein weiteres Mal ausgeführt werden musste weil er irgendwo verschluckt wurde. Es dauert stellenweise halt wenige Sekunden, dann gibt es definitiv diesen Fehler im Log und der Befehl ist trotzdem ausgeführt. Auch FHEM aktualisiert sauber trotz dem Fehler die aktuellen Werte im Anschluss. Es ist halt mit einem der letzten Updates von HMCCU schlimmer geworden weil der Fehler nicht mehr nur im Log steht sondern halt weitergeleitet wird auf eine Seite mit diesem Fehler, zusammen mit dem Problem des notify das keine Werte mehr bekommt weil alles hängt...

Edit:
Hier, auch weiterhin nach einem Neustart. Vollkommen sporadisch, vollkommen ohne Zusammenhang zu irgendetwas...

2018.02.26 17:57:23 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:23 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:57:23 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:23 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 17:57:24 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:24 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=SET_POINT_TEMPERATURE
2018.02.26 17:57:24 2: HMCCUDEV: SetDatapoint: param=HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE, value=20.5
2018.02.26 17:57:28 2: HMCCUDEV: SetDatapoint: Addr=000393C9A4F405:1 Name=HMIP-eTRV 000393C9A4F405:1
2018.02.26 17:57:28 2: HMCCUDEV: SetDatapoint: Script response =
undef
2018.02.26 17:57:28 2: HMCCUDEV: SetDatapoint: Script =
http://10.0.10.11:8181/do.exe?r1=dom.GetObject("HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE").State(20.5)
2018.02.26 17:57:28 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:57:28 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=OPERATING_VOLTAGE, value=2.5
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=OPERATING_VOLTAGE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=DUTY_CYCLE, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=DUTY_CYCLE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_PEER, value=-58
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_PEER, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_DEVICE, value=-54
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_DEVICE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=UNREACH, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=UNREACH, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=LOW_BAT, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=LOW_BAT, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=0.LOW_BAT, orgvalue=0 value=ok peer=null
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.WINDOW_STATE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:57:28 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTUAL_TEMPERATURE, value=26.7
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTUAL_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.ACTUAL_TEMPERATURE, orgvalue=26.7 value=26.7 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=VALVE_STATE, value=4
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=VALVE_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=PARTY_MODE, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=PARTY_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=WINDOW_STATE, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=WINDOW_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.WINDOW_STATE, orgvalue=0 value=closed peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_TEMPERATURE, value=20.5
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_TEMPERATURE, orgvalue=20.5 value=20.5 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=LEVEL, value=0.0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=LEVEL, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=valve_position, orgvalue=0.0 value=0 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_MODE, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_MODE, orgvalue=0 value=0 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_TIME, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_TIME, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_TIME, orgvalue=0 value=0 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_MODE, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_MODE, orgvalue=0 value=0 peer=null
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SWITCH_POINT_OCCURED, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SWITCH_POINT_OCCURED, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTIVE_PROFILE, value=1
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTIVE_PROFILE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=FROST_PROTECTION, value=0
2018.02.26 17:57:28 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=FROST_PROTECTION, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:57:28 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:57:28 2: HMCCUDEV:     check result false
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.WINDOW_STATE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:57:28 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL


Edit 2:
Noch einer, dazwischen lagen wieder 6 Änderungen der Temperatur ohne Fehler...

2018.02.26 17:59:50 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:50 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:59:50 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:50 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 17:59:53 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:53 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=SET_POINT_TEMPERATURE
2018.02.26 17:59:53 2: HMCCUDEV: SetDatapoint: param=HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE, value=22.0
2018.02.26 17:59:57 2: HMCCUDEV: SetDatapoint: Addr=000393C9A4F405:1 Name=HMIP-eTRV 000393C9A4F405:1
2018.02.26 17:59:57 2: HMCCUDEV: SetDatapoint: Script response =
undef
2018.02.26 17:59:57 2: HMCCUDEV: SetDatapoint: Script =
http://10.0.10.11:8181/do.exe?r1=dom.GetObject("HmIP-RF.000393C9A4F405:1.SET_POINT_TEMPERATURE").State(22.0)
2018.02.26 17:59:57 1: HMCCUDEV: HMIP_Radiator_Thermostat_Livingroom Execution of CCU script or command failed
2018.02.26 17:59:57 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 17:59:57 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:59:57 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 17:59:57 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:59:57 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 17:59:57 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=LOW_BAT, value=0
2018.02.26 17:59:57 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=LOW_BAT, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:57 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=0.LOW_BAT, orgvalue=0 value=ok peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_PEER, value=-58
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_PEER, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=RSSI_DEVICE, value=-54
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=RSSI_DEVICE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=UNREACH, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=UNREACH, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=OPERATING_VOLTAGE, value=2.5
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=OPERATING_VOLTAGE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:0, dpt=DUTY_CYCLE, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:0, chnnam=HMIP-Radiator-Thermostat-Livingroom:0 chnnum=0 dpt=DUTY_CYCLE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.WINDOW_STATE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Virlist =
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Grplist = HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: HMIP_Radiator_Thermostat_Livingroom Objects = 000393C9A4F405
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: Processing device HMIP_Radiator_Thermostat_Livingroom
2018.02.26 17:59:58 2: HMCCUDEV: GetAttrSubstitute: subst = SET_POINT_TEMPERATURE!#0-4.5:off,#30.5-40:on;WINDOW_STATE!(0|false):closed,(1|true):open;;LOW_BAT!(0|false):ok,(1|true):low
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTUAL_TEMPERATURE, value=26.9
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTUAL_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.ACTUAL_TEMPERATURE, orgvalue=26.9 value=26.9 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=VALVE_STATE, value=4
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=VALVE_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=PARTY_MODE, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=PARTY_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_TEMPERATURE, value=22.0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_TEMPERATURE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_TEMPERATURE, orgvalue=22.0 value=22.0 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=WINDOW_STATE, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=WINDOW_STATE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.WINDOW_STATE, orgvalue=0 value=closed peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=LEVEL, value=0.0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=LEVEL, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=valve_position, orgvalue=0.0 value=0 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_MODE, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_MODE, orgvalue=0 value=0 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=BOOST_TIME, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=BOOST_TIME, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.BOOST_TIME, orgvalue=0 value=0 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SET_POINT_MODE, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SET_POINT_MODE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: device=HMIP_Radiator_Thermostat_Livingroom, readings=1.SET_POINT_MODE, orgvalue=0 value=0 peer=null
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=SWITCH_POINT_OCCURED, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=SWITCH_POINT_OCCURED, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=ACTIVE_PROFILE, value=1
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=ACTIVE_PROFILE, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: UpdateSingleDevice: dev=HMIP_Radiator_Thermostat_Livingroom, chnadd=000393C9A4F405:1, dpt=FROST_PROTECTION, value=0
2018.02.26 17:59:58 2: HMCCUDEV: FilterReading: chn=000393C9A4F405:1, chnnam=HMIP-eTRV 000393C9A4F405:1 chnnum=1 dpt=FROST_PROTECTION, rules=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME
2018.02.26 17:59:58 2: HMCCUDEV:     check rm=1 f=^ACTUAL_TEMPERATURE|^BOOST_MODE|^SET_POINT_MODE|^SET_POINT_TEMPERATURE|^LEVEL|^WINDOW_STATE|^LOW_BAT|^BOOST_TIME cn= c=
2018.02.26 17:59:58 2: HMCCUDEV:     check result false
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: hmstatevals=^0\.UNREACH!(1|true):unreachable;^[0-9]\.LOW_?BAT!(1|true):warn_battery
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: dptexpr=^0\.UNREACH, subst=(1|true):unreachable
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^0\.UNREACH
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: dptexpr=^[0-9]\.LOW_?BAT, subst=(1|true):warn_battery
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.FROST_PROTECTION match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.DUTY_CYCLE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_PEER match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.RSSI_DEVICE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UNREACH match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.WINDOW_STATE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.SET_POINT_TEMPERATURE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.OPERATING_VOLTAGE match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.CONFIG_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 1.PARTY_TIME_START match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.UPDATE_PENDING match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: GetHMState: Check 0.LOW_BAT match ^[0-9]\.LOW_?BAT
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=ON_TIME
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: 1 is not a valid channel address
2018.02.26 17:59:58 2: HMCCUDEV: IsValidDatapoint: devtype=HMIP-eTRV, chnno=1, dpt=LEVEL