Hallo zusammen,
seit einiger Zeit wobei ich nicht sagen kann seit wann blockiert fhem zeitweise.
Dies äussert sich z.B darin, dass wenn ich per Fernbedienung einen Aktor schalten möchte dieser nicht reagiert.
Der Befehl scheint aber gecached zu werden, da dieser nach einer gewissen Zeit ausgeführt wird.
Einmal konnte ich dieses Verhalten nachmittags beobachten.
Die Website von fhem war nicht erreichbar und lief in einen Timeout, die Auslastung des Rapis habe ich mir dann gleich mit top angeschaut. Hier konnte ich keine Auslastung oder Belastung des Raspi erkennen.
Derzeit habe ich ein MQTT Device an fhem angedockt und hier stelle ich fest, dass dieses System des öfteren einen reconnect am fhem MQTT Server vornimmt.
Mindestens aber einmal am Tag.
Im Logfile von fhem kann ich dieses sehen wobei ich immer dachte es liegt an meinem MQTT Device, aber die Zeiten passen zu den Ausfällen in fhem.
Hier der Auszug aus dem Log.
2021.01.14 00:07:11.279 5: out: PINGRESP: (208)(0)
2021.01.14 00:14:47.680 5: in: PINGREQ: (192)(0)
2021.01.14 00:14:47.680 4: MQTT2_FHEM_Server_192.168.10.208_51868 Briefkasten PINGREQ
2021.01.14 00:14:47.680 5: out: PINGRESP: (208)(0)
2021.01.14 00:14:48.032 5: CUL_HM set BadK_Thermostat ?
2021.01.14 00:14:48.185 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_60446
2021.01.14 00:14:52.678 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:52.678 4: MQTT2_FHEM_Server_192.168.10.208_60446 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:52.679 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:52.690 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_51868: EOF
2021.01.14 00:14:52.696 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_52471
2021.01.14 00:14:53.175 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_60446: EOF
2021.01.14 00:14:53.180 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:53.180 4: MQTT2_FHEM_Server_192.168.10.208_52471 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:53.180 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:53.182 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_57727
2021.01.14 00:14:53.300 5: CUL_HM set BadK_Thermostat ?
2021.01.14 00:14:53.549 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:53.549 4: MQTT2_FHEM_Server_192.168.10.208_57727 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:53.549 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:53.574 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_52471: EOF
2021.01.14 00:14:53.844 5: CUL_HM set BadK_Thermostat ?
2021.01.14 00:14:54.002 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_61680
2021.01.14 00:14:54.013 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_57727: EOF
2021.01.14 00:14:54.014 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.014 4: MQTT2_FHEM_Server_192.168.10.208_61680 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.014 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.015 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_59939
2021.01.14 00:14:54.102 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_61680: EOF
2021.01.14 00:14:54.103 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_56365
2021.01.14 00:14:54.109 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.109 4: MQTT2_FHEM_Server_192.168.10.208_59939 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.109 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.115 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.116 4: MQTT2_FHEM_Server_192.168.10.208_56365 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.116 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.117 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_51940
2021.01.14 00:14:54.132 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_59939: EOF
2021.01.14 00:14:54.134 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_60848
2021.01.14 00:14:54.147 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_56365: EOF
2021.01.14 00:14:54.187 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.187 4: MQTT2_FHEM_Server_192.168.10.208_51940 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.187 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.203 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.203 4: MQTT2_FHEM_Server_192.168.10.208_60848 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.203 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.204 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_64268
2021.01.14 00:14:54.210 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.210 4: MQTT2_FHEM_Server_192.168.10.208_64268 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.210 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.211 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_63554
2021.01.14 00:14:54.221 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_60848: EOF
2021.01.14 00:14:54.226 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_64268: EOF
2021.01.14 00:14:54.231 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_51940: Connection reset by peer
2021.01.14 00:14:54.231 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.232 4: MQTT2_FHEM_Server_192.168.10.208_63554 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.232 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.232 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_49299
2021.01.14 00:14:54.245 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.245 4: MQTT2_FHEM_Server_192.168.10.208_49299 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.246 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.251 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_63554: EOF
2021.01.14 00:14:54.252 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_59532
2021.01.14 00:14:54.261 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_49299: EOF
2021.01.14 00:14:54.263 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_60283
2021.01.14 00:14:54.267 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.267 4: MQTT2_FHEM_Server_192.168.10.208_59532 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.268 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.269 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.269 4: MQTT2_FHEM_Server_192.168.10.208_60283 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.269 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.269 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_65143
2021.01.14 00:14:54.279 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_59532: EOF
2021.01.14 00:14:54.280 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.280 4: MQTT2_FHEM_Server_192.168.10.208_65143 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.280 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.285 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_60283: EOF
2021.01.14 00:14:54.286 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_58130
2021.01.14 00:14:54.292 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_51616
2021.01.14 00:14:54.297 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.297 4: MQTT2_FHEM_Server_192.168.10.208_58130 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.297 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.302 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_58130: EOF
2021.01.14 00:14:54.302 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.303 4: MQTT2_FHEM_Server_192.168.10.208_51616 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.303 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.303 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_55008
2021.01.14 00:14:54.313 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_65143: Connection reset by peer
2021.01.14 00:14:54.314 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.314 4: MQTT2_FHEM_Server_192.168.10.208_55008 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.314 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.321 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_55033
2021.01.14 00:14:54.331 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_51616: EOF
2021.01.14 00:14:54.336 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_55008: EOF
2021.01.14 00:14:54.336 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.336 4: MQTT2_FHEM_Server_192.168.10.208_55033 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.336 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.338 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_63331
2021.01.14 00:14:54.343 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.343 4: MQTT2_FHEM_Server_192.168.10.208_63331 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.343 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.344 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_62480
2021.01.14 00:14:54.476 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_55033: EOF
2021.01.14 00:14:54.477 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_53755
2021.01.14 00:14:54.487 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_63331: EOF
2021.01.14 00:14:54.487 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.491 4: MQTT2_FHEM_Server_192.168.10.208_62480 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.492 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.497 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_62480: EOF
2021.01.14 00:14:54.497 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.497 4: MQTT2_FHEM_Server_192.168.10.208_53755 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.497 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.498 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_63683
2021.01.14 00:14:54.503 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.503 4: MQTT2_FHEM_Server_192.168.10.208_63683 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.503 5: out: CONNACK: (2)(0)(0)
2021.01.14 00:14:54.504 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_61709
2021.01.14 00:14:54.513 4: Connection closed for MQTT2_FHEM_Server_192.168.10.208_53755: Connection reset by peer
2021.01.14 00:14:54.514 5: in: CONNECT: (16)(23)(0)(4)MQTT(4)(2)(0)(15)(0)(11)Briefkasten
2021.01.14 00:14:54.514 4: MQTT2_FHEM_Server_192.168.10.208_61709 cid:Briefkasten CONNECT V:4 keepAlive:15
2021.01.14 00:14:54.514 5: out: CONNACK: (2)(0)(0)
Mein fhem läuft auf einem Raspi 4 mit 8GB Ram und ist auf dem neusten Stand vom OS und fhem.
Das fhem log Verzeichnis ist auf mein NAS ausgelagert.
Eine VCCU ist installiert mit einem 443 und einem 886er CUL.
Auf dem Raspi läuft nur fhem und Samba um hier fhem auf Windows zu mappen wenn erforderlich sonst aber keine anderen Applikationen.
Das Logging der Devices erfolgt nicht in File sondern auf meiner MySQL auf der NAS.
Hat jemand eine Idee wo ich hier ansetzen kann um der Sache mal auf den Grund zu gehen.
Viele Grüße
Sven
Zitat
Die Website von fhem war nicht erreichbar und lief in einen Timeout, die Auslastung des Rapis habe ich mir dann gleich mit top angeschaut. Hier konnte ich keine Auslastung oder Belastung des Raspi erkennen.
Das ist der größte "Trugschluss": die Auslastung ist (oft) nicht unbedingt der Grund für "Hänger".
EDIT: kann aber nat. auch ein Grund sein ;)
Fhem läuft in einem Thread, d.h. wenn fhem oder ein Modul auf etwas wartet (IO, Netzwerk, Internet, ...) dann ist die Auslastung (meist) bei "null", trotzdem geht in fhem nichts mehr...
Ich würde mal freezemon aktivieren und schauen was der so meldet.
EDIT:
https://forum.fhem.de/index.php?topic=83748.0
https://fhem.de/commandref_DE.html#freezemon
Ansonsten: nutzt du Module mit Internetzugriff (Wetter, ...)? Hast du das Attribut dnsServer bei global gesetzt?
EDIT:
Zitat
Eine VCCU ist installiert mit einem 443 und einem 886er CUL.
vccu? Oder virtualisierrte CCU? Einen CUL für Homematic? Warum? ;)
Hat (verm.) nichts mit dem Problem zu tun. Nur weil es mir aufgefallen ist... ;)
Gruß, Joachim
ist der pi über wlan angebunden?
Hallo,
vielen Dank erst einmal.
Mein Pi ist per WLan angebunden und ja ich nutzte folgende Web Zugriffe
Wetteronline = kann ich mal abschalten
RKI = hier frage ich zyklisch die Daten ab, zyklische Aktualisierung
apothekenfinder.mobi = hier frage ich die Notdienstapotheke ab, Aktualisierung per AT morgends
Das mit dem freezemon schaue ich mir an und werde dies aktivieren
Ich nutze die virtuelle CCU.
Hierauf habe ich erst letztens umgestellt um dann auch von dem CUL für Homematic weg zu kommen.
Viele Grüße
Sven
Du musst die Internet-Dienste nicht gleich deaktivieren (kannst du nat.) aber wichtig bei Nutzung von "Internet-Diensten" ist auf jeden Fall:
attr global dnsServer IP-Des-Routers
Also meist IP des Routers bzw. eben des "Rechners" der DNS-Auflösung macht/machen soll...
Gruß, Joachim
ZitatMein Pi ist per WLan angebunden
ich würde einen fhem server immer über lan an einen router anbinden.
zumindestens über das interne wlan meines pi3 habe ich nie eine dauerhaft stabile verbindung erreicht.
Zitatattr global dnsServer IP-Des-Routers
Also meist IP des Routers bzw. eben des "Rechners" der DNS-Auflösung macht/machen soll...
Wenn IP-Des-Routers nicht bekannt ist / irgendwie nicht funktioniert, kann man auch einen DNS-Server von den "Grossen" nehmen: 1.1.1.1 (CloudFlare) oder 4.4.4.4 (Google), das kann man relativ einfach merken, und man vertippt sich nicht so leicht.
Hallo,
gestern war es mal wieder zum beobachten, dass fhem eingefroren war.
Freezmon hat mir hier auch einiges aufgezeichnet.
Mir fällt hier auf, dass mein LG TV anscheinend die Probleme bereitet. Hier bin ich mir aber nicht sicher und bitte euch schaut doch mal drüber.
Hier wird ein delay von 449,625 sekunden verzeichnet, da frage ich mich aber warum.
Das TV ist mit den fhem Boardmitteln eingebunden, hier mein List dazu.
Internals:
DEF 192.168.10.48
FUUID 5f8808a2-f33f-f700-196d-6d3e07adc529c9d7
FVERSION 82_LGTV_WebOS.pm:v3.2.4-s22008/2020-05-22
HOST 192.168.10.48
NAME LG_TV
NR 820
PARTIAL
STATE off
TYPE LGTV_WebOS
VERSION v3.2.4
READINGS:
2020-12-09 00:30:05 channel -
2020-10-15 10:30:26 channelCurrentEndTime -
2020-10-15 10:30:26 channelCurrentStartTime -
2020-10-15 10:30:26 channelCurrentTitle -
2020-12-09 00:30:05 channelMedia -
2020-12-09 00:30:05 channelName -
2020-10-15 10:30:26 channelNextEndTime -
2020-10-15 10:30:26 channelNextStartTime -
2020-10-15 10:30:26 channelNextTitle -
2021-01-12 23:49:33 extInput_HDMI 1 connect_0
2021-01-16 20:10:37 extInput_HDMI 1 connect_1
2021-01-16 20:10:37 extInput_HDMI 2 connect_0
2021-01-16 20:10:37 extInput_HDMI 3 connect_0
2021-01-16 20:10:37 extInput_HDMI 4 connect_0
2021-01-10 23:24:53 input HDMI 1
2021-01-16 23:58:44 lastResponse ok
2021-01-10 23:24:53 launchApp -
2020-10-15 10:32:34 lgKey 4beb29f819bfc2a394265219319b78c7
2020-10-15 10:32:38 mute off
2021-01-04 00:25:22 pairing paired
2021-01-17 00:14:50 state off
2020-12-27 21:45:18 volume 99
helper:
wsKey MTYxMDgyNDIxOS4zMjI3MQ==
device:
registered 1
runsetcmd 0
channelguide:
counter 7624
inputapps:
com.webos.app.hdmi1 HDMI 1
com.webos.app.hdmi2 HDMI 2
com.webos.app.hdmi3 HDMI 3
com.webos.app.hdmi4 HDMI 4
inputs:
HDMI 1 com.webos.app.hdmi1
HDMI 2 com.webos.app.hdmi2
HDMI 3 com.webos.app.hdmi3
HDMI 4 com.webos.app.hdmi4
Attributes:
devStateIcon on:10px-kreis-gruen:off off:10px-kreis-rot:on
room Wohnzimmer
wakeOnLanBroadcast 255.255.255.255
wakeOnLanMAC 58:FD:B1:82:A8:E7
Hier der Freezlog
=========================================================
[Freezemon] fhem_freez: possible freeze starting at 00:07:21, delay is 449.625 possibly caused by: tmr-LGTV_WebOS_GetForgroundAppInfo(LG_TV) tmr-at_Exec(LED_gelb.blink)
2021.01.17 00:07:20.091 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_GetForgroundAppInfo: 0
2021.01.17 00:07:20.091 5: LGTV_WebOS (LG_TV) - Sending command: {"client-key":"4beb29f819bfc2a394265219319b78c7","uri":["ssap://com.webos.applicationManager/getForegroundAppInfo"],"type":"request","id":"request_1610838440.0913"}
2021.01.17 00:07:20.091 4: LGTV_WebOS (LG_TV) - WriteFn called
2021.01.17 00:07:20.091 4: LGTV_WebOS (LG_TV) - þ ¤ 2K{;Q'i|\?-rW2"#b|Py9
z9{T(2xr4+~2( x1 P|8zi,;G9i;"jA*p# dcv_ew|P$s7S;pu[(am[$nTS%a~W9/~W?Fv@.gk]>n}s;pP\-o;og"mK;e;ir|C>ejFi,;[/"#9ehG.smmz6(s3!07r1*6
--- log skips 449.869 secs.
2021.01.17 00:14:49.961 5: CUL/RAW: /i6669AAAAAAAA95AAF2
i6669AAAAAAAA95AAE5
2021.01.17 00:14:49.961 4: CUL_Parse: CUL_1 i6669AAAAAAAA95AAF2 -81
2021.01.17 00:14:49.962 4: CUL_1 IT: message "i6669aaaaaaaa95aa" (17)
2021.01.17 00:14:49.962 4: CUL_1 ITv3: bin message "0110011001101001101010101010101010101010101010101001010110101010" (64)
2021.01.17 00:14:49.962 4: CUL_1 IT: msgcode "01010110111111111111111110001111" (32) bin = 0110011001101001101010101010101010101010101010101001010110101010
2021.01.17 00:14:49.962 3: CUL_1 IT: FB2_Ch01 on->off
2021.01.17 00:14:49.963 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:49.964 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.964 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:49.964 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.964 4: DbLog logdb -> number of events received: 1 for device: FB2_Ch01
2021.01.17 00:14:49.964 4: DbLog logdb -> check Device: FB2_Ch01 , Event: state: off
2021.01.17 00:14:49.966 5: Triggering n_Schl_La_Bett_off
2021.01.17 00:14:49.966 4: n_Schl_La_Bett_off exec set Schl_La_.* off
2021.01.17 00:14:49.966 5: Cmd: >set Schl_La_.* off<
2021.01.17 00:14:49.975 3: CUL_HM set Schl_La_Bett off noArg
2021.01.17 00:14:49.977 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:49.977 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.977 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:49.978 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.978 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Bett
2021.01.17 00:14:49.978 4: DbLog logdb -> check Device: Schl_La_Bett , Event: commState: CMDs_pending
2021.01.17 00:14:49.979 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:49.981 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:49.983 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:49.983 5: CUL_HM Schl_La_Bett protEvent:CMDs_pending pending:1
2021.01.17 00:14:49.984 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:49.985 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.985 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:49.985 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.985 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Bett
2021.01.17 00:14:49.985 4: DbLog logdb -> check Device: Schl_La_Bett , Event: state: set_off noArg
2021.01.17 00:14:49.986 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:49.988 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:49.993 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:49.994 5: CUL_0 sending As0E0AA011F11034269B9A0201000000
2021.01.17 00:14:49.994 5: SW: As0E0AA011F11034269B9A0201000000
2021.01.17 00:14:49.997 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:49.997 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.998 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:49.998 4: DbLog logdb -> ################################################################
2021.01.17 00:14:49.998 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Bett
2021.01.17 00:14:49.998 4: DbLog logdb -> check Device: Schl_La_Bett , Event: commState: CMDs_processing...
2021.01.17 00:14:49.999 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.001 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:50.006 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:50.006 5: CUL_HM Schl_La_Bett protEvent:CMDs_processing... pending:0
2021.01.17 00:14:50.007 3: CUL_HM set Schl_La_Haupt off noArg
2021.01.17 00:14:50.008 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.008 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.008 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.008 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.008 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Haupt
2021.01.17 00:14:50.009 4: DbLog logdb -> check Device: Schl_La_Haupt , Event: commState: CMDs_pending
2021.01.17 00:14:50.010 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.011 5: CUL_HM set Schl_La_Haupt ?
2021.01.17 00:14:50.015 5: End notify loop for Schl_La_Haupt
2021.01.17 00:14:50.015 5: CUL_HM Schl_La_Haupt protEvent:CMDs_pending pending:1
2021.01.17 00:14:50.015 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.016 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.016 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.016 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.016 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Haupt
2021.01.17 00:14:50.016 4: DbLog logdb -> check Device: Schl_La_Haupt , Event: state: set_off noArg
2021.01.17 00:14:50.018 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.019 5: CUL_HM set Schl_La_Haupt ?
2021.01.17 00:14:50.023 5: End notify loop for Schl_La_Haupt
2021.01.17 00:14:50.024 5: CUL_0 sending As0E8DA011F1103437D9670201000000
2021.01.17 00:14:50.024 5: SW: As0E8DA011F1103437D9670201000000
2021.01.17 00:14:50.026 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.027 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.027 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.027 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.027 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Haupt
2021.01.17 00:14:50.027 4: DbLog logdb -> check Device: Schl_La_Haupt , Event: commState: CMDs_processing...
2021.01.17 00:14:50.028 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.030 5: CUL_HM set Schl_La_Haupt ?
2021.01.17 00:14:50.034 5: End notify loop for Schl_La_Haupt
2021.01.17 00:14:50.034 5: CUL_HM Schl_La_Haupt protEvent:CMDs_processing... pending:0
2021.01.17 00:14:50.035 3: CUL_HM set Schl_La_Schrank off noArg
2021.01.17 00:14:50.036 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.037 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.037 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.037 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.037 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Schrank
2021.01.17 00:14:50.037 4: DbLog logdb -> check Device: Schl_La_Schrank , Event: commState: CMDs_pending
2021.01.17 00:14:50.038 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.040 5: CUL_HM set Schl_La_Schrank ?
2021.01.17 00:14:50.043 5: End notify loop for Schl_La_Schrank
2021.01.17 00:14:50.043 5: CUL_HM Schl_La_Schrank protEvent:CMDs_pending pending:1
2021.01.17 00:14:50.044 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.045 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.045 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.045 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.045 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Schrank
2021.01.17 00:14:50.045 4: DbLog logdb -> check Device: Schl_La_Schrank , Event: state: set_off noArg
2021.01.17 00:14:50.046 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.048 5: CUL_HM set Schl_La_Schrank ?
2021.01.17 00:14:50.052 5: End notify loop for Schl_La_Schrank
2021.01.17 00:14:50.053 5: CUL_0 sending As0EDDA011F110342EB0120201000000
2021.01.17 00:14:50.053 5: SW: As0EDDA011F110342EB0120201000000
2021.01.17 00:14:50.056 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.056 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.056 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.056 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.056 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Schrank
2021.01.17 00:14:50.056 4: DbLog logdb -> check Device: Schl_La_Schrank , Event: commState: CMDs_processing...
2021.01.17 00:14:50.058 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.059 5: CUL_HM set Schl_La_Schrank ?
2021.01.17 00:14:50.063 5: End notify loop for Schl_La_Schrank
2021.01.17 00:14:50.063 5: CUL_HM Schl_La_Schrank protEvent:CMDs_processing... pending:0
2021.01.17 00:14:50.064 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.073 5: End notify loop for FB2_Ch01
2021.01.17 00:14:50.073 4: CUL_Parse: CUL_1 i6669AAAAAAAA95AAE5 -87.5
2021.01.17 00:14:50.073 4: CUL_1 IT: message "i6669aaaaaaaa95aa" (17)
2021.01.17 00:14:50.073 4: CUL_1 ITv3: bin message "0110011001101001101010101010101010101010101010101001010110101010" (64)
2021.01.17 00:14:50.073 4: CUL_1 IT: msgcode "01010110111111111111111110001111" (32) bin = 0110011001101001101010101010101010101010101010101001010110101010
2021.01.17 00:14:50.073 3: CUL_1 IT: FB2_Ch01 off->off
2021.01.17 00:14:50.074 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.074 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.074 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.074 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.074 4: DbLog logdb -> number of events received: 1 for device: FB2_Ch01
2021.01.17 00:14:50.074 4: DbLog logdb -> check Device: FB2_Ch01 , Event: state: off
2021.01.17 00:14:50.075 5: Triggering n_Schl_La_Bett_off
2021.01.17 00:14:50.075 4: n_Schl_La_Bett_off exec set Schl_La_.* off
2021.01.17 00:14:50.075 5: Cmd: >set Schl_La_.* off<
2021.01.17 00:14:50.079 3: CUL_HM set Schl_La_Bett off noArg
2021.01.17 00:14:50.079 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.080 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.080 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.080 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.080 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Bett
2021.01.17 00:14:50.080 4: DbLog logdb -> check Device: Schl_La_Bett , Event: state: set_off noArg
2021.01.17 00:14:50.080 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.081 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:50.083 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:50.084 3: CUL_HM set Schl_La_Haupt off noArg
2021.01.17 00:14:50.084 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.085 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.085 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.085 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.085 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Haupt
2021.01.17 00:14:50.085 4: DbLog logdb -> check Device: Schl_La_Haupt , Event: state: set_off noArg
2021.01.17 00:14:50.085 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.086 5: CUL_HM set Schl_La_Haupt ?
2021.01.17 00:14:50.088 5: End notify loop for Schl_La_Haupt
2021.01.17 00:14:50.088 3: CUL_HM set Schl_La_Schrank off noArg
2021.01.17 00:14:50.089 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.089 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.089 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.089 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.089 4: DbLog logdb -> number of events received: 1 for device: Schl_La_Schrank
2021.01.17 00:14:50.089 4: DbLog logdb -> check Device: Schl_La_Schrank , Event: state: set_off noArg
2021.01.17 00:14:50.090 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.091 5: CUL_HM set Schl_La_Schrank ?
2021.01.17 00:14:50.092 5: End notify loop for Schl_La_Schrank
2021.01.17 00:14:50.093 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.101 5: End notify loop for FB2_Ch01
2021.01.17 00:14:50.101 4: LGTV_WebOS (LG_TV) - ReadFn started
2021.01.17 00:14:50.102 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.102 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.102 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.102 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.102 4: DbLog logdb -> number of events received: 1 for device: LG_TV
2021.01.17 00:14:50.102 4: DbLog logdb -> check Device: LG_TV , Event: state: off
2021.01.17 00:14:50.103 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.104 5: End notify loop for LG_TV
2021.01.17 00:14:50.104 4: LGTV_WebOS (LG_TV) - Socket Disconnected
2021.01.17 00:14:50.104 5: CUL/RAW: /A1950008F635650F0000100002FD92828276FABF0B2CFB9C186A3D3
A0F72861064FAB10000000AA0DD0A00401C
A0F3D861072647F0000000A88B10F004029
A0CA2865A3A79EE00000088CE2F28
A0B08A44024BBA0269B9A032D2E
A0E088002269B9A24BBA0010128203919
A0D09A410269B9AF1103406010000
2021.01.17 00:14:50.104 4: CUL_Parse: CUL_0 A 19 50 008F 635650 F00001 00002FD92828276FABF0B2CFB9C186A3D3 -96.5
2021.01.17 00:14:50.105 4: CUL_Parse: CUL_0 A 0F 72 8610 64FAB1 000000 0AA0DD0A00401C -60
2021.01.17 00:14:50.108 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.108 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.108 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.108 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.108 4: DbLog logdb -> number of events received: 6 for device: WC_Thermostat
2021.01.17 00:14:50.108 4: DbLog logdb -> check Device: WC_Thermostat , Event: actuator: 0
2021.01.17 00:14:50.108 4: DbLog logdb -> check Device: WC_Thermostat , Event: battery: ok
2021.01.17 00:14:50.109 5: DbLog logdb -> parsed Event: WC_Thermostat , Event: battery: ok
2021.01.17 00:14:50.109 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: WC_Thermostat, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.109 4: DbLog logdb -> check Device: WC_Thermostat , Event: batteryLevel: 2.5
2021.01.17 00:14:50.109 5: DbLog logdb -> parsed Event: WC_Thermostat , Event: batteryLevel: 2.5
2021.01.17 00:14:50.109 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: WC_Thermostat, Type: CUL_HM, Event: batteryLevel: 2.5, Reading: batteryLevel, Value: 2.5, Unit:
2021.01.17 00:14:50.109 4: DbLog logdb -> check Device: WC_Thermostat , Event: desired-temp: 20.0
2021.01.17 00:14:50.109 4: DbLog logdb -> check Device: WC_Thermostat , Event: measured-temp: 22.1
2021.01.17 00:14:50.109 4: DbLog logdb -> check Device: WC_Thermostat , Event: motorErr: ok
2021.01.17 00:14:50.119 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.119 4: DbLog logdb -> ### New database processing cycle - synchronous ###
2021.01.17 00:14:50.119 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.119 4: DbLog logdb -> DbLogType is: Current/History
2021.01.17 00:14:50.119 4: DbLog logdb -> AutoCommit mode: ON, Transaction mode: ON
2021.01.17 00:14:50.119 4: DbLog logdb -> Insert mode: Array
2021.01.17 00:14:50.125 4: DbLog logdb -> Primary Key used in history: none
2021.01.17 00:14:50.125 4: DbLog logdb -> Primary Key used in current: DEVICE,READING
2021.01.17 00:14:50.125 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: WC_Thermostat, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.125 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: WC_Thermostat, Type: CUL_HM, Event: batteryLevel: 2.5, Reading: batteryLevel, Value: 2.5, Unit:
2021.01.17 00:14:50.129 4: DbLog logdb -> 2 of 2 events inserted into table history
2021.01.17 00:14:50.149 4: DbLog logdb -> insert table history committed by autocommit
2021.01.17 00:14:50.156 4: DbLog logdb -> 2 of 2 events updated in table current using PK on columns DEVICE,READING
2021.01.17 00:14:50.215 4: DbLog logdb -> insert / update table current committed by autocommit
2021.01.17 00:14:50.216 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.217 5: CUL_HM set WC_Thermostat ?
2021.01.17 00:14:50.218 5: End notify loop for WC_Thermostat
2021.01.17 00:14:50.218 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.219 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.219 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.219 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.219 4: DbLog logdb -> number of events received: 9 for device: WC_Thermostat_Clima
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: ValvePosition: 0
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: boostTime: -
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: controlMode: manual
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: desired-temp: 20.0
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: measured-temp: 22.1
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: partyEnd: -
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: partyStart: -
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: partyTemp: -
2021.01.17 00:14:50.219 4: DbLog logdb -> check Device: WC_Thermostat_Clima , Event: state: T: 22.1 desired: 20.0 valve: 0
2021.01.17 00:14:50.220 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.221 5: CUL_HM set WC_Thermostat_Clima ?
2021.01.17 00:14:50.222 5: End notify loop for WC_Thermostat_Clima
2021.01.17 00:14:50.222 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.223 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.223 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.223 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.223 4: DbLog logdb -> number of events received: 2 for device: WC_Thermostat_Weather
2021.01.17 00:14:50.223 4: DbLog logdb -> check Device: WC_Thermostat_Weather , Event: measured-temp: 22.1
2021.01.17 00:14:50.223 4: DbLog logdb -> check Device: WC_Thermostat_Weather , Event: state: 22.1
2021.01.17 00:14:50.223 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.224 5: CUL_HM set WC_Thermostat_Weather ?
2021.01.17 00:14:50.224 5: End notify loop for WC_Thermostat_Weather
2021.01.17 00:14:50.224 4: CUL_Parse: CUL_0 A 0F 3D 8610 72647F 000000 0A88B10F004029 -53.5
2021.01.17 00:14:50.227 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.228 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.228 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.228 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.228 4: DbLog logdb -> number of events received: 6 for device: BadK_Thermostat
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: actuator: 0
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: battery: ok
2021.01.17 00:14:50.228 5: DbLog logdb -> parsed Event: BadK_Thermostat , Event: battery: ok
2021.01.17 00:14:50.228 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: BadK_Thermostat, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: batteryLevel: 3
2021.01.17 00:14:50.228 5: DbLog logdb -> parsed Event: BadK_Thermostat , Event: batteryLevel: 3
2021.01.17 00:14:50.228 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: BadK_Thermostat, Type: CUL_HM, Event: batteryLevel: 3, Reading: batteryLevel, Value: 3, Unit:
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: desired-temp: 17.0
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: measured-temp: 17.7
2021.01.17 00:14:50.228 4: DbLog logdb -> check Device: BadK_Thermostat , Event: motorErr: ok
2021.01.17 00:14:50.233 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.233 4: DbLog logdb -> ### New database processing cycle - synchronous ###
2021.01.17 00:14:50.233 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.233 4: DbLog logdb -> DbLogType is: Current/History
2021.01.17 00:14:50.233 4: DbLog logdb -> AutoCommit mode: ON, Transaction mode: ON
2021.01.17 00:14:50.233 4: DbLog logdb -> Insert mode: Array
2021.01.17 00:14:50.240 4: DbLog logdb -> Primary Key used in history: none
2021.01.17 00:14:50.240 4: DbLog logdb -> Primary Key used in current: DEVICE,READING
2021.01.17 00:14:50.240 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: BadK_Thermostat, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.240 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: BadK_Thermostat, Type: CUL_HM, Event: batteryLevel: 3, Reading: batteryLevel, Value: 3, Unit:
2021.01.17 00:14:50.244 4: DbLog logdb -> 2 of 2 events inserted into table history
2021.01.17 00:14:50.282 4: DbLog logdb -> insert table history committed by autocommit
2021.01.17 00:14:50.288 4: DbLog logdb -> 2 of 2 events updated in table current using PK on columns DEVICE,READING
2021.01.17 00:14:50.291 4: DbLog logdb -> insert / update table current committed by autocommit
2021.01.17 00:14:50.293 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.293 5: CUL_HM set BadK_Thermostat ?
2021.01.17 00:14:50.296 5: End notify loop for BadK_Thermostat
2021.01.17 00:14:50.297 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.297 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.297 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.297 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.297 4: DbLog logdb -> number of events received: 9 for device: BadK_Thermostat_Clima
2021.01.17 00:14:50.297 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: ValvePosition: 0
2021.01.17 00:14:50.297 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: boostTime: -
2021.01.17 00:14:50.297 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: controlMode: manual
2021.01.17 00:14:50.297 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: desired-temp: 17.0
2021.01.17 00:14:50.297 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: measured-temp: 17.7
2021.01.17 00:14:50.298 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: partyEnd: -
2021.01.17 00:14:50.298 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: partyStart: -
2021.01.17 00:14:50.298 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: partyTemp: -
2021.01.17 00:14:50.298 4: DbLog logdb -> check Device: BadK_Thermostat_Clima , Event: state: T: 17.7 desired: 17.0 valve: 0
2021.01.17 00:14:50.298 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.300 5: CUL_HM set BadK_Thermostat_Clima ?
2021.01.17 00:14:50.300 5: End notify loop for BadK_Thermostat_Clima
2021.01.17 00:14:50.301 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.301 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.301 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.301 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.301 4: DbLog logdb -> number of events received: 2 for device: BadK_Thermostat_Weather
2021.01.17 00:14:50.301 4: DbLog logdb -> check Device: BadK_Thermostat_Weather , Event: measured-temp: 17.7
2021.01.17 00:14:50.301 4: DbLog logdb -> check Device: BadK_Thermostat_Weather , Event: state: 17.7
2021.01.17 00:14:50.302 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.302 5: CUL_HM set BadK_Thermostat_Weather ?
2021.01.17 00:14:50.303 5: End notify loop for BadK_Thermostat_Weather
2021.01.17 00:14:50.303 4: CUL_Parse: CUL_0 A 0C A2 865A 3A79EE 000000 88CE2F28 -54
2021.01.17 00:14:50.305 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.305 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.305 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.305 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.305 4: DbLog logdb -> number of events received: 4 for device: Kue_Thermostat_Climate
2021.01.17 00:14:50.306 4: DbLog logdb -> check Device: Kue_Thermostat_Climate , Event: desired-temp: 17.0
2021.01.17 00:14:50.306 4: DbLog logdb -> check Device: Kue_Thermostat_Climate , Event: humidity: 47
2021.01.17 00:14:50.306 5: DbLog logdb -> parsed Event: Kue_Thermostat_Climate , Event: humidity: 47
2021.01.17 00:14:50.306 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: Kue_Thermostat_Climate, Type: CUL_HM, Event: humidity: 47, Reading: humidity, Value: 47, Unit: %
2021.01.17 00:14:50.306 4: DbLog logdb -> check Device: Kue_Thermostat_Climate , Event: measured-temp: 20.6
2021.01.17 00:14:50.306 4: DbLog logdb -> check Device: Kue_Thermostat_Climate , Event: state: T: 20.6 desired: 17.0
2021.01.17 00:14:50.311 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.311 4: DbLog logdb -> ### New database processing cycle - synchronous ###
2021.01.17 00:14:50.311 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.311 4: DbLog logdb -> DbLogType is: Current/History
2021.01.17 00:14:50.311 4: DbLog logdb -> AutoCommit mode: ON, Transaction mode: ON
2021.01.17 00:14:50.311 4: DbLog logdb -> Insert mode: Array
2021.01.17 00:14:50.316 4: DbLog logdb -> Primary Key used in history: none
2021.01.17 00:14:50.316 4: DbLog logdb -> Primary Key used in current: DEVICE,READING
2021.01.17 00:14:50.316 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: Kue_Thermostat_Climate, Type: CUL_HM, Event: humidity: 47, Reading: humidity, Value: 47, Unit: %
2021.01.17 00:14:50.319 4: DbLog logdb -> 1 of 1 events inserted into table history
2021.01.17 00:14:50.377 4: DbLog logdb -> insert table history committed by autocommit
2021.01.17 00:14:50.382 4: DbLog logdb -> 1 of 1 events updated in table current using PK on columns DEVICE,READING
2021.01.17 00:14:50.433 4: DbLog logdb -> insert / update table current committed by autocommit
2021.01.17 00:14:50.435 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.436 5: CUL_HM set Kue_Thermostat_Climate ?
2021.01.17 00:14:50.437 5: End notify loop for Kue_Thermostat_Climate
2021.01.17 00:14:50.437 4: CUL_Parse: CUL_0 A 0B 08 A440 24BBA0 269B9A 032D2E -51
2021.01.17 00:14:50.439 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.440 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.440 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.440 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.440 4: DbLog logdb -> number of events received: 4 for device: Schl_FT_Btn_03
2021.01.17 00:14:50.440 4: DbLog logdb -> check Device: Schl_FT_Btn_03 , Event: state: Short 1_45 (to Schl_La_Bett)
2021.01.17 00:14:50.440 4: DbLog logdb -> check Device: Schl_FT_Btn_03 , Event: trigger: Short_45
2021.01.17 00:14:50.440 4: DbLog logdb -> check Device: Schl_FT_Btn_03 , Event: triggerTo_Schl_La_Bett: Short_45
2021.01.17 00:14:50.440 4: DbLog logdb -> check Device: Schl_FT_Btn_03 , Event: trigger_cnt: 45
2021.01.17 00:14:50.441 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.442 5: CUL_HM set Schl_FT_Btn_03 ?
2021.01.17 00:14:50.442 5: End notify loop for Schl_FT_Btn_03
2021.01.17 00:14:50.443 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.443 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.443 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.443 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.443 4: DbLog logdb -> number of events received: 2 for device: Schl_FT_Device
2021.01.17 00:14:50.443 4: DbLog logdb -> check Device: Schl_FT_Device , Event: battery: ok
2021.01.17 00:14:50.443 5: DbLog logdb -> parsed Event: Schl_FT_Device , Event: battery: ok
2021.01.17 00:14:50.443 4: DbLog logdb -> added event - Timestamp: 2021-01-17 00:14:50, Device: Schl_FT_Device, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.443 4: DbLog logdb -> check Device: Schl_FT_Device , Event: state: Schl_FT_Btn_03 Short
2021.01.17 00:14:50.448 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.448 4: DbLog logdb -> ### New database processing cycle - synchronous ###
2021.01.17 00:14:50.448 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.448 4: DbLog logdb -> DbLogType is: Current/History
2021.01.17 00:14:50.448 4: DbLog logdb -> AutoCommit mode: ON, Transaction mode: ON
2021.01.17 00:14:50.448 4: DbLog logdb -> Insert mode: Array
2021.01.17 00:14:50.453 4: DbLog logdb -> Primary Key used in history: none
2021.01.17 00:14:50.453 4: DbLog logdb -> Primary Key used in current: DEVICE,READING
2021.01.17 00:14:50.453 4: DbLog logdb -> processing event Timestamp: 2021-01-17 00:14:50, Device: Schl_FT_Device, Type: CUL_HM, Event: battery: ok, Reading: battery, Value: ok, Unit:
2021.01.17 00:14:50.457 4: DbLog logdb -> 1 of 1 events inserted into table history
2021.01.17 00:14:50.515 4: DbLog logdb -> insert table history committed by autocommit
2021.01.17 00:14:50.519 4: DbLog logdb -> 1 of 1 events updated in table current using PK on columns DEVICE,READING
2021.01.17 00:14:50.582 4: DbLog logdb -> insert / update table current committed by autocommit
2021.01.17 00:14:50.583 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.583 5: CUL_HM set Schl_FT_Device ?
2021.01.17 00:14:50.584 5: End notify loop for Schl_FT_Device
2021.01.17 00:14:50.584 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.585 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.585 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.585 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.585 4: DbLog logdb -> number of events received: 2 for device: Schl_La_Bett
2021.01.17 00:14:50.585 4: DbLog logdb -> check Device: Schl_La_Bett , Event: trigLast: Schl_FT_Btn_03:short
2021.01.17 00:14:50.585 4: DbLog logdb -> check Device: Schl_La_Bett , Event: trig_Schl_FT_Btn_03: Short_45
2021.01.17 00:14:50.585 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.586 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:50.588 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:50.588 4: CUL_Parse: CUL_0 A 0E 08 8002 269B9A 24BBA0 010128203919 -61.5
2021.01.17 00:14:50.592 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.592 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.592 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.592 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.592 4: DbLog logdb -> number of events received: 1 for device: Schl_FT_Btn_03
2021.01.17 00:14:50.592 4: DbLog logdb -> check Device: Schl_FT_Btn_03 , Event: triggerTo_Schl_La_Bett: Short_45_ack
2021.01.17 00:14:50.593 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.593 5: CUL_HM set Schl_FT_Btn_03 ?
2021.01.17 00:14:50.594 5: End notify loop for Schl_FT_Btn_03
2021.01.17 00:14:50.594 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.595 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.595 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.595 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.595 4: DbLog logdb -> number of events received: 9 for device: Schl_La_Bett
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: deviceMsg: 20 (to Schl_FT_Device)
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: dim: down:20
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: level: 20
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: overheat: off
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: overload: off
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: pct: 20
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: reduced: off
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: state: 20
2021.01.17 00:14:50.595 4: DbLog logdb -> check Device: Schl_La_Bett , Event: timedOn: off
2021.01.17 00:14:50.596 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.597 5: CUL_HM set Schl_La_Bett ?
2021.01.17 00:14:50.598 5: End notify loop for Schl_La_Bett
2021.01.17 00:14:50.598 5: in: PINGREQ: (192)(0)
2021.01.17 00:14:50.600 4: MQTT2_FHEM_Server_192.168.10.208_62048 Briefkasten PINGREQ
2021.01.17 00:14:50.601 5: out: PINGRESP: (208)(0)
2021.01.17 00:14:50.604 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_57844
2021.01.17 00:14:50.606 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.607 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.607 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.607 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.607 4: DbLog logdb -> number of events received: 1 for device: MQTT2_FHEM_Server
2021.01.17 00:14:50.607 4: DbLog logdb -> check Device: MQTT2_FHEM_Server , Event: nrclients: 2
2021.01.17 00:14:50.607 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.608 5: End notify loop for MQTT2_FHEM_Server
2021.01.17 00:14:50.608 5: Cmd: >{BlockingStart('23701')}<
2021.01.17 00:14:50.610 5: Cmd: >{PRESENCE_ProcessLocalScan('DashButton_Duracell|0|absent')}<
2021.01.17 00:14:50.610 5: PRESENCE (DashButton_Duracell) - blocking scan result: DashButton_Duracell|0|absent
2021.01.17 00:14:50.611 4: PRESENCE (DashButton_Duracell) - rescheduling next check in 1 seconds
2021.01.17 00:14:50.612 5: exec at command LED_gelb.blink
2021.01.17 00:14:50.612 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.17 00:14:50.612 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.17 00:14:50.612 5: Cmd: >set LED_gelb on<
2021.01.17 00:14:50.612 5: LED_gelb, in fileaccess: value 1
2021.01.17 00:14:50.613 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.613 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.613 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.613 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.613 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.17 00:14:50.613 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.17 00:14:50.614 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.614 5: wird an setextensions gesendet: LED_gelb ?
2021.01.17 00:14:50.622 5: End notify loop for LED_gelb
2021.01.17 00:14:50.623 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.17 00:14:50.623 5: Temperaturen: not on any display, ignoring notify
2021.01.17 00:14:50.624 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.624 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.17 00:14:50.624 4: DbLog logdb -> ################################################################
2021.01.17 00:14:50.624 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.17 00:14:50.624 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 00:07:22
2021.01.17 00:14:50.624 5: rg_battery: not on any display, ignoring notify
2021.01.17 00:14:50.625 5: End notify loop for LED_gelb.blink
2021.01.17 00:14:50.625 5: [Freezemon] fhem_freez: ----------- Starting Freeze handling at 2021.01.17 00:14:50.625 ---------------------
[Freezemon] fhem_freez: possible freeze starting at 00:07:21, delay is 449.625 possibly caused by: tmr-LGTV_WebOS_GetForgroundAppInfo(LG_TV) tmr-at_Exec(LED_gelb.blink)
Vorausgegangen ist das Command an Alexa "Gute Nacht an"
Dieses schaltet mir mein Entertainment System aus und verschiedene Lampen im Haus ein damit ich hier nicht beim zu Bett gehen überall Lichter an machen muss :)
Hierzu habe ich einen Dummy auf den dann ein notify reagiert.
Dummy
Internals:
FUUID 5e89fc60-f33f-f700-c393-75c0c7bd50ab6988
NAME Gute_Nacht
NR 802
STATE off
TYPE dummy
READINGS:
2021-01-16 23:59:04 state off
Attributes:
alexaName Gute Nacht
genericDeviceType switch
room Test,Wohnzimmer
setList on off
webCmd on:off
Notify
Internals:
CFGFN ./test.cfg
DEF Gute_Nacht:on.* {
if (Value('Radio') eq 'on') {
fhem ("set Radio off");
}
if (Value('TV') eq 'on') {
fhem ("set TV off");
}
fhem ("set Stimmungslicht off");
fhem ('define at_Gute_Nacht_notify at +00:00:20 {
fhem ("set Gute_Nacht off");;
}
');;
fhem ("set Wz_La_Spot on;set Kue_La_.* on; set Flur_La_Haupt on;set Bad_La_Haupt on;set Schl_La_Bett 25");
}
FUUID 5e8a00c8-f33f-f700-a2be-96dcf97272b1a38d
NAME n_Gute_Nacht
NOTIFYDEV Gute_Nacht
NR 265
NTFY_ORDER 50-n_Gute_Nacht
REGEXP Gute_Nacht:on.*
STATE 2021-01-16 23:58:41
TRIGGERTIME 1610837921.97889
TYPE notify
READINGS:
2021-01-16 15:00:23 state active
Attributes:
room Test,Wohnzimmer,notify
Das set TV off setzt mir eine Dummy auf off auf den dann wiederrum ein notify reagiert.
notify n_TV
Internals:
CFGFN ./test.cfg
DEF TV {
if (Value('Radio') eq 'off') {
fhem ('set n_Entertainment inactive;set SATReceiver $EVENT;set Receiver $EVENT;set LG_TV $EVENT');
if ($EVENT eq 'on') {
if(ReadingsVal('Receiver','power','off') eq 'off') {
fhem ('define at_Receiver_input at +00:00:05 {
fhem ("set Receiver input hdmi1;;set Receiver volume 40");;
}
');
} else {
fhem ('set Receiver input hdmi1;;set Receiver volume 40');
}
if(ReadingsVal("SATReceiver","state","off") eq "off") {
fhem ('define at_SatReceiver_input at +00:00:10 {
fhem ("set SATReceiver remoteContol exit");;
if(ReadingsVal("SATReceiver","input","radio") eq "radio") {
fhem ("set SATReceiver input tv;;set SATReceiver mute off");;
} else {
fhem ("set SATReceiver mute off");;
}
}
');
} else {
fhem ("set SATReceiver remoteContol exit;set SATReceiver mute off");
if(ReadingsVal("SATReceiver","input","radio") eq "radio") {
fhem ("set SATReceiver input tv;set SATReceiver mute off");;
}
}
} else {
fhem ('set SATReceiver $EVENT;set Receiver $EVENT;set LG_TV $EVENT');
}
} else {
fhem ("set n_Entertainment inactive;set n_TV inactive;set n_Radio inactive;set Radio off;set LG_TV on");
if(ReadingsVal("SATReceiver","input","tv") eq "radio") {
fhem ("set SATReceiver input tv");;
}
}
fhem ('define at_Entertainment_notify at +00:00:05 {
fhem ("set n_TV active;;set n_Radio active;; set n_Entertainment active");;
}
');
}
FUUID 5cbaebfb-f33f-3d5f-e8f8-72f300d40936afba
NAME n_TV
NOTIFYDEV TV
NR 254
NTFY_ORDER 50-n_TV
REGEXP TV
STATE active
TRIGGERTIME 1610837921.98459
TYPE notify
READINGS:
2021-01-17 12:38:33 state active
Attributes:
room Wohnzimmer,Test
Eigentlich kein Hexenwerk.
Ich denke es ist der LG Fernseher. Dieser ist per LAN Kabel in mein Netzwerk eingebunden.
Könnte hier ein Timing Problem in dem fhem-Modul von dem LG Fernseher sein ?
Viele Grüße
Sven
Zitat von: rudolfkoenig am 14 Januar 2021, 15:54:52
oder 4.4.4.4 (Google)
Korrektur: 8.8.8.8 oder 8.8.4.4
Hinter 4.4.4.4 liegt kein DNS-Server (Jedenfalls kein mir bekannter oder funktionierender, gerade getestet)
Habe leider meinen Link zu Beschreibungen "Große DNS-Server) verloren und nur auf die schnelle folgendes gefunden: https://www.privacy-handbuch.de/handbuch_93d.htm (https://www.privacy-handbuch.de/handbuch_93d.htm)
Hi,
den DNS habe ich auf meinen Raspi mit pi-hole gestellt und dieser reicht im Bedarfsfall an meine Unity Router weiter.
Ich denke dies sollte so passen.
Viele Grüsse
Sven
Sorry aber bitte verwende die "Code" Tags "das # im Editor".
So ist es nicht lesbar .... (Jedenfalls nicht für mich)
Aber eine Kurzanfrage: hast Du das dns-server (o.Ä.) Attribut in FHEM gesetzt?
Hi,
sorry hatte ich.
Die sind bei Copy und Paste vom Notepad++ verschwunden.
im freezemon log musst du dir die stelle anschauen, wo "log skips" steht.
das log ist zu lang und wurde deswegen abgeschnitten.
Beitraege wie diese sind unlesbar, und fuehren auf mittlere Sicht zum Ignorieren:
Bitte alles was mehr als 5 Zeilen ist, in Code-Tags packen.
Alles was mehr als 100 Zeilen sind, komprimieren, und als Anhang (siehe Erweiterte Optionen).
Letzteres ist notwendig, da ein Beitrag (ohne Anhang) hoechstens 100k (oder 1MB?) sein kann, und beide Limits sind mAn sehr grosszuegig gewaehlt. Wenn es mehr ist, dann werden die schliessenden Code-Tags abgeschnitten, und wir haben den Salat.
Ein Regex ist ein kleines und manchmal unerwartet kompliziertes Programm und kann unter Umstaenden sehr lange laufen (siehe https://www.regular-expressions.info/catastrophic.html). Es gibt dafuer kein "Timeout" in FHEM.
Hallo Rudolf,
vielen Dank.
Ich hatte hier per copy und paste mit Notepad++ gearbeitet und da ist mir die Sache um die Ohren geflogen.
Habe die unleserlichen Beträge gelöscht.
Dank dir und Grüß
Sven
Hallo,
so jetzt hat es geklappt :)
Ich weiß hier nicht mehr so richtig weiter.
Nach der Installation vom freezmon habe ich einige Aktionen gesehen die ausgeführt wurden und nicht nötig waren. Diese Probleme habe ich alle gelöst.
Die freezes sind nach wie vor vorhanden und gestern war der Hammer.
Hier hatte ich einen Ausfall um 23:25 festgestellt. Hier wollte ich mein Licht einschalten und nichts ging.
An der Homesteuerung habe ich eine LED die im 2 Sekunden Takt blinkt und wenn fhem hängt, hängt dieses logischerweise auch.
Bei der heutigen Analyse ist folgendes auffällig.
Die Feezfiles wurden um 22:36 und um 23:36 geschrieben
Laut fhem Log war der Ausfall zwischen 22:58 - 23:36.
Hier sehe ich im Freeze-Log-File von 22:59 das fhem bei regex hängen bleibt.
Aber warum im regex gibt es hier keine Timeouts ?
Zu anderen Zeiten wo fhem hängt konnte ich sowas nicht nicht beobachten.
Es lag auch der Gedanke nahe, dass der Mount von /opt/fhem/log der bei mir auf meine NAS zeigt offline war.
Dann wären ja noch log Files von fhem auf der SD-Card vom Raspi gewesen. Dies kann ich auch ausschliessen.
Heute morgen hängt fhem erneut und wieder in dem Regex von der Bundesliga Abfragen.
Diese werden ich erst einmal aussetzen und und mal schauen was hier im Regex nicht funktioniert.
Es stellt sich für mich die Frage warum fhem im Regex so lange hängt und ob hier nicht noch was anderes die Ursache ist.
Die freezes hatte ich auch wie die Bundesliga Abfrage noch ohne Probleme funktionierte.
Die Freezes in der Bundesliga Abfrage ist so heftig, dass ich hier in der config Datei von fhem die Sache deaktivieren musste.
Dies zeigt mir aber, dass dies nur ein Problem ist da dies ein neues Verhalten ist.
Hier hänge ich mal die Log-Files an. Vielleicht kann mir hier jemand einen Tipp geben wo ich noch ansetzen kann.
Fhem Log-File Ausschnitt
2021.01.29 22:58:44.533 5: in: PINGREQ: (192)(0)
2021.01.29 22:58:44.536 4: MQTT2_FHEM_Server_192.168.10.208_53679 Briefkasten PINGREQ
2021.01.29 22:58:44.538 5: out: PINGRESP: (208)(0)
2021.01.29 22:58:53.854 5: CUL_HM set BadK_Thermostat ?
2021.01.29 22:58:53.894 4: CUL_HM BadK_Thermostat dupe: dont process
2021.01.29 22:58:59.560 5: in: PINGREQ: (192)(0)
2021.01.29 22:58:59.564 4: MQTT2_FHEM_Server_192.168.10.208_53679 Briefkasten PINGREQ
2021.01.29 22:58:59.568 5: out: PINGRESP: (208)(0)
2021.01.29 23:36:11.339 1: [Freezemon] fhem_freez: possible freeze starting at 22:59:03, delay is 2228.339 possibly caused by: tmr-CODE(0x4173f08)(GetUpdate) tmr-SetExtensionsFn(N/A)
2021.01.29 23:36:11.426 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.10.208_53679/Briefkasten left us (keepalive check)
2021.01.29 23:36:23.500 1: /dev/serial/by-id/usb-busware.de_CUL868_868000-if00 disconnected, waiting to reappear (CUL_0)
2021.01.29 23:36:23.506 4: Connection accepted from MQTT2_FHEM_Server_192.168.10.208_62762
[/code]
Erster Freez-Log wo man den Freez zwischen 22:59:02 - 23:07:05 sieht
[Freezemon] fhem_freez: possible freeze starting at 22:59:03, delay is 2228.339 possibly caused by: tmr-CODE(0x4173f08)(GetUpdate) tmr-SetExtensionsFn(N/A)
2021.01.29 22:59:02.051 4: bundesligaSpieltagErgebnisse: GetUpdate called (update)
2021.01.29 22:59:02.052 4: bundesligaSpieltagErgebnisse: UpdateTimer called from GetUpdate with cmd next sets timer to call update function in 3600.0 sec at 23:59:02.051, interval 3600
setuuid
2021.01.29 22:59:02.053 5: bundesligaSpieltagErgebnisse: AddToQueue adds type update to URL https://www.kicker.de/1-bundesliga/spieltag, no data, no headers, retry 0, initial queue len: 0
2021.01.29 22:59:02.053 5: bundesligaSpieltagErgebnisse: HandleSendQueue called from AddToSendQueue, qlen = 1
2021.01.29 22:59:02.054 4: bundesligaSpieltagErgebnisse: HandleSendQueue sends update with timeout 2 to https://www.kicker.de/1-bundesliga/spieltag, No Data, No Header
2021.01.29 22:59:02.054 5: HttpUtils url=https://www.kicker.de/1-bundesliga/spieltag
2021.01.29 22:59:02.092 4: IP: www.kicker.de -> 143.204.215.109
2021.01.29 22:59:02.149 5: HttpUtils request header:
GET /1-bundesliga/spieltag HTTP/1.0
Host: www.kicker.de
User-Agent: fhem
Accept-Encoding: gzip,deflate
2021.01.29 22:59:02.355 4: https://www.kicker.de/1-bundesliga/spieltag: HTTP response code 301
2021.01.29 22:59:02.355 4: HttpUtils https://www.kicker.de/1-bundesliga/spieltag: Redirect to https://www.kicker.de:443/bundesliga/spieltag
2021.01.29 22:59:02.355 5: HttpUtils url=https://www.kicker.de:443/bundesliga/spieltag
2021.01.29 22:59:02.361 4: IP: www.kicker.de -> 143.204.215.126
2021.01.29 22:59:02.458 5: HttpUtils request header:
GET /bundesliga/spieltag HTTP/1.0
Host: www.kicker.de
User-Agent: fhem
Accept-Encoding: gzip,deflate
2021.01.29 22:59:02.642 5: Cmd: >set LED_gelb off<
2021.01.29 22:59:02.643 5: LED_gelb, in fileaccess: value 0
2021.01.29 22:59:02.646 4: DbLog logdb -> ################################################################
2021.01.29 22:59:02.646 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 22:59:02.646 4: DbLog logdb -> ################################################################
2021.01.29 22:59:02.646 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 22:59:02.647 4: DbLog logdb -> check Device: LED_gelb , Event: state: off
2021.01.29 22:59:02.650 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 22:59:02.654 5: End notify loop for LED_gelb
2021.01.29 22:59:02.946 4: https://www.kicker.de:443/bundesliga/spieltag: HTTP response code 200
2021.01.29 22:59:02.946 5: HttpUtils https://www.kicker.de:443/bundesliga/spieltag: Got data, length: 203536
2021.01.29 22:59:02.946 5: HttpUtils response header:
hier wird die http Site geladen. Habe ich herausgenommen, da es im der Voschau(forum) toll aussah aber nach dem Speichern alles in der Ansicht würfelte
2021.01.29 22:59:02.954 5: bundesligaSpieltagErgebnisse: ExtractReading spiel01 with regex /(?^:(?s)Begegnungen.*?gameRow".*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 22:59:02.956 5: bundesligaSpieltagErgebnisse: ExtractReading for reading01-1 sets spiel01-1 to VfB Stuttgart
2021.01.29 22:59:02.956 5: bundesligaSpieltagErgebnisse: ExtractReading value as hex is 56664220537475747467617274
2021.01.29 22:59:02.956 5: bundesligaSpieltagErgebnisse: ExtractReading for reading01-2 sets spiel01-2 to 2
2021.01.29 22:59:02.956 5: bundesligaSpieltagErgebnisse: ExtractReading value as hex is 32
2021.01.29 22:59:02.956 5: bundesligaSpieltagErgebnisse: ExtractReading for reading01-3 sets spiel01-3 to 0
2021.01.29 22:59:02.957 5: bundesligaSpieltagErgebnisse: ExtractReading value as hex is 30
2021.01.29 22:59:02.957 5: bundesligaSpieltagErgebnisse: ExtractReading for reading01-4 sets spiel01-4 to 1. FSV Mainz 05
2021.01.29 22:59:02.957 5: bundesligaSpieltagErgebnisse: ExtractReading value as hex is 312e20465356204d61696e7a203035
2021.01.29 22:59:02.957 5: bundesligaSpieltagErgebnisse: ExtractReading spiel02 with regex /(?^:(?s)Begegnungen.*?gameRow".*?gameRow".*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
--- log skips 482.733 secs.
2021.01.29 23:07:05.691 5: bundesligaSpieltagErgebnisse: ExtractReading spiel02 did not match
2021.01.29 23:07:05.691 5: bundesligaSpieltagErgebnisse: ExtractReading spiel03 with regex /(?^:(?s)Begegnungen.*?gameRow".*?gameRow".*?gameRow".*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
--- log skips 806.940 secs.
2021.01.29 23:20:32.631 5: bundesligaSpieltagErgebnisse: ExtractReading spiel03 did not match
2021.01.29 23:20:32.632 5: bundesligaSpieltagErgebnisse: ExtractReading spiel04 with regex /(?^:(?s)Begegnungen.*?gameRow".*?gameRow".*?gameRow".*?gameRow".*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
--- log skips 938.682 secs.
2021.01.29 23:36:11.314 5: bundesligaSpieltagErgebnisse: ExtractReading spiel04 did not match
2021.01.29 23:36:11.314 5: bundesligaSpieltagErgebnisse: ExtractReading spiel05 with regex /(?^:(?s)Begegnungen.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 23:36:11.317 5: bundesligaSpieltagErgebnisse: ExtractReading spiel05 did not match
2021.01.29 23:36:11.317 5: bundesligaSpieltagErgebnisse: ExtractReading spiel06 with regex /(?^:(?s)Begegnungen.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 23:36:11.320 5: bundesligaSpieltagErgebnisse: ExtractReading spiel06 did not match
2021.01.29 23:36:11.320 5: bundesligaSpieltagErgebnisse: ExtractReading spiel07 with regex /(?^:(?s)Begegnungen.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 23:36:11.323 5: bundesligaSpieltagErgebnisse: ExtractReading spiel07 did not match
2021.01.29 23:36:11.323 5: bundesligaSpieltagErgebnisse: ExtractReading spiel08 with regex /(?^:(?s)Begegnungen.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 23:36:11.326 5: bundesligaSpieltagErgebnisse: ExtractReading spiel08 did not match
2021.01.29 23:36:11.326 5: bundesligaSpieltagErgebnisse: ExtractReading spiel09 with regex /(?^:(?s)Begegnungen.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?Analyse.*?name">(.*?) <.*?scoreHolder__score">([0-9]?)<.*?score">([0-9]?)<.*?team__name">(.*?) <)/...
2021.01.29 23:36:11.329 5: bundesligaSpieltagErgebnisse: ExtractReading spiel09 did not match
2021.01.29 23:36:11.329 4: bundesligaSpieltagErgebnisse: Read response matched 4, unmatch 8 Reading(s)
2021.01.29 23:36:11.329 5: bundesligaSpieltagErgebnisse: Read response to update matched spiel01-1 spiel01-2 spiel01-3 spiel01-4
2021.01.29 23:36:11.329 5: bundesligaSpieltagErgebnisse: Read response to update did not match spiel02 spiel03 spiel04 spiel05 spiel06 spiel07 spiel08 spiel09
2021.01.29 23:36:11.333 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.333 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.333 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.333 4: DbLog logdb -> number of events received: 4 for device: bundesligaSpieltagErgebnisse
2021.01.29 23:36:11.333 4: DbLog logdb -> check Device: bundesligaSpieltagErgebnisse , Event: spiel01-1: VfB Stuttgart
2021.01.29 23:36:11.333 4: DbLog logdb -> check Device: bundesligaSpieltagErgebnisse , Event: spiel01-2: 2
2021.01.29 23:36:11.333 4: DbLog logdb -> check Device: bundesligaSpieltagErgebnisse , Event: spiel01-3: 0
2021.01.29 23:36:11.333 4: DbLog logdb -> check Device: bundesligaSpieltagErgebnisse , Event: spiel01-4: 1. FSV Mainz 05
2021.01.29 23:36:11.338 5: End notify loop for bundesligaSpieltagErgebnisse
2021.01.29 23:36:11.339 5: bundesligaSpieltagErgebnisse: HandleSendQueue called from ReadCallback, qlen = 0
2021.01.29 23:36:11.339 5: bundesligaSpieltagErgebnisse: HandleSendQueue found no usable entry in queue
2021.01.29 23:36:11.339 5: [Freezemon] fhem_freez: ----------- Starting Freeze handling at 2021.01.29 23:36:11.339 ---------------------
[Freezemon] fhem_freez: possible freeze starting at 22:59:03, delay is 2228.339 possibly caused by: tmr-CODE(0x4173f08)(GetUpdate) tmr-SetExtensionsFn(N/A)
Nachfolgender Freez-Log File, ein Ausschnitt. Dieser war viel zu lang
[Freezemon] fhem_freez: possible freeze starting at 23:36:12, delay is 11.624 possibly caused by: tmr-LGTV_WebOS_GetForgroundAppInfo(LG_TV) tmr-at_Exec(LED_gelb.blink) tmr-LGTV_WebOS_Get3DStatus(LG_TV) tmr-LGTV_WebOS_GetExternalInputList(LG_TV) tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-PRESENCE_StartLocalScan(Handy_Sven) tmr-FW_closeInactiveClients(N/A) tmr-MQTT::GENERIC_BRIDGE::timerProc(mqttGeneric) tmr-YAMAHA_AVR_GetStatus(Receiver) tmr-HMUARTLGW_CheckCredits(myHmUART) tmr-CODE(0x4689c70)(GetStatus) tmr-ENIGMA2_GetStatus(SATReceiver) tmr-PRESENCE_StartLocalScan(Handy_Andrea) tmr-BlockingKill(N/A) tmr-at_Exec(AT_FSD_Flur_Tuer_off) tmr-at_Exec(AT_Weihnachts_LA_off) tmr-CODE(0x4173f08)(GetUpdate) tmr-CODE(0x4173f08)(GetUpdate) tmr-PRESENCE_StartLocalScan(Cam_Weg_Instar) tmr-PRESENCE_StartLocalScan(Cam_Garten_Lupas) tmr-PRESENCE_StartLocalScan(Briefkasten_aktiv) tmr-CUL_HM_ActCheck(N/A)
2021.01.29 23:36:11.353 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_GetForgroundAppInfo: 0
2021.01.29 23:36:11.353 5: LGTV_WebOS (LG_TV) - Sending command: {"client-key":"4beb29f819bfc2a394265219319b78c7","id":"request_1611959771.3533","type":"request","uri":["ssap://com.webos.applicationManager/getForegroundAppInfo"]}
2021.01.29 23:36:11.353 4: LGTV_WebOS (LG_TV) - WriteFn called
2021.01.29 23:36:11.353 4: LGTV_WebOS (LG_TV) - þ ¤ 2K{;Q'i|\?-rW2"#b|Py9
z9{T(2xr4+~2( x1 P|8zi,;[/"#9ehG.smmz6(r5 |17~3*g"mK;e;ir|C>ejFi,;G9i;"jA*p# dcv_ew|P$s7S;pu[(am[$nTS%a~W9/~W?Fv@.gk]>n}s;pP\-o;o6
2021.01.29 23:36:11.353 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.353 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.353 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.354 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.354 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.356 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.356 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.356 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.356 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.356 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.358 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.360 5: End notify loop for LED_gelb
2021.01.29 23:36:11.360 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.362 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.362 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.362 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.362 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.362 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:05
2021.01.29 23:36:11.365 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.365 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_Get3DStatus: 0
2021.01.29 23:36:11.365 5: LGTV_WebOS (LG_TV) - Sending command: {"uri":["ssap://com.webos.service.tv.display/get3DStatus"],"client-key":"4beb29f819bfc2a394265219319b78c7","id":"request_1611959771.36535","type":"request"}
2021.01.29 23:36:11.365 4: LGTV_WebOS (LG_TV) - WriteFn called
2021.01.29 23:36:11.365 4: LGTV_WebOS (LG_TV) - þ œ 2K{;G9i;"jA*p# dcv_ew|P$s7A.ro[(e7F=.}[8puS2/~W?3]a?amG8"D icu[.nm e`q"-P.b+ -8( )fz *3 y6, z9*rb.
(7; ii}q"kW:u|A?_(z1 r7.e3/x5; it`B."#9ehG.sm6
2021.01.29 23:36:11.365 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.365 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.365 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.366 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.366 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.368 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.368 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.368 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.368 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.368 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.370 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.372 5: End notify loop for LED_gelb
2021.01.29 23:36:11.372 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.374 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.374 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.374 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.374 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.374 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:07
2021.01.29 23:36:11.377 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.377 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_GetExternalInputList: 0
2021.01.29 23:36:11.377 5: LGTV_WebOS (LG_TV) - Sending command: {"client-key":"4beb29f819bfc2a394265219319b78c7","id":"request_1611959771.37746","type":"request","uri":["ssap://tv/getExternalInputList"]}
2021.01.29 23:36:11.377 4: LGTV_WebOS (LG_TV) - WriteFn called
2021.01.29 23:36:11.377 4: LGTV_WebOS (LG_TV) - þ ‹ 2K{;Q'i|\?-rW2"#b|Py9
z9{T(2xr4+~2( x1 P|8zi,;[/"#9ehG.smmz6(r5 |17|7-i,;F2p|q"kW:u|A?"5>rpq[;A8aid/mDdg|FxmW9nx^niG?LpA?"DO
2021.01.29 23:36:11.377 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.377 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.378 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.378 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.378 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.380 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.380 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.380 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.380 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.380 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.382 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.384 5: End notify loop for LED_gelb
2021.01.29 23:36:11.384 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.386 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.386 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.386 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.386 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.386 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:09
2021.01.29 23:36:11.389 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.389 4: LGTV_WebOS (LG_TV) - run get functions
2021.01.29 23:36:11.398 4: BlockingCall (LGTV_WebOS_PresenceRun): created child (21731), uses telnetPort to connect back
2021.01.29 23:36:11.400 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_GetAudioStatus: 0
2021.01.29 23:36:11.401 5: LGTV_WebOS (LG_TV) - Sending command: {"type":"request","id":"request_1611959771.4011","client-key":"4beb29f819bfc2a394265219319b78c7","uri":["ssap://audio/getStatus"]}
2021.01.29 23:36:11.402 4: LGTV_WebOS (LG_TV) - WriteFn called
2021.01.29 23:36:11.402 4: LGTV_WebOS (LG_TV) - þ , 2K{;F2p|q"kW:u|A?"5"d;ir|C>ejF1/z9, |7( 0(i,;Q'i|\?-rW2"#b|Py9
z9{T(2xr4+~2( x1 P|8zi,;G9i;"jA*p# dalV"o6U.tJF*tlAi]d
2021.01.29 23:36:11.417 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.417 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.417 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.418 4: DbLog logdb -> number of events received: 1 for device: MQTT2_FHEM_Server
2021.01.29 23:36:11.418 4: DbLog logdb -> check Device: MQTT2_FHEM_Server , Event: nrclients: 1
2021.01.29 23:36:11.426 5: End notify loop for MQTT2_FHEM_Server
2021.01.29 23:36:11.426 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.10.208_53679/Briefkasten left us (keepalive check)
2021.01.29 23:36:11.429 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.429 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.430 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.432 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.432 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.435 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.435 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.435 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.435 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.436 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.438 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.443 5: End notify loop for LED_gelb
2021.01.29 23:36:11.443 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.447 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.447 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.447 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.447 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.447 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:11
2021.01.29 23:36:11.450 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.450 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.450 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.450 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.451 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.451 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.453 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.453 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.453 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.453 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.454 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.456 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.458 5: End notify loop for LED_gelb
2021.01.29 23:36:11.458 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.460 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.460 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.460 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.460 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.461 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:13
2021.01.29 23:36:11.463 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.463 5: PRESENCE (Handy_Sven) - stopping timer
2021.01.29 23:36:11.463 5: PRESENCE (Handy_Sven) - starting blocking call for mode lan-ping
2021.01.29 23:36:11.475 4: BlockingCall (PRESENCE_DoLocalPingScan): created child (21732), uses telnetPort to connect back
2021.01.29 23:36:11.488 4: YAMAHA_AVR (Receiver) - append to queue of device Receiver "statusRequest basicStatus": <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Basic_Status>GetParam</Basic_Status></Main_Zone></YAMAHA_AV>
2021.01.29 23:36:11.488 5: YAMAHA_AVR (Receiver) - no commands currently running, but queue has pending commands. preparing new request
2021.01.29 23:36:11.489 5: YAMAHA_AVR (Receiver) - checking cmd queue item: 0 (cmd: statusRequest, arg: basicStatus, data: 1, priority: -, at_first: 0, not_before: 0)
2021.01.29 23:36:11.489 5: YAMAHA_AVR (Receiver) - choosed item 0 as next command
2021.01.29 23:36:11.489 4: YAMAHA_AVR (Receiver) - send command "statusRequest basicStatus": <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Basic_Status>GetParam</Basic_Status></Main_Zone></YAMAHA_AV>
2021.01.29 23:36:11.490 5: HttpUtils url=http://192.168.10.46/YamahaRemoteControl/ctrl
2021.01.29 23:36:11.491 4: IP: 192.168.10.46 -> 192.168.10.46
2021.01.29 23:36:11.494 4: YAMAHA_AVR (Receiver) - append to queue of device Receiver "statusRequest partyModeStatus": <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><System><Party_Mode><Mode>GetParam</Mode></Party_Mode></System></YAMAHA_AV>
2021.01.29 23:36:11.494 4: YAMAHA_AVR (Receiver) - append to queue of device Receiver "statusRequest toneStatus": <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Sound_Video><Tone><Bass>GetParam</Bass></Tone></Sound_Video></Main_Zone></YAMAHA_AV>
2021.01.29 23:36:11.494 4: YAMAHA_AVR (Receiver) - append to queue of device Receiver "statusRequest toneStatus": <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Sound_Video><Tone><Treble>GetParam</Treble></Tone></Sound_Video></Main_Zone></YAMAHA_AV>
2021.01.29 23:36:11.495 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.496 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.497 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.499 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.500 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.508 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.508 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.508 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.508 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.508 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.513 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.519 5: End notify loop for LED_gelb
2021.01.29 23:36:11.519 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.523 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.523 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.523 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.523 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.523 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:15
2021.01.29 23:36:11.526 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.526 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.526 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.526 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.527 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.527 5: LED_gelb, in fileaccess: value 1
2021.01.29 23:36:11.529 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.530 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.530 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.530 4: DbLog logdb -> number of events received: 1 for device: LED_gelb
2021.01.29 23:36:11.530 4: DbLog logdb -> check Device: LED_gelb , Event: state: on
2021.01.29 23:36:11.532 5: wird an setextensions gesendet: LED_gelb ?
2021.01.29 23:36:11.534 5: End notify loop for LED_gelb
2021.01.29 23:36:11.535 5: redefine at command LED_gelb.blink as +*00:00:02 set LED_gelb on-for-timer 1
2021.01.29 23:36:11.537 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.537 4: DbLog logdb -> ### start of new Logcycle ###
2021.01.29 23:36:11.537 4: DbLog logdb -> ################################################################
2021.01.29 23:36:11.537 4: DbLog logdb -> number of events received: 1 for device: LED_gelb.blink
2021.01.29 23:36:11.537 4: DbLog logdb -> check Device: LED_gelb.blink , Event: state: Next: 22:59:17
2021.01.29 23:36:11.540 5: End notify loop for LED_gelb.blink
2021.01.29 23:36:11.540 5: HMUARTLGW myHmUART checking credits (from timer)
2021.01.29 23:36:11.540 5: HMUARTLGW myHmUART send: 00 08
2021.01.29 23:36:11.541 5: HMUARTLGW myHmUART send: (8): fd0003001d08d633
2021.01.29 23:36:11.541 5: SW: fd0003001d08d633
2021.01.29 23:36:11.542 5: exec at command LED_gelb.blink
2021.01.29 23:36:11.542 5: Cmd: >set LED_gelb on-for-timer 1<
2021.01.29 23:36:11.543 5: wird an setextensions gesendet: LED_gelb on-for-timer 1
2021.01.29 23:36:11.543 5: Cmd: >set LED_gelb on<
2021.01.29 23:36:11.544 5: LED_gelb, in fileaccess: value 1
Vielen Dank, dass ihr hier drüberschaut.
Sven
Es schaut so aus, das deine Vermutung mit dem Regex richtig ist, und der Fall eintritt, das in dem vom mir verlinkten Artikel genauer beschrieben wird.
Ich wuerde versuchen die Daten erst mit einer anderen Methode zu extrahieren, oder wenn das nicht geht, die Regexps optimieren, auch mit Hilfe der im verlinkten Artikel beschriebenen Mittel bzw Webseiten.
Hallo,
fhem läuft nun bei mir seit geraumer Zeit wieder stabil nachdem ich die RegEx alle mal auf Eis gelegt habe.
Ich werde nun langsam wieder damit anfangen Stück für Stück zu aktivieren und einige RegEx überarbeiten.
Vielen Dank euch allen für die Hilfe und Grüße
Sven