RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Einrichtung, Nutzung und Hilfe zu RaspberryMatic (OCCU auf Raspberry Pi)

Moderatoren: jmaus, Co-Administratoren

ibein
Beiträge: 73
Registriert: 21.01.2015, 14:06

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von ibein » 25.01.2019, 17:39

Hallo,

ich habe aktuell riesige Probleme, mein Anlage wieder zum Laufen zu bringen.

Ich habe auf die aktuelle Version gewechselt, dies lief auch bis vor drei tagen absolut problemlos. Backups habe ich auch nur noch von der aktuellen FW-Version.

Bespiele ich eine neue SD-Karte mit einem frisch heruntergeladenen FW-Upgrade, startet die Raspberrymatic und ich komme auch auf die WebUI.

Spiele ich dann eines der Backups ein, startet die Anlage, fährt hoch und ist auch per SSH (Konsole als auch Cyberduck) erreichbar. Allerdings komme ich nicht mehr auf die WebUI und pocketControl zeigt auch keine Verbindung an. Allerdings bekomme ich Servicemeldungen auf pocketControl, die auf Kommunikationsstörungen mit einer Komponente zielen (sehr schlecht erreichbar)... leider bin ich ansonsten relativ hilflos, um den Fehler zu finden. Ich habe auch schon eine neue SD-Karte genommen... wäre froh, hier von euch Support zu bekommen.

Merkwürdig war es zuletzt, dass ich zwischendurch auf die Anlage kam; habe ich dann am Netzwerkkabel gezogen, war plötzlich die komplette Kommunikation nicht mehr möglich. Das Kabel habe ich inzwischen schon getauscht. In der Fritz-Box wird die Anlage mit der korrekten IP-Adresse als aktiv angezeigt...

Die Logik scheint auch zu laufen, Bewegungsmelder schalten das Licht ein/aus; dies ist in einem Programm realisiert. Die LEDs blinken auch grün...

Welche Infos würdet ihr von mir brauchen?

Xel66
Beiträge: 14085
Registriert: 08.05.2013, 23:33
System: Alternative CCU (auf Basis OCCU)
Wohnort: Nordwürttemberg
Hat sich bedankt: 580 Mal
Danksagung erhalten: 1492 Mal

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von Xel66 » 25.01.2019, 18:04

ibein hat geschrieben:
25.01.2019, 17:39
Welche Infos würdet ihr von mir brauchen?
Erst mal exakte Fehlermeldungen. So was wie ...
ibein hat geschrieben:
25.01.2019, 17:39
Allerdings bekomme ich Servicemeldungen auf pocketControl, die auf Kommunikationsstörungen mit einer Komponente zielen (sehr schlecht erreichbar)...
... sind auch sehr ein Fall für die Glaskugel. Und wenn Du ein Problem mit Raspberrymatic hast, dann suche den Fehler auch dort und hole nicht noch ein anderes Fremdprodukt mit ins Boot. Fehlermeldungen stehen in der WebUI. Smartphone-Apps sind zu Bedienung gut, aber zu Fehlersuche Schrott.

Gruß Xel66
-------------------------------------------------------------------------------------------
524 Kanäle in 146 Geräten und 267 CUxD-Kanäle in 34 CUxD-Geräten:
343 Programme, 334 Systemvariablen und 183 Direktverknüpfungen,
RaspberryMatic Version: 3.65.11.20221005 + Testsystem: CCU2 2.61.7
-------------------------------------------------------------------------------------------
Einsteigerthread, Programmlogik-Thread, WebUI-Handbuch

ibein
Beiträge: 73
Registriert: 21.01.2015, 14:06

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von ibein » 25.01.2019, 18:23

Auf die WebUI komme ich ja nicht mehr... sicher hilfreich wären Logs direkt aus dem Verzeichnis; aber wo anfangen?

LibertyX
Beiträge: 767
Registriert: 10.11.2012, 19:47
System: Alternative CCU (auf Basis OCCU)
Wohnort: RP
Hat sich bedankt: 1 Mal
Danksagung erhalten: 19 Mal

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von LibertyX » 25.01.2019, 18:29

Das Log liegt unter /var/log/messages
RaspberryMatic (3.71.12.20231020) @RPI3 | 218 Kanäle in 53 Geräten und 72 CUxD-Kanäle in 8 CUxD-Geräten (2.11) | iobroker.pro - CCU-Historian (3.4.0)

ibein
Beiträge: 73
Registriert: 21.01.2015, 14:06

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von ibein » 25.01.2019, 18:33

Code: Alles auswählen

Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 2 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 2 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 3, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 4, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 0.000000 valR1 = 1.000000 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 3, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 1 valR1 = 0 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, but dp is not the trigger, condition = 1 [iseCondition.cpp:543]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 2, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_ONLY is set, condition = 1 [iseCondition.cpp:484]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 3 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 1, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, trigger dp exists  [iseCondition.cpp:524]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseCondition.cpp:1112]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, CONDITION_TRIGGER_EXECUTE is reset. [iseRule.cpp:227]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 1, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Rule evaluated state is FALSE by Program ID = 1467 'An-und-Abwesenheiten-Steuerung v2' [iseDOMPrg.cpp:527]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 14929 'Status Eingangst¸r' with valNew = '0' ; oidTrigger = 3795 [iseDOMPrg.cpp:478]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_CHANGE is set, trigger dp exists  [iseCondition.cpp:524]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = 1, condition valL = 0 valR1 = 1 [iseCondition.cpp:388]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1074]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseCondition.cpp:1112]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_EXECUTE is reset. [iseRule.cpp:227]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 14929 'Status Eingangst¸r'; Destination ID = 44589 [iseDOMPrg.cpp:501]
Jan 25 18:31:18 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: break execute for Program ID = 14929 'Status Eingangst¸r', rule's trigger flags = 0 [iseDOMPrg.cpp:521]
Jan 25 18:31:18 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:18 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:19 ccu2 user.debug multimac: C> @142397: #72 LLMAC Response ACK @11427: 2C A3
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript START]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:19 ccu2 user.debug script: [ALCHY ALLINScript START]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' ; oidTrigger = 2487 [iseDOMPrg.cpp:478]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_VALUE_IN_RANGE_FROM_TO, condition valL = ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M  valR1 =  valR2 =  [iseCondition.cpp:355]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:501]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 49207 'Push Script for pocket control', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:611]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 4214; time= 0 [iseRTScheduler.cpp:343]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M Luca_H_LEQ0781933 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M SZ_LEQ0785414 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' [iseDOMPrg.cpp:625]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript ENDE]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 59657; ticks = 21 [iseRTScheduler.cpp:601]
Jan 25 18:31:19 ccu2 user.debug script: [ALCHY ALLINScript ENDE]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IsePersist::ExecProcess = 'wget -q -O /dev/null '--post-data=ccuid=P_2487C748-EDF5-475C-B10E-5C570ECA9B96&push=ALTE%20Servicemeldung^M ^M Luca_H_LEQ0781933%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M SZ_LEQ0785414%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M DB_H_LEQ0784289%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M HM-LC-Sw4-Ba-PCB%20NEQ0027554%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:30%20(25.01.19%2018:31)^M ^M Flur_unten_BWM_HmIP-SMI55%200014D8A98A143A%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M %20' http://push.pocket-control.com:9325 &' returned 0 [iseDOMpersist.cpp:380]
Jan 25 18:31:19 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 4214; ticks = 10 [iseRTScheduler.cpp:601]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 3000 [iseRTScheduler.cpp:481]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 3000 [iseRTScheduler.cpp:481]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:19 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:21 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:21 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:21 ccu2 auth.info sshd[2458]: Accepted password for root from 192.168.178.22 port 54503 ssh2
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:21 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:22 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: try to call set state - DP id = 2052 value = 0 [iseRTScheduler.cpp:629]
Jan 25 18:31:22 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= BidCos-RF for ID=1007 [iseXmlRpc.cpp:2549]
Jan 25 18:31:22 ccu2 user.debug rfd: TX:  @2249255610 0x31AF12 -> 0x2F0145 Generic [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=1,BURST=1,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x11   DATA = 80 
Jan 25 18:31:22 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:22 ccu2 user.debug multimac: C> @145943: #40 LLMAC RX @14993ms -69dBm 01 B0 11 31 AF 12 2F 01 45 80
Jan 25 18:31:22 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:22 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:22 ccu2 user.debug multimac: A<: #82 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:22 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:22 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:23 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:23 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:23 ccu2 user.info rfd: LanConnection::receive(): sock 16: Remote host closed connection.
Jan 25 18:31:23 ccu2 user.debug multimac: C> @147095: #41 LLMAC RX @16145ms -69dBm 01 B0 11 31 AF 12 2F 01 45 80
Jan 25 18:31:23 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:23 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:23 ccu2 user.debug multimac: A<: #84 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->2F0145 CentralCommand: 80
Jan 25 18:31:23 ccu2 user.debug rfd: (NEQ0708485) Response status: Telegram sent, received ACK.
Jan 25 18:31:23 ccu2 user.debug rfd: (MEQ0835478) Telegram Response status: OK.
Jan 25 18:31:23 ccu2 user.debug rfd: Response accepted:  @2249257281 RSSI=-65dB 0x2F0145 -> 0x31AF12 ACK_STATUS [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02   CHANNEL = 4   STATUS = 39   STATE = 0   CLOCK = 0   LOWBAT = 0   DUTY_CYCLE = 0   RSSI = 69
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.CONTROL_MODE=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.FAULT_REPORTING=0
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.BOOST_STATE=0
Jan 25 18:31:23 ccu2 user.debug multimac: C> @147229: #42 LLMAC RX @16278ms -79dBm 01 80 02 2F 01 45 31 AF 12 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug multimac: Bidcos RX: #01[Ren] 2F0145->31AF12 Ack: 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug multimac: A<: #86 HmBidcos RxTelegram AuthNone #01[Ren] 2F0145->31AF12 Ack: 01 04 27 00 45 00
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_TIME=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_DAY=1
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 5 events
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_MONTH=1
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_START_YEAR=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_TIME=0
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_DAY=1
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_MONTH=1
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 10 events
Jan 25 18:31:23 ccu2 user.debug rfd: Event: LEQ0786107:4.PARTY_STOP_YEAR=0
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"LEQ0786107:4","AUTO_MODE",false} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: set state - DP id = 2052 [iseRTScheduler.cpp:634]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteWriteJob: oid = 2052; ticks = 1677 [iseRTScheduler.cpp:591]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 4000 [iseRTScheduler.cpp:481]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: RX for LEQ0786107: @2249257281 RSSI=-65dB 0x2F0145 -> 0x31AF12 ACK_STATUS [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02   CHANNEL = 4   STATUS = 39   STATE = 0   CLOCK = 0   LOWBAT = 0   DUTY_CYCLE = 0   RSSI = 69
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:23 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0786107:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 2050 [iseDOMchn.h:288]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 2017 [iseDOMdev.h:225]
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:23 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:23 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:24 ccu2 user.debug multimac: C<: #73 TRX GetDutyCycle
Jan 25 18:31:24 ccu2 user.debug multimac: C< @148177: bin:FD 00 03 01 49 03 2E 1B
Jan 25 18:31:24 ccu2 user.debug multimac: C> @148281: #73 TRX Response Ack 08
Jan 25 18:31:24 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:25 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:25 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:25 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:25 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:27 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: try to call set state - DP id = 1351 value = 0 [iseRTScheduler.cpp:629]
Jan 25 18:31:27 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= BidCos-RF for ID=1007 [iseXmlRpc.cpp:2549]
Jan 25 18:31:27 ccu2 user.debug rfd: TX:  @2249261288 0x31AF12 -> 0x3105F2 Generic [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=1,BURST=1,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x11   DATA = 80 
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.debug multimac: C> @151621: #43 LLMAC RX @20671ms -66dBm 01 B0 11 31 AF 12 31 05 F2 80
Jan 25 18:31:28 ccu2 user.debug multimac: Bidcos RX: #01[BiDi|WOR|Ren] 31AF12->3105F2 CentralCommand: 80
Jan 25 18:31:28 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:28 ccu2 user.debug multimac: A<: #89 HmBidcos RxTelegram AuthNone #01[BiDi|WOR|Ren] 31AF12->3105F2 CentralCommand: 80
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.debug rfd: (NEQ0708485) Response status: Telegram sent, received ACK.
Jan 25 18:31:28 ccu2 user.debug rfd: Response accepted:  @2249261806 RSSI=-38dB 0x3105F2 -> 0x31AF12 ACK_STATUS [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02   CHANNEL = 4   STATUS = 40   STATE = 0   CLOCK = 0   LOWBAT = 0   DUTY_CYCLE = 0   RSSI = 37
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.CONTROL_MODE=0
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.FAULT_REPORTING=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.BOOST_STATE=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.SET_TEMPERATURE=20.000000
Jan 25 18:31:28 ccu2 user.debug multimac: C> @151754: #44 LLMAC RX @20803ms -67dBm 01 80 02 31 05 F2 31 AF 12 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 user.debug multimac: Bidcos RX: #01[Ren] 3105F2->31AF12 Ack: 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:28 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_TIME=0
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_DAY=1
Jan 25 18:31:28 ccu2 user.debug multimac: A<: #91 HmBidcos RxTelegram AuthNone #01[Ren] 3105F2->31AF12 Ack: 01 04 28 00 25 00
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_MONTH=1
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_START_YEAR=0
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_TIME=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 4 events
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_DAY=1
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_MONTH=1
Jan 25 18:31:28 ccu2 user.debug rfd: Event: LEQ1085122:4.PARTY_STOP_YEAR=0
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 5 events
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 12 events
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"LEQ1085122:4","AUTO_MODE",false} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: SchedulerRT::ExecuteWriteJob: set state - DP id = 1351 [iseRTScheduler.cpp:634]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteWriteJob: oid = 1351; ticks = 526 [iseRTScheduler.cpp:591]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 user.debug rfd: RX for LEQ1085122: @2249261806 RSSI=-38dB 0x3105F2 -> 0x31AF12 ACK_STATUS [NEQ0708485]:   CNT=1,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=0,BCAST=0,TYPE=0x02   CHANNEL = 4   STATUS = 40   STATE = 0   CLOCK = 0   LOWBAT = 0   DUTY_CYCLE = 0   RSSI = 37
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."SET_TEMPERATURE"=20.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 20.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 57266; ticks = 102 [iseRTScheduler.cpp:601]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 569000 [iseRTScheduler.cpp:481]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ1085122:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1349 [iseDOMchn.h:288]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1316 [iseDOMdev.h:225]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:28 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:28 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:28 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:28 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:28 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:28 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:29 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:29 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:29 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:30 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:30 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:30 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:30 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:30 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:30 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:32 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:32 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:32 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:32 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:32 ccu2 auth.info sshd[2968]: Accepted password for root from 192.168.178.22 port 54504 ssh2
Jan 25 18:31:34 ccu2 user.debug multimac: C<: #74 TRX GetDutyCycle
Jan 25 18:31:34 ccu2 user.debug multimac: C< @158177: bin:FD 00 03 01 4A 03 24 1B
Jan 25 18:31:34 ccu2 user.debug multimac: C> @158281: #74 TRX Response Ack 08
Jan 25 18:31:34 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:35 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:35 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:35 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:36 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:36 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:37 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:37 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:37 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:37 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:37 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:37 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:39 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:39 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:39 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:39 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:42 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:42 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:42 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_GET"=0.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_NUM"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_GET"=60.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 60.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TIMER_EVENT"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."STATE"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."TS"="1548437563" [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1548437563 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="CUX2800001:7"."WORKING"=true [iseXmlRpc.cpp:321]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 15320 [iseDOMchn.h:288]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 15270 [iseDOMdev.h:225]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:43 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:43 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:43 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:43 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:44 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:44 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:44 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:44 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:44 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:44 ccu2 user.debug multimac: C<: #75 TRX GetDutyCycle
Jan 25 18:31:44 ccu2 user.debug multimac: C< @168178: bin:FD 00 03 01 4B 03 A2 18
Jan 25 18:31:44 ccu2 user.debug multimac: C> @168282: #75 TRX Response Ack 08
Jan 25 18:31:44 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:45 ccu2 user.debug rfd: RX for LEQ0781933: @2249278474 RSSI=-63dB 0x2E1D17 -> 0x000000 Generic [MEQ0835478]:   CNT=52,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=1,BCAST=1,TYPE=0x10   DATA = 0A 9C D4 0A 00 00 
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:0.UNREACH=false
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug multimac: C> @168423: #45 LLMAC RX @ 4703ms -83dBm 34 86 10 2E 1D 17 00 00 00 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.CONTROL_MODE=0
Jan 25 18:31:45 ccu2 user.debug multimac: Bidcos RX: #34[BC|Ren|WMup] 2E1D17->000000 Info: 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:45 ccu2 user.debug multimac: A<: #95 HmBidcos RxTelegram AuthNone #34[BC|Ren|WMup] 2E1D17->000000 Info: 0A 9C D4 0A 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.FAULT_REPORTING=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.BATTERY_STATE=2.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.VALVE_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.BOOST_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.ACTUAL_TEMPERATURE=21.200000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_TIME=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_START_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_TIME=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0781933:4.PARTY_STOP_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 2 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:0"."UNREACH"=false [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1518 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP::WriteValue -> Alarm is not receipted until now! [iseDOMdpAlarm.cpp:295]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 4 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 11 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 15 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP (OID=1540 Type:Alarm) changed to Receipted state! [iseDOMdpAlarm.cpp:226]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '4' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 4 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 59655 'Servicemeldungen all in v1.98', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 59657; time= 1548437506 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '4' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '4' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 4 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 57264 'System - Servicemeldungen bestaetigen', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 57266; time= 1548437515 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '4' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."BATTERY_STATE"=2.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 2.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."VALVE_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 15 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."ACTUAL_TEMPERATURE"=21.200000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 21.200000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0781933:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1550 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1517 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: RX for LEQ0785414: @2249278522 RSSI=-53dB 0x2C95BD -> 0x000000 Generic [MEQ0835478]:   CNT=23,RPTEN=1,RPTED=0,BIDI=0,BURST=0,WAKEUP=0,WAKEMEUP=1,BCAST=1,TYPE=0x10   DATA = 0A 9C D1 0B 00 00 
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:0.UNREACH=false
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 1 events
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.CONTROL_MODE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.FAULT_REPORTING=0
Jan 25 18:31:45 ccu2 user.debug multimac: C> @168470: #46 LLMAC RX @ 4751ms -83dBm 17 86 10 2C 95 BD 00 00 00 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: Bidcos RX: #17[BC|Ren|WMup] 2C95BD->000000 Info: 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug multimac: GetAckActionForIncomingTelegram(): Unknown peer, AckAction_NotForUs
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 user.debug multimac: A<: #97 HmBidcos RxTelegram AuthNone #17[BC|Ren|WMup] 2C95BD->000000 Info: 0A 9C D1 0B 00 00
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:0"."UNREACH"=false [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1597 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.BATTERY_STATE=2.600000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.VALVE_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.BOOST_STATE=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.ACTUAL_TEMPERATURE=20.900000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.SET_TEMPERATURE=19.500000
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_TEMPERATURE=5.000000
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_TIME=0
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."CONTROL_MODE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_DAY=1
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_MONTH=1
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_START_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_TIME=0
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP::WriteValue -> Alarm is not receipted until now! [iseDOMdpAlarm.cpp:295]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."FAULT_REPORTING"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_DAY=1
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_MONTH=1
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 13 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: Event: LEQ0785414:4.PARTY_STOP_YEAR=0
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 6 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 8 events
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 14 events
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseAlarmDP (OID=1619 Type:Alarm) changed to Receipted state! [iseDOMdpAlarm.cpp:226]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 1 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."BATTERY_STATE"=2.600000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 2.600000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."VALVE_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 2 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."BOOST_STATE"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 3 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."ACTUAL_TEMPERATURE"=20.900000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 20.900000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."SET_TEMPERATURE"=19.500000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 4 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 5 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 6 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_EXACTVALUE, condition valL = 7 valR1 = 0 [iseCondition.cpp:348]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '3' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 3 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 59655 'Servicemeldungen all in v1.98', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 59655 'Servicemeldungen all in v1.98'; Destination ID = 59657 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 10000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 59657; time= 1548437506 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 59655 'Servicemeldungen all in v1.98' with valNew = '3' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '3' ; oidTrigger = 41 [iseDOMPrg.cpp:478]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_GREATER, condition valL = 3 valR1 = 0 [iseCondition.cpp:313]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 19.500000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 1 [iseCondition.cpp:1119]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_TEMPERATURE"=5.000000 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 1 [iseRule.cpp:235]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:501]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 57264 'System - Servicemeldungen bestaetigen', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 5.000000 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 57264 'System - Servicemeldungen bestaetigen'; Destination ID = 57266 [iseDOMPrg.cpp:611]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send 3 events
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 1000 [iseRTScheduler.cpp:481]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 57266; time= 1548437515 [iseRTScheduler.cpp:343]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_START_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 57264 'System - Servicemeldungen bestaetigen' with valNew = '3' [iseDOMPrg.cpp:625]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_TIME"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_DAY"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_MONTH"=1 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 1 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: XmlRpcMethodEvent::execute: Event="LEQ0785414:4"."PARTY_STOP_YEAR"=0 [iseXmlRpc.cpp:321]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: CHANNEL::SetLastDPActionTime: call on change; id = 1629 [iseDOMchn.h:288]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: DEVICE::SetLastActionTime: call on change; id = 1596 [iseDOMdev.h:225]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: XmlRpcMethodEvent::execute: UpdateValue succeeded; val = 0 [iseXmlRpc.cpp:364]
Jan 25 18:31:45 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 user.debug rfd: HSSXmlRpcEventDispatcher::Handle send completed
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:45 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript START]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:46 ccu2 user.debug script: [ALCHY ALLINScript START]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: EventThread::ThreadFunction: wait max timeout = 240000 [iseRTEvent.cpp:69]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: called Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' ; oidTrigger = 2487 [iseDOMPrg.cpp:478]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, trigger dp exists  [iseCondition.cpp:500]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: DP_VALUE_CHECK_UPDATE is set, condition = 1 [iseCondition.cpp:506]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseSingleCondition::Evaluate: type = DP_VALUE_IN_RANGE_FROM_TO, condition valL = ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M  valR1 =  valR2 =  [iseCondition.cpp:355]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, CONDITION_TRIGGER_TRUE is set. [iseCondition.cpp:1117]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseCondition::Evaluate: sc = 0, condition result = 0 [iseCondition.cpp:1119]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, CONDITION_TRIGGER_TRUE is set. [iseRule.cpp:232]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseRule::Evaluate: c = 0, condition result = 0 [iseRule.cpp:235]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::SetState: Rule evaluated state is TRUE by Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:501]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseDOMPrg::SetState: Program ID = 49207 'Push Script for pocket control', rule's trigger flags = 6 [iseDOMPrg.cpp:515]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: execute Program ID = 49207 'Push Script for pocket control'; Destination ID = 4214 [iseDOMPrg.cpp:611]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: start execute Destination within the trigger delay 0 [iseDOMPrg.cpp:615]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::Add: added script element - id= 4214; time= 0 [iseRTScheduler.cpp:343]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: IseDOMPrg::Execute: pDest->ExecuteDestination succeeded from Program ID = 49207 'Push Script for pocket control' with valNew = 'ALTE Servicemeldung^M ^M DB_H_LEQ0784289 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M HM-LC-Sw4-Ba-PCB NEQ0027554 : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:30 (25.01.19 18:31)^M ^M Flur_unten_BWM_HmIP-SMI55 0014D8A98A143A : ^M hat Kommunikationsfehler ^M seit: 25.01.19 18:31 (25.01.19 18:31)^M ^M ' [iseDOMPrg.cpp:625]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::GetInterfaceByID: interface name= CUxD for ID=12941 [iseXmlRpc.cpp:2549]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IseXmlRpc::CallXmlrpcMethod: method =setValue params = {"CUX2801001:1","CMD_EXEC","logger -t script -p user.debug [ALCHY ALLINScript ENDE]"} result = "" [iseXmlRpc.cpp:2610]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 59657; ticks = 26 [iseRTScheduler.cpp:601]
Jan 25 18:31:46 ccu2 user.debug script: [ALCHY ALLINScript ENDE]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: IsePersist::ExecProcess = 'wget -q -O /dev/null '--post-data=ccuid=P_2487C748-EDF5-475C-B10E-5C570ECA9B96&push=ALTE%20Servicemeldung^M ^M DB_H_LEQ0784289%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M HM-LC-Sw4-Ba-PCB%20NEQ0027554%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:30%20(25.01.19%2018:31)^M ^M Flur_unten_BWM_HmIP-SMI55%200014D8A98A143A%20:%20^M hat%20Kommunikationsfehler%20^M seit:%2025.01.19%2018:31%20(25.01.19%2018:31)^M ^M %20' http://push.pocket-control.com:9325 &' returned 0 [iseDOMpersist.cpp:380]
Jan 25 18:31:46 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 4214; ticks = 9 [iseRTScheduler.cpp:601]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 9000 [iseRTScheduler.cpp:481]
Jan 25 18:31:46 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 9000 [iseRTScheduler.cpp:481]
Jan 25 18:31:46 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:46 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:46 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:46 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:50 ccu2 user.err rfd: LGWPortWrapper::ReadData(): Receive error
Jan 25 18:31:50 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::asyncReconnect(): Reconnect already in progress.
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Trying to reconnect.
Jan 25 18:31:50 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Perform connect.
Jan 25 18:31:51 ccu2 user.info rfd: Lan Device Information: Protocol-Version: 1 Product-ID: Revilo-HM-LGW Firmware-Version: 0.0.2 Serial Number: MEQ0835478
Jan 25 18:31:51 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initialize coprocessor.
Jan 25 18:31:51 ccu2 user.debug rfd: CCU2CommController::improvedInit() - Coprocessor is in bootloader, going to start application.
Jan 25 18:31:51 ccu2 user.debug rfd: (MEQ0835478) CCU2CommController::handleIdentifyEvent(): Coprocessor entered application. Life is good.
Jan 25 18:31:52 ccu2 user.info rfd: (MEQ0835478) CCU2CommController::setCSMACAEnabled(): CSMA/CA disabled.
Jan 25 18:31:52 ccu2 user.debug rfd: (MEQ0835478) Response status: OK.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Initializing keepalives.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::connect(): Reconnected.
Jan 25 18:31:52 ccu2 user.debug rfd: LGWPortWrapper::reconnect(): Reconnect finished.
Jan 25 18:31:52 ccu2 user.info rfd: LanConnection::receive(): sock 14: Remote host closed connection.
Jan 25 18:31:52 ccu2 user.debug multimac: C> @176343: #3 TRX CMD=0B  00 01
Jan 25 18:31:52 ccu2 user.warn multimac: Bad cast: std::bad_cast
Jan 25 18:31:52 ccu2 user.debug multimac: A<: #25 TRX CMD=0B  00 01
Jan 25 18:31:52 ccu2 user.debug multimac: A>: #235 TRX CMD=0A  
Jan 25 18:31:52 ccu2 user.debug multimac: MacController::OnDownstreamFrame(#235 TRX CMD=0A  )
Jan 25 18:31:52 ccu2 user.debug multimac: C<: #76 TRX CMD=0A  
Jan 25 18:31:52 ccu2 user.debug multimac: C< @176346: bin:FD 00 03 01 4C 0A 30 2D
Jan 25 18:31:53 ccu2 user.debug multimac: C> @176449: #76 TRX Response Ack 00
Jan 25 18:31:53 ccu2 user.debug multimac: A<: #235 TRX Response Ack 00
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Joanna').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Tato').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 315 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Ingo').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 317 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 226 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Laura').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 325 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 230 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.iPhone-5S').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 319 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.Nutzer').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 233 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueList=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').ValueList() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 225 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.list').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 227 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend.string').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 305 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&valueName0=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName0()&valueName1=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').ValueName1() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: start web processing, worker thread #0 {"HTTP-Listener"} [httpListener.cpp:208]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: recvd 220 bytes by web server #1 [httpServer.cpp:767]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: IseSession GetSessionId from URL: /rega.exe&state=dom.GetObject(ID_SYSTEM_VARIABLES).Get('Anwesend').Value() [iseSession.cpp:185]
Jan 25 18:31:53 ccu2 local0.info ReGaHss: Info: http id #1 sends parsed file [httpServer.cpp:2025]
Jan 25 18:31:54 ccu2 user.err rfd: UnifiedLanCommController::connect(): Could not connect.
Jan 25 18:31:54 ccu2 user.err rfd: LGWPortWrapper::keepAliveThreadFunction(): Cannot connect.
Jan 25 18:31:54 ccu2 user.debug rfd: asyncReconnect
Jan 25 18:31:54 ccu2 user.debug rfd: asyncReconnect -> reconnect
Jan 25 18:31:54 ccu2 user.debug multimac: C<: #77 TRX GetDutyCycle
Jan 25 18:31:54 ccu2 user.debug multimac: C< @178179: bin:FD 00 03 01 4D 03 B6 18
Jan 25 18:31:54 ccu2 user.debug multimac: C> @178283: #77 TRX Response Ack 08
Jan 25 18:31:54 ccu2 user.debug multimac: SubsystemBidcos::CheckDutyCycleEventThreshold( 4.0, 4.0 ) = 0
Jan 25 18:31:55 ccu2 local0.debug ReGaHss: Verbose: SchedulerRT::Execute -> ExecuteScript: id = 57266; ticks = 67 [iseRTScheduler.cpp:601]
Jan 25 18:31:55 ccu2 local0.info ReGaHss: Info: SchedulerRT::ThreadFunction(): wait for event ms= 542000 [iseRTScheduler.cpp:481]
Jan 25 18:31:56 ccu2 auth.info sshd[3741]: Accepted password for root from 192.168.178.22 port 54509 ssh2

Benutzeravatar
jmaus
Beiträge: 9819
Registriert: 17.02.2015, 14:45
System: Alternative CCU (auf Basis OCCU)
Wohnort: Dresden
Hat sich bedankt: 459 Mal
Danksagung erhalten: 1856 Mal
Kontaktdaten:

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von jmaus » 25.01.2019, 18:35

@ibein: Das nöchste mal Logfiles als attachments hochladen oder in Codetags setzen sonst lösche ich den Beitrag einfach weg...
RaspberryMatic 3.75.6.20240316 @ ProxmoxVE – ~200 Hm-RF/HmIP-RF/HmIPW Geräte + ioBroker + HomeAssistant – GitHub / Sponsors / PayPal / ☕️

ibein
Beiträge: 73
Registriert: 21.01.2015, 14:06

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von ibein » 25.01.2019, 18:37

Ok, sorry...merkwürdig: nach einem manuellem Reboot ging es plötzlich wieder...

Benutzeravatar
jmaus
Beiträge: 9819
Registriert: 17.02.2015, 14:45
System: Alternative CCU (auf Basis OCCU)
Wohnort: Dresden
Hat sich bedankt: 459 Mal
Danksagung erhalten: 1856 Mal
Kontaktdaten:

Re: RaspberryMatic 3.41.11.20181222 – Erfahrungsberichte

Beitrag von jmaus » 26.01.2019, 00:17

Da inzwischen wieder eine neue Version von RaspberryMatic von mir releast wurde (3.41.11.20190126) geht es an folgender Stelle mit Erfahrungsaustausch rund um die neue Version weiter:

viewtopic.php?f=65&t=48667
RaspberryMatic 3.75.6.20240316 @ ProxmoxVE – ~200 Hm-RF/HmIP-RF/HmIPW Geräte + ioBroker + HomeAssistant – GitHub / Sponsors / PayPal / ☕️

Gesperrt

Zurück zu „RaspberryMatic“