[gelöst]configdb + mysql weiterhin keine state Infos mehr nach Neustart

Begonnen von persching, 26 März 2022, 10:19:43

Vorheriges Thema - Nächstes Thema

persching

Hallo,
ich hab schon gelesen, dass durch ein Update die states irgendwie in die Datenbank übertragen werden sollten. Bei mir ist es aber immer noch so, dass z.B. der Status der ROOMMATE nicht gespeichert werden. Oder auch von den dummys fehlen die States. :(
Es wird wohl eine Datei in die ConfigDB geschrieben, wie man an den beiden angehängten Bildschirmfotos erkennen kann. Das eine von 10.04.06 ist vor einem "save config", das andere danach. Ich habe auch "attr global verbose 4" eingestellt, aber weiß nicht nach was ich jetzt suchen soll. Die Datei ist riesig (5,1 MB) und hat ganz viele Infos... Gibt es ein Stichwort nachdem ich suchen soll?

Gruß persching

betateilchen

Zu wenige Infos, um Dir wirklich helfen zu können.

Wenn Du ein shutdown restart ausführst und verbose=4 schon eingestellt ist, sollten kurz vor dem shutdown und kurz nach dem restart Meldungen von configDB im Log stehen. Diese Meldungen wären der erste Ansatzpunkt für eine Diagnose.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Hier mal der Logauszug:

2022.03.26 10:04:44.427 0: Server shutdown
2022.03.26 10:04:44.430 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.434 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.444 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.449 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.457 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.462 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.470 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.475 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.483 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.488 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.497 4: configDB reading file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.502 4: configDB writing file: ./FHEM/FhemUtils/cacheDbRep
2022.03.26 10:04:44.516 4: DbLog logdb -> ################################################################
2022.03.26 10:04:44.517 4: DbLog logdb -> ###              start of new Logcycle                       ###
2022.03.26 10:04:44.517 4: DbLog logdb -> ################################################################
2022.03.26 10:04:44.517 4: DbLog logdb -> number of events received: 1 of device: FHEM_MQTT_Client
2022.03.26 10:04:44.517 4: DbLog logdb -> check Device: FHEM_MQTT_Client , Event: state: disconnected
2022.03.26 10:04:44.517 4: DbLog logdb -> added event - Timestamp: 2022-03-26 10:04:44, Device: FHEM_MQTT_Client, Type: MQTT2_CLIENT, Event: state: disconnected, Reading: state, Value: disconnected, Unit:
2022.03.26 10:04:44.518 4: n_publish_mqtt exec {
my $mqttRoom = AttrVal($NAME, 'mqttRoom', '');;
    my $mqttName = AttrVal($NAME, 'mqttName', '');;

    if ($mqttRoom ne '' && $mqttName ne '') {
        my $reading = "";;
        my $message = "";;

        if ($EVENT =~ qr/(.*?): (.*)/p) {
            $reading = $1;;
            $message = $2;;
        } else {
            $reading = "state";;
            $message = $EVENT;;
        }

        my $topic = "SmartHome/$mqttRoom/$mqttName/$reading";;

        fhem("set Mosquitto publish $topic $message");;
    }}
2022.03.26 10:04:44.524 4: DbLog logdb -> ################################################################
2022.03.26 10:04:44.525 4: DbLog logdb -> ###              start of new Logcycle                       ###
2022.03.26 10:04:44.525 4: DbLog logdb -> ################################################################
2022.03.26 10:04:44.525 4: DbLog logdb -> number of events received: 2 of device: Mosquitto
2022.03.26 10:04:44.525 4: DbLog logdb -> check Device: Mosquitto , Event: connection: disconnected
2022.03.26 10:04:44.525 4: DbLog logdb -> check Device: Mosquitto , Event: state: disconnected
2022.03.26 10:04:44.525 4: n_publish_mqtt exec {
my $mqttRoom = AttrVal($NAME, 'mqttRoom', '');;
    my $mqttName = AttrVal($NAME, 'mqttName', '');;

    if ($mqttRoom ne '' && $mqttName ne '') {
        my $reading = "";;
        my $message = "";;

        if ($EVENT =~ qr/(.*?): (.*)/p) {
            $reading = $1;;
            $message = $2;;
        } else {
            $reading = "state";;
            $message = $EVENT;;
        }

        my $topic = "SmartHome/$mqttRoom/$mqttName/$reading";;

        fhem("set Mosquitto publish $topic $message");;
    }}
2022.03.26 10:04:44.526 4: n_publish_mqtt exec {
my $mqttRoom = AttrVal($NAME, 'mqttRoom', '');;
    my $mqttName = AttrVal($NAME, 'mqttName', '');;

    if ($mqttRoom ne '' && $mqttName ne '') {
        my $reading = "";;
        my $message = "";;

        if ($EVENT =~ qr/(.*?): (.*)/p) {
            $reading = $1;;
            $message = $2;;
        } else {
            $reading = "state";;
            $message = $EVENT;;
        }

        my $topic = "SmartHome/$mqttRoom/$mqttName/$reading";;

        fhem("set Mosquitto publish $topic $message");;
    }}
2022.03.26 10:04:44.528 1: Shutdown executed
2022.03.26 10:04:44.537 4: configDB writing file: ./log/eventTypes.txt
2022.03.26 10:04:44.587 4: configDB save state 387bb23e494904e7f2a9cdfe53581927.fhem.save with 3884 entries
2022.03.26 10:04:44.588 4: configDB writing file: 387bb23e494904e7f2a9cdfe53581927.fhem.save
2022.03.26 10:04:47.845 3: From the FHEM_GLOBALATTR environment: attr global logfile ./log/fhem-%Y-%m-%d.log
2022.03.26 10:04:47.845 3: From the FHEM_GLOBALATTR environment: attr global pidfilename ./log/fhem.pid
2022.03.26 10:04:47.846 3: From the FHEM_GLOBALATTR environment: attr global updateInBackground 1
2022.03.26 10:04:47.846 3: From the FHEM_GLOBALATTR environment: attr global nofork 0
2022.03.26 10:04:47.853 4: configDB read config 387bb23e494904e7f2a9cdfe53581927
2022.03.26 10:04:47.886 4: configDB reading file: 387bb23e494904e7f2a9cdfe53581927.fhem.save
2022.03.26 10:04:47.891 4: configDB read state 387bb23e494904e7f2a9cdfe53581927.fhem.save
2022.03.26 10:04:47.921 4: configDB reading file: ./FHEM/FhemUtils/uniqueID
2022.03.26 10:04:47.927 3: telnetPort: port 7072 opened
2022.03.26 10:04:48.098 3: web: port 8083 opened
2022.03.26 10:04:48.117 3: WEBtablet: port 8082 opened
2022.03.26 10:04:48.138 4: configDB reading file: ./log/eventTypes.txt
2022.03.26 10:04:48.164 2: eventTypes: loaded 997 lines from ./log/eventTypes.txt
2022.03.26 10:04:48.184 3: Opening CUL_0 device /dev/virtual_CUL
2022.03.26 10:04:48.206 3: Setting CUL_0 serial parameters to 9600,8,N,1
2022.03.26 10:04:48.312 3: CUL_0: Possible commands: ABbCEeFGiKklMmNRTtUuVWXxYZ
2022.03.26 10:04:48.317 3: CUL_0 device opened
2022.03.26 10:04:48.323 2: Switched CUL_0 rfmode to MAX
2022.03.26 10:04:48.360 1: HMLAN_Parse: HMLAN1 new condition disconnected
2022.03.26 10:04:48.664 4: https://dtd9NP9xBN0KDT3P5m7eB28N5kVIDYjw:%20@api.pushbullet.com/v2/users/me: HTTP response code 200
2022.03.26 10:04:48.664 4: FHEM -> Pushbullet.com:
2022.03.26 10:04:48.665 4: Pushbullet.com -> FHEM: {"active":true,"iden":"ujCBFbNV9Xw","created":1431508562.093194,"modified":1643972693.0944939,"email":"persching1978@gmail.com","email_normalized":"persching1978@gmail.com","name":"Dirk Braun","image_url":"https://static.pushbullet.com/google-user/8607a131bf526424505f4721e24d6decba78edb43dad85af1da36fa1c6477dd3","max_upload_size":26214400}
2022.03.26 10:04:49.183 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.194 3: HourCounter HourCounter Initialize.220 Init Done with Version 1.0.1.2 - 24.12.2014
2022.03.26 10:04:49.195 0: HourCounter EG_Bad_Fensterkontakt_HC Define.228 parameters: EG_Bad_Fensterkontakt_HC HourCounter EG_Bad_Fensterkontakt:onoff:.1 EG_Bad_Fensterkontakt:onoff:.0
2022.03.26 10:04:49.258 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.262 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.266 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.271 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.276 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.280 0: HourCounter EG_WoZi_Fensterkontakt_HC Define.228 parameters: EG_WoZi_Fensterkontakt_HC HourCounter EG_WoZi_Fensterkontakt:onoff:.1 EG_WoZi_Fensterkontakt:onoff:.0
2022.03.26 10:04:49.281 0: HourCounter KACHELOFEN_HC Define.228 parameters: KACHELOFEN_HC HourCounter Kachelofen_dummy:an Kachelofen_dummy:aus
2022.03.26 10:04:49.296 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.304 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.335 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.339 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.343 4: Looking for SVN Id in module 98_DOIF.pm
2022.03.26 10:04:49.346 0: HourCounter OG_Bad_Fensterkontakt_HC Define.228


Was mir auffällt:

2022.03.26 10:04:44.528 1: Shutdown executed

2022.03.26 10:04:44.537 4: configDB writing file: ./log/eventTypes.txt
2022.03.26 10:04:44.587 4: configDB save state 387bb23e494904e7f2a9cdfe53581927.fhem.save with 3884 entries
2022.03.26 10:04:44.588 4: configDB writing file: 387bb23e494904e7f2a9cdfe53581927.fhem.save

2022.03.26 10:04:47.853 4: configDB read config 387bb23e494904e7f2a9cdfe53581927
2022.03.26 10:04:47.886 4: configDB reading file: 387bb23e494904e7f2a9cdfe53581927.fhem.save
2022.03.26 10:04:47.891 4: configDB read state 387bb23e494904e7f2a9cdfe53581927.fhem.save

Ich lese das so, dass erst der Shutdown ausgeführt wird, dann wird das File geschrieben und danach dasselbe wieder eingelesen... Wäre nicht die Reihenfolge
- writing file
- shutdown
- reading file

??

betateilchen

Zitat von: persching am 27 März 2022, 13:39:46
Ich lese das so, dass erst der Shutdown ausgeführt wird, dann wird das File geschrieben und danach dasselbe wieder eingelesen...

Das ist schon alles ok so, Du interpretierst die Meldungen lediglich falsch.

"shutdown executed" bedeutet nicht, dass der shutdown abgeschlossen ist, sondern dass dieser gerade ausgeführt wird. Und das Schreiben des statefile ist fester Bestandteil des shutdown.




Zurück zum eigentlichen Thema:


2022.03.26 10:04:44.587 4: configDB save state 387bb23e494904e7f2a9cdfe53581927.fhem.save with 3884 entries
2022.03.26 10:04:47.853 4: configDB read config 387bb23e494904e7f2a9cdfe53581927
2022.03.26 10:04:47.891 4: configDB read state 387bb23e494904e7f2a9cdfe53581927.fhem.save


Das ist exakt das zu erwartende korrekte Verhalten. Da hier keine Probleme erkennbar sind (keine Fehlermeldungen o.ä.) muss man davon ausgehen, dass sämtliche readings korrekt weggeschrieben wurden.

Zitat von: persching am 26 März 2022, 10:19:43
Bei mir ist es aber immer noch so, dass z.B. der Status der ROOMMATE nicht gespeichert werden.
Oder auch von den dummys fehlen die States.

Was steht denn bei den devices, die nicht korrekt gespeichert werden, in deren readings?
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Alle betroffenen Devices zeigen bei "STATE" ??? an. Irgendwelche Folgedevices wie DOIF oder so haben dann das Problem, dass sie damit nix anfangen können.

Hier bspw. mein Roommate Device:

Internals:
   DEF        Familie
   DURATIONTIMER 1648396826.27701
   FUUID      5c49a06d-f33f-e65d-a26b-77f75689c1c10583
   FVERSION   20_ROOMMATE.pm:0.195330/2019-06-02
   NAME       rr_Dirk
   NOTIFYDEV  global,DirkPresence
   NR         155
   NTFY_ORDER 50-rr_Dirk
   READY      1
   RESIDENTGROUPS Familie
   STATE      ???
   SUBTYPE    adult
   TYPE       ROOMMATE
   READINGS:
     2022-03-27 17:59:26   durTimerAbsence 00:00:00
     2022-03-27 17:59:26   durTimerAbsence_cr 0
     2022-03-27 17:59:26   durTimerPresence 00:00:00
     2022-03-27 17:59:26   durTimerPresence_cr 0
     2022-03-27 17:59:26   durTimerSleep   00:00:00
     2022-03-27 17:59:26   durTimerSleep_cr 0
   TIMER:
     rr_Dirk_DurationTimer:
       HASH       rr_Dirk
       MODIFIER   DurationTimer
       NAME       rr_Dirk_DurationTimer
Attributes:
   DbLogExclude .*
   alias      Dirk
   devStateIcon .*zuhause:user_available:absent .*anwesend:user_available:absent .*abwesend:user_away:home .*verreist:user_ext_away:home .*bettfertig:scene_toilet:asleep .*schlaeft:scene_sleeping:awoken .*schläft:scene_sleeping:awoken .*aufgestanden:scene_sleeping_alternat:home .*:user_unknown:home
   eventMap   home:zuhause absent:abwesend gone:verreist gotosleep:bettfertig asleep:schläft awoken:aufgestanden
   group      Bewohner
   icon       people_sensor
   room       Anwesenheit
   rr_autoGoneAfter 24
   rr_presenceDevices DirkPresence
   rr_realname alias
   sortby     1
   webCmd     state
   widgetOverride state:zuhause,bettfertig,schläft,aufgestanden,abwesend,verreist


Oder ein Dummy mit dem ich verschiedene Profile für die Weekdaytimer meiner Heizung vorwähle:
Internals:
   FUUID      5c49a04e-f33f-e65d-9177-595fb16e43fd3aec
   FVERSION   98_dummy.pm:0.256060/2022-02-01
   NAME       WDT_Badezimmer_Profile
   NR         71
   STATE      ???
   TYPE       dummy
Attributes:
   alias      Bad
   devStateIcon . Auto:sani_heating_automatic@lightgreen . Minimal:sani_heating_level_50@orange . Aus:sani_heating_level_0@lightblue . Manuell:time_manual_mode
   group      Profile
   icon       rc_SETUP
   mqttName   HCProfile
   mqttRoom   Bad
   room       Heizung->Thermostate,Obergeschoss->Badezimmer
   setList    state:Auto,Manuell,Minimal,Aus
   webCmd     state

betateilchen

Sorge doch mal dafür, dass die devices einen gültigen STATE bekommen. Und wenn das passiert ist, machst Du ein save config und einen shutdown restart.

Da die devices kein reading "state" haben und es auch kein Attribut "stateFormat" gibt, frage ich mich gerade, wo der Wert für das Internal  STATE herkommen soll. Ein Wert mit ??? wird jedenfalls nicht gespeichert.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Das habe ich eben gemacht bevor ich das LIST hier gepostet habe. Und genau dann hatte ich den geposteten Zustand. :(

betateilchen

Zitat von: persching am 27 März 2022, 18:10:44
Das habe ich eben gemacht bevor ich das LIST hier gepostet habe. Und genau dann hatte ich den geposteten Zustand. :(

Wie hast Du das gemacht? Wie kommen die Werte in das internal STATE? Und was steht dann da drin?

Mit verbose=5 kannst Du Dir im Logfile genau anschauen, was zu einem bestimmten device abgespeichert wird. Schau doch mal nach, ob da bei den betroffenen devices irgendwelche Auffälligkeiten im Log stehen.

Offenbar ist es ja so, dass nur bestimmte devices von dem Problem betroffen sind und nicht alle. Und die configDB interessiert sich beim Speichern grundsätzlich nicht dafür, um welchen device-TYPE es sich handelt.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Die Devices die größtenteils davon betroffen sind haben alle ein webcmd über die ich dann das Initialisieren auf den neuen Wert mache. Ich hatte bspw. wieder mein Roommate-Device auf "zuhause" initialisiert, dann gespeichert und ein shutdown-restart gemacht. Im Logfile steht dann dazu das hier:

2022.03.27 20:16:42.458 5: configDB: setstate rr_Dirk zuhause
2022.03.27 20:16:42.458 5: configDB: setstate rr_Dirk 2022-03-27 19:50:36 durTimerAbsence 00:00:00
2022.03.27 20:16:42.458 5: configDB: setstate rr_Dirk 2022-03-27 19:50:36 durTimerAbsence_cr 0
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 20:15:47 durTimerPresence 00:25:02
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 20:15:47 durTimerPresence_cr 25
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:36 durTimerSleep 00:00:00
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:36 durTimerSleep_cr 0
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:45 lastArrival 2022-03-27 19:50:45
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:45 lastLocation undefined
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:47 lastMood sleepy
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:47 lastState gotosleep
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:45 location home
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:47 mood calm
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:45 presence present
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:47 state home
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:45 wayhome 0
.
.
.
.
2022.03.27 20:16:42.462 4: configDB save state 4359c58e3b22efd00cfc65b022a335fd.fhem.save with 3778 entries
2022.03.27 20:16:42.464 4: configDB writing file: 4359c58e3b22efd00cfc65b022a335fd.fhem.save
2022.03.27 20:16:42.464 4: DbLog logdb -> 181 of 181 events updated in table current
2022.03.27 20:16:42.471 4: DbLog logdb -> insert / update table current committed by autocommit
2022.03.27 20:16:42.471 5: DbLog logdb -> DbLog_PushAsync finished
2022.03.27 20:16:42.487 4: configDB save config 4359c58e3b22efd00cfc65b022a335fd
2022.03.27 20:16:43.675 4: configDB reorg started, keeping last 5 versions.
2022.03.27 20:16:44.381 5: configDB: statefile  filename >7a10db4cc89094f18bd8bdff14c8038c.fhem.save<
2022.03.27 20:16:44.381 5: configDB: statefile uuid:  >7a10db4cc89094f18bd8bdff14c8038c<
2022.03.27 20:16:44.382 5: configDB: statefile found: >notfound<
2022.03.27 20:16:44.382 5: configDB: statefile del2 >7a10db4cc89094f18bd8bdff14c8038c.fhem.save<
2022.03.27 20:16:44.383 5: configDB: statefile  filename >2fbabab8a1f632ae4ba41700722491b1.fhem.save<
2022.03.27 20:16:44.383 5: configDB: statefile uuid:  >2fbabab8a1f632ae4ba41700722491b1<
2022.03.27 20:16:44.384 5: configDB: statefile found: >2fbabab8a1f632ae4ba41700722491b1<
2022.03.27 20:16:44.384 5: configDB: statefile  filename >c937cd3ae3a56666303e938f92a3f84f.fhem.save<
2022.03.27 20:16:44.384 5: configDB: statefile uuid:  >c937cd3ae3a56666303e938f92a3f84f<
2022.03.27 20:16:44.385 5: configDB: statefile found: >c937cd3ae3a56666303e938f92a3f84f<
2022.03.27 20:16:44.385 5: configDB: statefile  filename >d96472fd956ef3f81b9081c4e8b61888.fhem.save<
2022.03.27 20:16:44.385 5: configDB: statefile uuid:  >d96472fd956ef3f81b9081c4e8b61888<
2022.03.27 20:16:44.386 5: configDB: statefile found: >d96472fd956ef3f81b9081c4e8b61888<
2022.03.27 20:16:44.386 5: configDB: statefile  filename >197f32165ff56260b052ece83e333809.fhem.save<
2022.03.27 20:16:44.387 5: configDB: statefile uuid:  >197f32165ff56260b052ece83e333809<
2022.03.27 20:16:44.387 5: configDB: statefile found: >197f32165ff56260b052ece83e333809<
2022.03.27 20:16:44.387 5: configDB: statefile  filename >f2be268de034f0ed95600ae7f6049aca.fhem.save<
2022.03.27 20:16:44.388 5: configDB: statefile uuid:  >f2be268de034f0ed95600ae7f6049aca<
2022.03.27 20:16:44.388 5: configDB: statefile found: >f2be268de034f0ed95600ae7f6049aca<
2022.03.27 20:16:44.389 5: configDB: statefile  filename >4359c58e3b22efd00cfc65b022a335fd.fhem.save<
2022.03.27 20:16:44.389 5: configDB: statefile uuid:  >4359c58e3b22efd00cfc65b022a335fd<
2022.03.27 20:16:44.389 5: configDB: statefile found: >4359c58e3b22efd00cfc65b022a335fd<
.
.
.
.
2022.03.27 20:17:13.273 5: Initializing Type Library:
2022.03.27 20:17:13.278 4: configDB read config 4359c58e3b22efd00cfc65b022a335fd
2022.03.27 20:17:13.311 4: configDB reading file: 4359c58e3b22efd00cfc65b022a335fd.fhem.save
2022.03.27 20:17:13.317 4: configDB read state 4359c58e3b22efd00cfc65b022a335fd.fhem.save
.
.
.
.
2022.03.27 20:17:33.751 4: ROOMMATE rr_Dirk: device initialization completed




Bei dem letzten Eintrag bin ich mir nicht sicher, ob das wirklich zum Zurück lesen der Datei gehört. So richtig wie beim Schreiben finde ich das nämlich nicht. Ich habe jetzt das Logfile nach "rr_Dirk" durchsucht und finde eben nur, dass scheinbar der Wert in eine Datei geschrieben wird. Die selbe Datei wird auch wieder eingelesen. Aber ich finde eben die Zuordnung nicht... aber bei global verbose 5 bin ich beim Logfile für heute schon bei 14 MB. Und 5 hatte ich nur immer kurz eingestellt.

Steht es denn genauso wie der Eintrag in die Datei auch beim Auslesen aus der Datei im Logfile?




betateilchen

Zitat von: persching am 27 März 2022, 20:56:15
2022.03.27 20:16:42.459 5: configDB: setstate rr_Dirk 2022-03-27 19:50:47 state home

Da wird jedenfalls das reading state korrekt in das statefile geschrieben.
Interessant wäre jetzt noch die Suche im Logfile beim restart, da muss es eine zugehörige Zeile geben, mit der das reading wieder geschrieben wird.

Zitat von: persching am 27 März 2022, 20:56:15
Die Devices die größtenteils davon betroffen sind haben alle ein webcmd über die ich dann das Initialisieren auf den neuen Wert mache.

Das muss ich nicht verstehen.

Aber ein Fehlverhalten der configDB kann ich nach wie vor nicht erkennen, zumal jetzt der Nachweis erbracht ist, dass die gesuchten Werte korrekt im statefile landen. Mit ziemlicher Sicherheit werden die Werte beim Einlesen auch wieder korrekt gesetzt. Vielleicht wird der Wert während des FHEM Starts durch irgendwas überschrieben. Keine Ahnung, wie/ob Dein webCmd das irgendwie beeinflussen kann.

Zitat von: persching am 27 März 2022, 20:56:15
aber bei global verbose 5 bin ich beim Logfile für heute schon bei 14 MB. Und 5 hatte ich nur immer kurz eingestellt.

Was ist denn das für eine Argumentation? Entweder, man nutzt das Logfile dazu, einem Fehler auf die Spur zu kommen oder man nutzt es halt nicht. Aber ohne Input auch kein Output. Will heißen: Wenn Du mir nicht sagst, was in Deinem Logfile geschrieben steht, kann ich Dir auch nicht helfen, herauszufinden, was da schiefläuft. Mit Hellsehen kommen wir jedenfalls nicht weiter.

Man kann ein Logfile mit "set Logfile clear" einfach leeren, bevor man "shutdown restart" macht, dann reduziert sich der Inhalt und die Größe beachtlich und auch die Suche wird erleichtert.
Oder man stellt das Logfile für die Zeit der Suche mal auf Stunden-Log um, dann bekommt man auch kleinere Dateien.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Zitat von: betateilchen am 28 März 2022, 14:28:48
Da wird jedenfalls das reading state korrekt in das statefile geschrieben.
Interessant wäre jetzt noch die Suche im Logfile beim restart, da muss es eine zugehörige Zeile geben, mit der das reading wieder geschrieben wird.

Genau danach hab ich gestern in dem riesigen Logfile über 1 Stunde lang gesucht und keine Zeile gefunden.


Zitat
Das muss ich nicht verstehen.

Ok, das war wirklich vielleicht nicht die beste Ausdrucksweise, ich versuche es noch einmal: Mein rr_Dirk sieht nach dem "shutdown restart" so aus wie im Screenshot 19.44.31.png

Wenn ich dann ein list rr_Dirk mache, dann bekomme ich folgendes:

Internals:
   DEF        Familie
   DURATIONTIMER 1648489486.59207
   FUUID      5c49a06d-f33f-e65d-a26b-77f75689c1c10583
   FVERSION   20_ROOMMATE.pm:0.195330/2019-06-02
   NAME       rr_Dirk
   NOTIFYDEV  global,DirkPresence
   NR         155
   NTFY_ORDER 50-rr_Dirk
   READY      1
   RESIDENTGROUPS Familie
   STATE      ???
   SUBTYPE    adult
   TYPE       ROOMMATE
   Helper:
     DBLOG:
       durTimerAbsence:
         logdb:
           TIME       1648489426.60489
           VALUE      00:00:00
       durTimerAbsence_cr:
         logdb:
           TIME       1648489426.60489
           VALUE      0
       durTimerPresence:
         logdb:
           TIME       1648489426.60489
           VALUE      00:00:00
       durTimerPresence_cr:
         logdb:
           TIME       1648489426.60489
           VALUE      0
       durTimerSleep:
         logdb:
           TIME       1648489426.60489
           VALUE      00:00:00
       durTimerSleep_cr:
         logdb:
           TIME       1648489426.60489
           VALUE      0
   READINGS:
     2022-03-28 19:43:46   durTimerAbsence 00:00:00
     2022-03-28 19:43:46   durTimerAbsence_cr 0
     2022-03-28 19:43:46   durTimerPresence 00:00:00
     2022-03-28 19:43:46   durTimerPresence_cr 0
     2022-03-28 19:43:46   durTimerSleep   00:00:00
     2022-03-28 19:43:46   durTimerSleep_cr 0
   TIMER:
     rr_Dirk_DurationTimer:
       HASH       rr_Dirk
       MODIFIER   DurationTimer
       NAME       rr_Dirk_DurationTimer
Attributes:
   alias      Dirk
   devStateIcon .*zuhause:user_available:absent .*anwesend:user_available:absent .*abwesend:user_away:home .*verreist:user_ext_away:home .*bettfertig:scene_toilet:asleep .*schlaeft:scene_sleeping:awoken .*schläft:scene_sleeping:awoken .*aufgestanden:scene_sleeping_alternat:home .*:user_unknown:home
   eventMap   home:zuhause absent:abwesend gone:verreist gotosleep:bettfertig asleep:schläft awoken:aufgestanden
   group      Bewohner
   icon       people_sensor
   room       Anwesenheit
   rr_autoGoneAfter 24
   rr_presenceDevices DirkPresence
   rr_realname alias
   sortby     1
   webCmd     state
   widgetOverride state:zuhause,bettfertig,schläft,aufgestanden,abwesend,verreist


Also STATE = ???

Nun wähle ich über das Pulldown-Menü z.B. "Abwesend" aus (siehe 19.50.20.png) und danach wieder "Zuhause".

Zitat
Aber ein Fehlverhalten der configDB kann ich nach wie vor nicht erkennen, zumal jetzt der Nachweis erbracht ist, dass die gesuchten Werte korrekt im statefile landen. Mit ziemlicher Sicherheit werden die Werte beim Einlesen auch wieder korrekt gesetzt. Vielleicht wird der Wert während des FHEM Starts durch irgendwas überschrieben. Keine Ahnung, wie/ob Dein webCmd das irgendwie beeinflussen kann.

Was ist denn das für eine Argumentation? Entweder, man nutzt das Logfile dazu, einem Fehler auf die Spur zu kommen oder man nutzt es halt nicht. Aber ohne Input auch kein Output. Will heißen: Wenn Du mir nicht sagst, was in Deinem Logfile geschrieben steht, kann ich Dir auch nicht helfen, herauszufinden, was da schiefläuft. Mit Hellsehen kommen wir jedenfalls nicht weiter.

Es ist nicht so, dass ich nicht versuche zu verstehen, was hier passiert bzw. was schiefläuft oder gar dass ich dir nicht sagen möchte, was dort steht. Ich (und vermutlich auch du) möchte hier kein Megalogfile posten. Wenn es notwendig ist, dann kann ich es gerne zur Verfügung stellen.

Ich denke, mir fehlt der Suchbegriff. Aber ich habe jetzt ein "set Logfile clear" gemacht. Und habe jetzt für einen Zeitraum von 8 Minuten um den restart rund 171.000 Logzeilen. Die habe ich jetzt wieder versucht zu durchsuchen, aber ich finde zwar, dass das statefile erst geschrieben und dann gelesen wird, aber ich finde nichts wo die Werte aus dem File zugewiesen werden.

Wie würde denn ungefähr der Logeintrag aussehen, der dem Device rr_Dirk aus dem gespeicherten File wieder den Wert zuweist? Oder anders gefragt: was ist der "Gegenspieler" zum Eintrag

configDB: setstate rr_Dirk zuhause

??

Zitat
Man kann ein Logfile mit "set Logfile clear" einfach leeren, bevor man "shutdown restart" macht, dann reduziert sich der Inhalt und die Größe beachtlich und auch die Suche wird erleichtert.
Oder man stellt das Logfile für die Zeit der Suche mal auf Stunden-Log um, dann bekommt man auch kleinere Dateien.

betateilchen

Zitat von: persching am 28 März 2022, 20:34:54
Wie würde denn ungefähr der Logeintrag aussehen, der dem Device rr_Dirk aus dem gespeicherten File wieder den Wert zuweist? Oder anders gefragt: was ist der "Gegenspieler" zum Eintrag

Ich habe Dein device jetzt mit einem dummy nachgebaut


defmod test_dummy dummy
attr test_dummy webCmd state
attr test_dummy widgetOverride state:zuhause,bettfertig,schläft,aufgestanden,abwesend,verreist


dann habe ich mit der dropdown-Liste auf "bettfertig" eingestellt und bei einem "shutdown restart" passiert folgendes:



Einträge beim shutdown - hier werden die Werte in das statefile geschrieben:
2022.03.29 11:01:09 5: configDB: setstate test_dummy bettfertig
2022.03.29 11:01:09 5: configDB: setstate test_dummy 2022-03-29 11:00:37 state bettfertig

Einträge beim restart - hier werden die aus dem statefile gelesenen Werte wieder in das device geschrieben:
2022.03.29 11:01:16 5: Cmd: >setstate test_dummy bettfertig<
2022.03.29 11:01:16 5: Cmd: >setstate test_dummy 2022-03-29 11:00:37 state bettfertig<


und im device ist nach dem Neustart alles wieder wie vorher. Einen Fehler seitens der configDB kann ich nach wie vor nicht feststellen.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Ich weiß nicht, was schiefläuft, aber hier mal ein paar Infos, was mir mein Logfile relativ schnell liefert:

Suchbegriff "configDB: setstate" -> 8282 Treffer und die Anfangsbuchstaben der Devices gehen von A-Z. Wobei das 2x speichern beinhalten müsste... also nehmen wir die Hälfte, was immer noch 4141 Treffer sind.

Suchbegriff "Cmd: >setstate" -> 629 Treffer und die Anfangsbuchstaben der Devices gehen von A-F. Der letzte Treffer zu dem Begriff steht in Zeile 16201 von insgesamt 171.413 Zeilen -> daraus schließe ich, dass es nicht daran liegt, dass ich zu früh das Logfile abgezogen habe.

Ich denke, irgendetwas bricht das Einlesen der states ab. Und dieses Problem hatte ich vor der Umstellung definitiv nicht. Du sagst immer, du kannst keine Fehlfunktion finden, aber irgendwas funktioniert ja scheinbar nicht.

betateilchen

#13
Zitat von: persching am 29 März 2022, 19:31:33
Ich denke, irgendetwas bricht das Einlesen der states ab. Und dieses Problem hatte ich vor der Umstellung definitiv nicht. Du sagst immer, du kannst keine Fehlfunktion finden, aber irgendwas funktioniert ja scheinbar nicht.

Langsam... grundsätzlich bestreite ich nicht, dass da bei Dir was schiefläuft.
Was ich nur sage, ist dass ich keine Fehlfunktion innerhalb der configDB erkennen kann. Dazu stehe ich nach wie vor. Zumal Du offenbar der Einzige bist, bei dem das Problem besteht.

Wenn das Einlesen abbricht, sollte es dazu eine Fehlermeldung in Deinem Logfile geben - entweder beim Schreiben oder beim Lesen.
Für das Problem kann es auch ganz andere Ursachen geben: Speicherproblem in der Hardware, Konfigurationsparameter der mySQL Datenbank usw.
Schau doch mal in das Fehlerlog Deines mySQL Servers, ob es dort Auffälligkeiten gibt. Wir hatten hier im Forum schon die merkwürdigsten Phänomene in diese Richtung.

Schau Dir doch mal mit "configdb fileshow <statefileName>" den Inhalt des statefiles in der Datenbank an.
Damit kannst Du zumindest feststellen, ob die Daten tatsächlich alle in der Datenbank stehen.
Auf diesem Weg können wir eingrenzen, ob das Problem beim Schreiben oder beim Lesen des statefile auftritt.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Jetzt dachte ich gerade schon, dass ich dem ganze ein wenig näher gekommen bin, aber dem war nicht wirklich so.

Ich hatte mir die gespeicherten save.files angeschaut und immer bei einem Eintrag vom Modul Calendar hatte ich eine über 1400 Zeichen langen String. Da dachte ich, dass das vielleicht zu Problemen führt. Daraufhin habe ich das Device von FHEM_Kalender zu zzz_FHEM_Kalender umbenannt, weil es ja offenbar so ist, dass es nach alphabetischer Reihenfolge in die Datei geschrieben wird. Meine Erwartung wäre also gewesen, dass es jetzt bis zzz durchläuft.
Leider war dem nicht so. Es steht jetzt als letzte Zeile etwas anderes drin. Es bricht sogar mitten in der Zeile ab.
Jetzt habe ich mal alles in ein Word-Dokument kopiert, damit ich die Anzahl der Zeichen rausbekomme, aber es ist nicht die identische Zeichenanzahl. Aber es sind einmal 48.019 Zeichen (nach der Umbenennung) und einmal 48.044 Zeichen (vor der Umbenennung). Nach dem Umbenennen auf den Ursprungsnamen ist es wieder wie zuvor. Es bricht also scheinbar zuverlässig irgendwo bei 48.000 Zeichen ab...

Die einzige Erkenntnis: das File wird nicht sauber geschrieben.

Ich muss mich jetzt mal anschauen, wie ich das mit der Analyse mysql-Server-seitig mache. Das läuft bei mir alles in einem Docker Container und ich habe zwar ein Pfad zum Logverzeichnis in der docker-compose angegeben, aber in dem Logfile ist der letzte Eintrag von vor 2 Jahren. Da stimmt wohl was nicht, sonst würde ja das Logfile beschrieben werden.



Wernieman

Was sagt denn der Docker-Contaiener, also "docker logs <containername>" (o.Ä. bitte prüfen, da aus dem Kopf geschrieben)?

Geht mit docker-compose auch so ....

Und der Plattenplatz auf mysql-Seite?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

betateilchen

Zitat von: persching am 30 März 2022, 16:59:35
Das läuft bei mir alles in einem Docker Container

Da bin ich ohnehin raus - das hättest Du ja mal früher schreiben können.

Die Geheimniskrämerei auch um Dein FHEM Log geht mir langsam tierisch auf den Zeiger.
Wenn es ein Problem innerhalb von FHEM oder configDB wäre, muss es eine Fehlermeldung im FHEM Log geben.

Zitat von: persching am 30 März 2022, 16:59:35
Die einzige Erkenntnis: das File wird nicht sauber geschrieben.

Das bedeutet aber noch lange nicht, dass configDB die Ursache dafür sein muss.
Es kann auch schlichtweg eine unpassende Konfiguration des mysql Servers sein.

Zitat von: persching am 30 März 2022, 16:59:35
Es bricht also scheinbar zuverlässig irgendwo bei 48.000 Zeichen ab...

Das klingt umso mehr nach einem unpassend eingestellten Server Parameter (max_allowed_packet oder ähnliches) auf mysql Seite.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Zitat von: Wernieman am 30 März 2022, 17:07:30
Was sagt denn der Docker-Contaiener, also "docker logs <containername>" (o.Ä. bitte prüfen, da aus dem Kopf geschrieben)?

Geht mit docker-compose auch so ....

Und der Plattenplatz auf mysql-Seite?

Hier das Docker Log für den mySQL Container:
docker logs mySQL
[Entrypoint] MySQL Docker Image 5.7.37-1.2.7-server
[Entrypoint] Starting MySQL 5.7.37-1.2.7-server
2022-03-24T17:21:12.559652Z 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
2022-03-24T17:21:12.559760Z 0 [Warning] 'NO_AUTO_CREATE_USER' sql mode was not set.
2022-03-24T17:21:12.562238Z 0 [Note] mysqld (mysqld 5.7.37) starting as process 1 ...
2022-03-24T17:21:12.569178Z 0 [Note] InnoDB: PUNCH HOLE support available
2022-03-24T17:21:12.569242Z 0 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2022-03-24T17:21:12.569252Z 0 [Note] InnoDB: Uses event mutexes
2022-03-24T17:21:12.569260Z 0 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2022-03-24T17:21:12.569268Z 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
2022-03-24T17:21:12.569282Z 0 [Note] InnoDB: Using Linux native AIO
2022-03-24T17:21:12.569786Z 0 [Note] InnoDB: Number of pools: 1
2022-03-24T17:21:12.569976Z 0 [Note] InnoDB: Using CPU crc32 instructions
2022-03-24T17:21:12.573154Z 0 [Note] InnoDB: Initializing buffer pool, total size = 128M, instances = 1, chunk size = 128M
2022-03-24T17:21:12.590153Z 0 [Note] InnoDB: Completed initialization of buffer pool
2022-03-24T17:21:12.593700Z 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2022-03-24T17:21:12.607209Z 0 [Note] InnoDB: Highest supported file format is Barracuda.
2022-03-24T17:21:12.627792Z 0 [Note] InnoDB: Creating shared tablespace for temporary tables
2022-03-24T17:21:12.627946Z 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2022-03-24T17:21:12.686379Z 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2022-03-24T17:21:12.688124Z 0 [Note] InnoDB: 96 redo rollback segment(s) found. 96 redo rollback segment(s) are active.
2022-03-24T17:21:12.688163Z 0 [Note] InnoDB: 32 non-redo rollback segment(s) are active.
2022-03-24T17:21:12.691520Z 0 [Note] InnoDB: 5.7.37 started; log sequence number 32366094058
2022-03-24T17:21:12.692097Z 0 [Note] Plugin 'FEDERATED' is disabled.
2022-03-24T17:21:12.698218Z 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2022-03-24T17:21:12.719579Z 0 [Note] Found ca.pem, server-cert.pem and server-key.pem in data directory. Trying to enable SSL support using them.
2022-03-24T17:21:12.719645Z 0 [Note] Skipping generation of SSL certificates as certificate files are present in data directory.
2022-03-24T17:21:12.719656Z 0 [Warning] A deprecated TLS version TLSv1 is enabled. Please use TLSv1.2 or higher.
2022-03-24T17:21:12.719661Z 0 [Warning] A deprecated TLS version TLSv1.1 is enabled. Please use TLSv1.2 or higher.
2022-03-24T17:21:12.720925Z 0 [Warning] CA certificate ca.pem is self signed.
2022-03-24T17:21:12.721036Z 0 [Note] Skipping generation of RSA key pair as key files are present in data directory.
2022-03-24T17:21:12.723601Z 0 [Note] Server hostname (bind-address): '*'; port: 3306
2022-03-24T17:21:12.723854Z 0 [Note] IPv6 is available.
2022-03-24T17:21:12.723898Z 0 [Note]   - '::' resolves to '::';
2022-03-24T17:21:12.723962Z 0 [Note] Server socket created on IP: '::'.
2022-03-24T17:21:12.756290Z 0 [Note] Event Scheduler: Loaded 0 events
2022-03-24T17:21:12.758066Z 0 [Note] mysqld: ready for connections.
Version: '5.7.37'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MySQL Community Server (GPL)
2022-03-24T17:21:13.736580Z 0 [Note] InnoDB: Buffer pool(s) load completed at 220324 17:21:13
2022-03-25T01:21:58.069859Z 156 [Note] Aborted connection 156 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
2022-03-26T17:05:17.733910Z 12448 [Note] Aborted connection 12448 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
2022-03-28T02:17:35.260620Z 23410 [Note] Aborted connection 23410 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
2022-03-29T01:43:46.475379Z 31194 [Note] Aborted connection 31194 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
2022-03-30T00:49:23.667389Z 0 [Note] Giving 0 client threads a chance to die gracefully
2022-03-30T00:49:23.667470Z 0 [Note] Shutting down slave threads
2022-03-30T00:49:23.670299Z 0 [Note] Forcefully disconnecting 0 remaining clients
2022-03-30T00:49:23.670582Z 0 [Note] Event Scheduler: Purging the queue. 0 events
2022-03-30T00:49:23.673704Z 0 [Note] Binlog end
2022-03-30T00:49:23.681058Z 0 [Note] Shutting down plugin 'ngram'
2022-03-30T00:49:23.681297Z 0 [Note] Shutting down plugin 'partition'
2022-03-30T00:49:23.681311Z 0 [Note] Shutting down plugin 'BLACKHOLE'
2022-03-30T00:49:23.681721Z 0 [Note] Shutting down plugin 'ARCHIVE'
2022-03-30T00:49:23.681740Z 0 [Note] Shutting down plugin 'PERFORMANCE_SCHEMA'
2022-03-30T00:49:23.682155Z 0 [Note] Shutting down plugin 'MRG_MYISAM'
2022-03-30T00:49:23.682615Z 0 [Note] Shutting down plugin 'MyISAM'
2022-03-30T00:49:23.683232Z 0 [Note] Shutting down plugin 'INNODB_SYS_VIRTUAL'
2022-03-30T00:49:23.683426Z 0 [Note] Shutting down plugin 'INNODB_SYS_DATAFILES'
2022-03-30T00:49:23.683437Z 0 [Note] Shutting down plugin 'INNODB_SYS_TABLESPACES'
2022-03-30T00:49:23.683442Z 0 [Note] Shutting down plugin 'INNODB_SYS_FOREIGN_COLS'
2022-03-30T00:49:23.683447Z 0 [Note] Shutting down plugin 'INNODB_SYS_FOREIGN'
2022-03-30T00:49:23.683451Z 0 [Note] Shutting down plugin 'INNODB_SYS_FIELDS'
2022-03-30T00:49:23.683456Z 0 [Note] Shutting down plugin 'INNODB_SYS_COLUMNS'
2022-03-30T00:49:23.683460Z 0 [Note] Shutting down plugin 'INNODB_SYS_INDEXES'
2022-03-30T00:49:23.683464Z 0 [Note] Shutting down plugin 'INNODB_SYS_TABLESTATS'
2022-03-30T00:49:23.683468Z 0 [Note] Shutting down plugin 'INNODB_SYS_TABLES'
2022-03-30T00:49:23.683473Z 0 [Note] Shutting down plugin 'INNODB_FT_INDEX_TABLE'
2022-03-30T00:49:23.683477Z 0 [Note] Shutting down plugin 'INNODB_FT_INDEX_CACHE'
2022-03-30T00:49:23.683481Z 0 [Note] Shutting down plugin 'INNODB_FT_CONFIG'
2022-03-30T00:49:23.683492Z 0 [Note] Shutting down plugin 'INNODB_FT_BEING_DELETED'
2022-03-30T00:49:23.683497Z 0 [Note] Shutting down plugin 'INNODB_FT_DELETED'
2022-03-30T00:49:23.683501Z 0 [Note] Shutting down plugin 'INNODB_FT_DEFAULT_STOPWORD'
2022-03-30T00:49:23.683506Z 0 [Note] Shutting down plugin 'INNODB_METRICS'
2022-03-30T00:49:23.683510Z 0 [Note] Shutting down plugin 'INNODB_TEMP_TABLE_INFO'
2022-03-30T00:49:23.683514Z 0 [Note] Shutting down plugin 'INNODB_BUFFER_POOL_STATS'
2022-03-30T00:49:23.683518Z 0 [Note] Shutting down plugin 'INNODB_BUFFER_PAGE_LRU'
2022-03-30T00:49:23.683523Z 0 [Note] Shutting down plugin 'INNODB_BUFFER_PAGE'
2022-03-30T00:49:23.683527Z 0 [Note] Shutting down plugin 'INNODB_CMP_PER_INDEX_RESET'
2022-03-30T00:49:23.683531Z 0 [Note] Shutting down plugin 'INNODB_CMP_PER_INDEX'
2022-03-30T00:49:23.683535Z 0 [Note] Shutting down plugin 'INNODB_CMPMEM_RESET'
2022-03-30T00:49:23.683540Z 0 [Note] Shutting down plugin 'INNODB_CMPMEM'
2022-03-30T00:49:23.683545Z 0 [Note] Shutting down plugin 'INNODB_CMP_RESET'
2022-03-30T00:49:23.683549Z 0 [Note] Shutting down plugin 'INNODB_CMP'
2022-03-30T00:49:23.683554Z 0 [Note] Shutting down plugin 'INNODB_LOCK_WAITS'
2022-03-30T00:49:23.683559Z 0 [Note] Shutting down plugin 'INNODB_LOCKS'
2022-03-30T00:49:23.683563Z 0 [Note] Shutting down plugin 'INNODB_TRX'
2022-03-30T00:49:23.683570Z 0 [Note] Shutting down plugin 'InnoDB'
2022-03-30T00:49:23.691471Z 0 [Note] InnoDB: FTS optimize thread exiting.
2022-03-30T00:49:23.693663Z 0 [Note] InnoDB: Starting shutdown...
2022-03-30T00:49:23.794398Z 0 [Note] InnoDB: Dumping buffer pool(s) to /var/lib/mysql/ib_buffer_pool
2022-03-30T00:49:23.795726Z 0 [Note] InnoDB: Buffer pool(s) dump completed at 220330  0:49:23
2022-03-30T00:49:25.129824Z 0 [Note] InnoDB: Shutdown completed; log sequence number 34167728181
2022-03-30T00:49:25.133239Z 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
2022-03-30T00:49:25.133287Z 0 [Note] Shutting down plugin 'MEMORY'
2022-03-30T00:49:25.133296Z 0 [Note] Shutting down plugin 'CSV'
2022-03-30T00:49:25.133303Z 0 [Note] Shutting down plugin 'sha256_password'
2022-03-30T00:49:25.133308Z 0 [Note] Shutting down plugin 'mysql_native_password'
2022-03-30T00:49:25.133492Z 0 [Note] Shutting down plugin 'binlog'
2022-03-30T00:49:25.138272Z 0 [Note] mysqld: Shutdown complete

[Entrypoint] MySQL Docker Image 5.7.37-1.2.7-server
[Entrypoint] Starting MySQL 5.7.37-1.2.7-server
2022-03-30T00:50:33.941423Z 0 [Warning] TIMESTAMP with implicit DEFAULT value is deprecated. Please use --explicit_defaults_for_timestamp server option (see documentation for more details).
2022-03-30T00:50:33.941540Z 0 [Warning] 'NO_AUTO_CREATE_USER' sql mode was not set.
2022-03-30T00:50:33.944479Z 0 [Note] mysqld (mysqld 5.7.37) starting as process 1 ...
2022-03-30T00:50:33.954730Z 0 [Note] InnoDB: PUNCH HOLE support available
2022-03-30T00:50:33.954789Z 0 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2022-03-30T00:50:33.954799Z 0 [Note] InnoDB: Uses event mutexes
2022-03-30T00:50:33.954808Z 0 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2022-03-30T00:50:33.954817Z 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
2022-03-30T00:50:33.954826Z 0 [Note] InnoDB: Using Linux native AIO
2022-03-30T00:50:33.955399Z 0 [Note] InnoDB: Number of pools: 1
2022-03-30T00:50:33.955654Z 0 [Note] InnoDB: Using CPU crc32 instructions
2022-03-30T00:50:33.959917Z 0 [Note] InnoDB: Initializing buffer pool, total size = 128M, instances = 1, chunk size = 128M
2022-03-30T00:50:33.977082Z 0 [Note] InnoDB: Completed initialization of buffer pool
2022-03-30T00:50:33.981260Z 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2022-03-30T00:50:34.000563Z 0 [Note] InnoDB: Highest supported file format is Barracuda.
2022-03-30T00:50:34.026087Z 0 [Note] InnoDB: Creating shared tablespace for temporary tables
2022-03-30T00:50:34.026445Z 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2022-03-30T00:50:34.078461Z 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2022-03-30T00:50:34.081014Z 0 [Note] InnoDB: 96 redo rollback segment(s) found. 96 redo rollback segment(s) are active.
2022-03-30T00:50:34.081068Z 0 [Note] InnoDB: 32 non-redo rollback segment(s) are active.
2022-03-30T00:50:34.082253Z 0 [Note] InnoDB: Waiting for purge to start
2022-03-30T00:50:34.132608Z 0 [Note] InnoDB: 5.7.37 started; log sequence number 34167728181
2022-03-30T00:50:34.133492Z 0 [Note] Plugin 'FEDERATED' is disabled.
2022-03-30T00:50:34.140103Z 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2022-03-30T00:50:34.152317Z 0 [Note] Found ca.pem, server-cert.pem and server-key.pem in data directory. Trying to enable SSL support using them.
2022-03-30T00:50:34.152447Z 0 [Note] Skipping generation of SSL certificates as certificate files are present in data directory.
2022-03-30T00:50:34.152695Z 0 [Warning] A deprecated TLS version TLSv1 is enabled. Please use TLSv1.2 or higher.
2022-03-30T00:50:34.152702Z 0 [Warning] A deprecated TLS version TLSv1.1 is enabled. Please use TLSv1.2 or higher.
2022-03-30T00:50:34.158467Z 0 [Warning] CA certificate ca.pem is self signed.
2022-03-30T00:50:34.158574Z 0 [Note] Skipping generation of RSA key pair as key files are present in data directory.
2022-03-30T00:50:34.160102Z 0 [Note] Server hostname (bind-address): '*'; port: 3306
2022-03-30T00:50:34.160742Z 0 [Note] IPv6 is available.
2022-03-30T00:50:34.160810Z 0 [Note]   - '::' resolves to '::';
2022-03-30T00:50:34.161054Z 0 [Note] Server socket created on IP: '::'.
2022-03-30T00:50:34.283930Z 0 [Note] Event Scheduler: Loaded 0 events
2022-03-30T00:50:34.284440Z 0 [Note] mysqld: ready for connections.
Version: '5.7.37'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MySQL Community Server (GPL)
2022-03-30T00:50:35.210508Z 0 [Note] InnoDB: Buffer pool(s) load completed at 220330  0:50:35
2022-03-30T08:51:18.468702Z 156 [Note] Aborted connection 156 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)


Plattenplatz: SSD mit 250GB, davon 10% belegt


Zitat von: betateilchen am 30 März 2022, 17:47:34
Da bin ich ohnehin raus - das hättest Du ja mal früher schreiben können.

Ich wusste nicht, dass die Änderung etwas mit Docker oder nicht Docker zu tun hat.

Zitat
Die Geheimniskrämerei auch um Dein FHEM Log geht mir langsam tierisch auf den Zeiger.
Wenn es ein Problem innerhalb von FHEM oder configDB wäre, muss es eine Fehlermeldung im FHEM Log geben.

Ich mache kein Geheimniskrämerei daraus. Ich sah bloß wenig Sinn 171.000 Zeilen zu posten. Du bist davon überzeugt, dass es einen Fehler im Log gibt, dann sind hier die relevanten Zeilen:

Einmal das Schreiben von 4142 states:

[code]
2022.03.28 19:43:13.677 4: configDB writing file: ./log/eventTypes.txt
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Dummy false
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Dummy 2022-03-28 05:08:39 state false
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI cmd_2
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 18:48:35 Device Umwaelzpumpe
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 05:08:40 cmd 2
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 05:08:40 cmd_event Umwaelzpumpe
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 05:08:40 cmd_nr 2
2022.03.28 19:43:13.705 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-27 21:03:23 e_Heizart_dummy_STATE Zeit
2022.03.28 19:43:13.706 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 18:48:35 e_Umwaelzpumpe_STATE closed
2022.03.28 19:43:13.706 5: configDB: setstate Absenkung_Thermostate_DI 2020-10-22 06:48:02 mode enabled
2022.03.28 19:43:13.706 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 05:08:40 state cmd_2
2022.03.28 19:43:13.706 5: configDB: setstate Absenkung_Thermostate_DI 2022-03-28 18:48:35 wait_timer no timer
2022.03.28 19:43:13.706 5: configDB: setstate ActionDetector alive:3 dead:0 unkn:0 off:0
2022.03.28 19:43:13.706 5: configDB: setstate ActionDetector 2022-03-28 19:37:16 state alive:3 dead:0 unkn:0 off:0
2022.03.28 19:43:13.706 5: configDB: setstate ActionDetector 2022-03-28 19:37:16 status_EG_WoZi_Powermeter alive
2022.03.28 19:43:13.706 5: configDB: setstate ActionDetector 2022-03-28 19:37:16 status_EG_WoZi_TSensor alive
2022.03.28 19:43:13.706 5: configDB: setstate ActionDetector 2022-03-28 19:37:16 status_HM_6503CE alive
2022.03.28 19:43:13.706 5: configDB: setstate AndroidMessage_dummy on
2022.03.28 19:43:13.706 5: configDB: setstate AndroidMessage_dummy 2019-11-06 19:03:00 state on
2022.03.28 19:43:13.706 5: configDB: setstate Bad_T23_DI cmd_2
2022.03.28 19:43:13.706 5: configDB: setstate Bad_T23_DI 2022-03-28 19:00:01 Device OG_Bad_Klo_T
2022.03.28 19:43:13.706 5: configDB: setstate Bad_T23_DI 2022-03-13 18:25:09 cmd 2
2022.03.28 19:43:13.706 5: configDB: setstate Bad_T23_DI 2022-03-13 18:25:09 cmd_event OG_Bad_Klo_T
2022.03.28 19:43:13.707 5: configDB: setstate Bad_T23_DI 2022-03-13 18:25:09 cmd_nr 2
2022.03.28 19:43:13.707 5: configDB: setstate Bad_T23_DI 2022-03-28 19:00:01 e_OG_Bad_Klo_T_desiredTemperature 21.5
2022.03.28 19:43:13.707 5: configDB: setstate Bad_T23_DI 2022-03-13 18:25:09 state cmd_2
2022.03.28 19:43:13.707 5: configDB: setstate Bad_T23_DI 2022-03-27 22:00:00 timer_01_c01 28.03.2022 08:00:00
2022.03.28 19:43:13.707 5: configDB: setstate Bad_T23_DI 2022-03-27 22:00:00 timer_02_c01 28.03.2022 22:00:00
2022.03.28 19:43:13.707 5: configDB: setstate Battery_check_notify active
2022.03.28 19:43:13.707 5: configDB: setstate Battery_check_notify 2022-03-27 20:17:07 state active
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig false
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig 2020-07-29 16:55:54 state false
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI cmd_2
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2022-03-28 19:42:14 Device Heizung
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2020-07-29 16:55:54 cmd 2
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2020-07-29 16:55:54 cmd_event Heizung
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2020-07-29 16:55:54 cmd_nr 2
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2022-03-28 19:42:14 e_Heizung_Temp-Aussen 16.3
2022.03.28 19:43:13.707 5: configDB: setstate Beschattung_Notwendig_DI 2022-03-28 19:18:18 e_MyWeather_condition Klar
2022.03.28 19:43:13.708 5: configDB: setstate Beschattung_Notwendig_DI 2020-07-29 16:54:36 mode enabled
2022.03.28 19:43:13.708 5: configDB: setstate Beschattung_Notwendig_DI 2020-07-29 16:55:54 state cmd_2
2022.03.28 19:43:13.708 5: configDB: setstate CMDALIAS_FRITZBOXDEVICE_GUESTWLAN_OFF defined
2022.03.28 19:43:13.708 5: configDB: setstate CUL_0 2022-03-27 20:17:06 cmds  A B b C E e F G i K k l M m N R T t U u V W X x Y Z
2022.03.28 19:43:13.708 5: configDB: setstate CUL_0 2022-03-28 19:42:16 credit10ms 3600
2022.03.28 19:43:13.708 5: configDB: setstate CUL_0 2022-03-28 19:39:45 state Initialized
2022.03.28 19:43:13.708 5: configDB: setstate CUL_0 2021-10-02 10:56:14 version No answer
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI cmd_1
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-25 04:23:00 cmd 1
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-25 04:23:00 cmd_event timer_1
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-25 04:23:00 cmd_nr 1
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-25 04:23:00 error configDB reorg 5:  Result after database reorg:\n-----------------------------------------------------------------\n configDB Database Information\n-----------------------------------------------------------------\n d:$Id: configDB.pm 25860 2022-03-20 10:03:20Z betateilchen $\n c:unknown\n-----------------------------------------------------------------\n dbconn: mysql:database=fhem;;host=mysql;;port=3306\n dbtype: MYSQL\n-----------------------------------------------------------------\n loaded:       bbdfc9f604a56d054d1034ee08aad6dc\n max Versions: 5\n lastReorg:    Fri Mar 25 04:23:00 2022\n config:       12974 entries\n\n Ver 0 saved: Thu Mar 24 21:59:50 2022 def: 308 attr: 1546\n Ver 1 saved: Thu Mar 24 21:25:32 2022 def: 308 attr: 1545\n Ver 2 saved: Thu Mar 24 20:55:44 2022 def: 308 attr: 1545\n Ver 3 saved: Thu Mar 24 19:48:23 2022 def: 308 attr: 1546\n Ver 4 saved: Thu Mar 24 18:04:11 2022 def: 308 attr: 1545\n Ver 5 saved: Thu Mar 24 17:55:57 2022 def: 308 attr: 1545\n-----------------------------------------------------------------\n filesave: 39 files stored in database\n-----------------------------------------------------------------
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2019-11-06 16:34:23 mode enabled
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-25 04:23:00 state cmd_1
2022.03.28 19:43:13.708 5: configDB: setstate Clean_ConfigDB_DI 2022-03-28 04:23:00 timer_01_c01 29.03.2022 04:23:00|5
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools initialized
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:16 .DOIF_detailFn DOIF_detailFn
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:16 .DOIFdO 1
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:16 .eM off
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-28 19:02:32 DOIF_version 98_DOIF.pm 25819 2022-03-12 23:15:22Z Damian
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:16 FHEM_revision 25882
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2019-11-05 19:48:30 doStatistics disabled
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:16 recording_target_duration 0
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2019-11-05 19:48:30 sourceAttribute readingList
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2022-03-27 20:17:14 state initialized
2022.03.28 19:43:13.709 5: configDB: setstate DOIFtools 2019-11-05 19:48:30 statisticsDeviceFilterRegex .*
2022.03.28 19:43:13.709 5: configDB: setstate DbRep_BuiltAvg reduceLog of fhem finished
2022.03.28 19:43:13.709 5: configDB: setstate DbRep_BuiltAvg 2022-03-28 03:33:53 background_processing_time 232.98
2022.03.28 19:43:13.709 5: configDB: setstate DbRep_BuiltAvg 2022-03-28 03:33:53 reduceLogState reduceLog finished. Rows processed: 303780, deleted: 256151, updated: 1279
2022.03.28 19:43:13.709 5: configDB: setstate DbRep_BuiltAvg 2022-03-28 03:33:53 state reduceLog of fhem finished
2022.03.28 19:43:13.709 5: configDB: setstate DbRep_BuiltAvg_writeToDB done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_BuiltAvg_writeToDB 2022-03-27 20:17:16 .associatedWith EG_Kueche_Kaffeemaschine_Powermeter_Leistung
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_BuiltAvg_writeToDB 2022-03-28 19:30:00 2022-03-28__KaffeePowerAVG__no_aggregation 0.0000
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_BuiltAvg_writeToDB 2022-03-28 19:30:00 db_lines_processed 2
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_BuiltAvg_writeToDB 2022-03-28 19:30:00 state done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Delete_Selected_Entries done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Delete_Selected_Entries 2022-03-27 23:30:00 .associatedWith EG_Kueche_Kaffeemaschine_Powermeter_Leistung
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Delete_Selected_Entries 2022-03-27 23:30:00 EG_Kueche_Kaffeemaschine_Powermeter_Leistung--/--DELETED_ROWS_HISTORY 239
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Delete_Selected_Entries 2022-03-27 23:30:00 state done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump Database backup finished
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 DumpFileCreated ./log/fhem_2022_03_28_04_30.sql
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 DumpFileCreatedSize 372.83 MB
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 DumpFilesDeleted fhem_2022_03_25_04_30.sql
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 DumpRowsCurrent 4977
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 DumpRowsHistory 1959138
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 background_processing_time 319.5516
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_Dump 2022-03-28 04:35:19 state Database backup finished
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Long done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Long 2022-03-27 23:00:00 /--EXCLUDE/Temp-Aussen--DELETED_ROWS_HISTORY 2116
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Long 2022-03-27 23:00:00 state done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Short done
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Short 2022-03-28 04:00:05 number_rows_deleted 1386
2022.03.28 19:43:13.710 5: configDB: setstate DbRep_KeepValues_Short 2022-03-28 04:00:05 state done
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence present
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence 2022-03-28 19:42:58 .absenceThresholdCounter 0
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence 2022-03-28 19:42:58 .presenceThresholdCounter 0
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence 2022-03-27 20:17:11 model function
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence 2022-03-28 19:42:58 presence present
2022.03.28 19:43:13.711 5: configDB: setstate DirkPresence 2022-03-28 19:42:58 state present
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo ok
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.cap.e audit_write,chown,dac_override,fowner,fsetid,kill,mknod,net_bind_service,net_raw,setfcap,setgid,setpcap,setuid,sys_chroot$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.cap.i audit_write,chown,dac_override,fowner,fsetid,kill,mknod,net_bind_service,net_raw,setfcap,setgid,setpcap,setuid,sys_chroot$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.cap.p audit_write,chown,dac_override,fowner,fsetid,kill,mknod,net_bind_service,net_raw,setfcap,setgid,setpcap,setuid,sys_chroot$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.hostname 8e7f5caba0ef$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.hostnetwork 0$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.id 8e7f5caba0ef777b0491cba7f15c7352c86b9e2bc1e2e8e0441b4d73d72a2207$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 container.privileged 0$xyz$
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 id.gid 6061
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 id.gname fhem
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 id.groups [ "fhem": 6061, "tty": 5, "mail": 8, "dialout": 20, "audio": 29, "video": 44, "bluetooth": 6001, "gpio": 6002, "i2c": 6003 ]
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 id.uid 6061
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 id.uname fhem
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.created 2020-08-03T11:22:51+00:00
2022.03.28 19:43:13.711 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.description A basic Docker image for FHEM house automation system, based on Debian Buster.
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.documentation https://github.com/fhem/fhem-docker/blob/e96d817971ec68f3a191c0dfa7a27e87b4d2e8be/README.md
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.licenses MIT
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.revision e96d817971ec68f3a191c0dfa7a27e87b4d2e8be
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.source https://github.com/fhem/fhem-docker/
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.title fhem-amd64_linux
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.url https://hub.docker.com/r/fhem/fhem-amd64_linux
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.vendor Julian Pawlowski
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 image.version 6.0-s22528_v2.2.4
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 ssh-id_ed25519.pub ssh-ed25519 AAAAC3NzaC1lZDIxxxx4nYYEIFAObNUbHv+8gU9oP7dKVD fhem@fhem-docker$xyz$
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 ssh-id_rsa.pub ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCh3TLqOoxxxxxxCh4j7M+ljgfO8ye8kP2/wZpuZ2kXwgwInMc45JbV+zwcUok+dx3OsXmqsddQMkSutvRGZpAFKb7ii8UNXx8iIKp4u4w+zWaVH6J7yB6uCzMjQ5rYhUzfAXVyXcJikLeyKuC5H1CJ/j+nT8fhQO8PXsQzvQ6UaMR+Sm1stZOEcUh+c2zlBeonaXQRYqwwMK+5G+u6H/M6oK7gbjLh+JaGQA2l8pAQviNizWlkx6ae5U7/uWd7v6YVERgBEzZPhHOhzKkIz0qne8IdUkMxiGgNm8tYv9aZKJoR8AwmP9fvNu8Qi69IjWciFnSgUR8WjLlWh77OD8EaAgWntX0apNEDOyE7klaQnhZd+oCe1GvZiW3BasXKw/cwmiOSeFeyD/JAsSWTCHociYPSAPQxG2SKE85jOBwejgEBwQpytCB0AYoNnOJMt+Y71T5aLb6Tq4mCFNEcccUoHPAosCw+AxatAov/V5MWQQOTZc0yMepXIhqWz1xmeVxwffVc9TyQHo816GHBoFJRSr7j1vOcoRTSrMBt97KSJLtQF3NzxcDkNk0T82zyjEPI1ZBeFmgWAPrVA3Ary9CZ8xaRZGoxoXJQVmoWG3q0A6xdLIm8FZEnsvUmlKdCx7IX88ydEatisu87rLNJcME2u6PUrwa5LDWKQ== fhem@fhem-docker$xyz$
2022.03.28 19:43:13.712 5: configDB: setstate DockerImageInfo 2022-03-27 20:17:14 sudoers [ "# Auto-generated during container start", "fhem ALL=(ALL) NOPASSWD:SETENV: /usr/bin/npm install *", "fhem ALL=(ALL) NOPASSWD:SETENV: /usr/bin/npm uninstall *", "fhem ALL=(ALL) NOPASSWD:SETENV: /usr/bin/npm update *", "fhem ALL=(ALL) NOPASSWD:SETENV: /usr/local/bin/cpanm *", "fhem ALL=(ALL) NOPASSWD: /usr/bin/apt-get -q update", "fhem ALL=(ALL) NOPASSWD: /usr/bin/apt-get -s -q -V upgrade", "fhem ALL=(ALL) NOPASSWD: /usr/bin/apt-get -y install *", "fhem ALL=(ALL) NOPASSWD: /usr/bin/apt-get -y -q -V dist-upgrade", "fhem ALL=(ALL) NOPASSWD: /usr/bin/apt-get -y -q -V upgrade", "fhem ALL=(ALL) NOPASSWD: /usr/bin/nmap" ]
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI cmd_2
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2022-03-28 14:49:07 Device EG_Bad_Fensterkontakt
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2021-10-24 15:58:37 cmd 2
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2021-10-24 15:58:37 cmd_event Familie
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2021-10-24 15:58:37 cmd_nr 2
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2022-03-28 14:49:07 e_EG_Bad_Fensterkontakt_STATE closed
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2022-03-28 12:32:53 e_Familie_STATE zuhause
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2020-01-11 15:14:06 e_WindowState_EG_Bad_Fensterkontakt_STATE closed
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_Alarm_DI 2021-10-24 15:58:37 state cmd_2
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI cmd_2
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-28 19:42:14 Device Heizung
2022.03.28 19:43:13.712 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-22 12:50:27 cmd 2
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-22 12:50:27 cmd_event EG_Bad_T
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-22 12:50:27 cmd_nr 2
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-28 14:49:07 e_EG_Bad_Fensterkontakt_STATE closed
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-28 19:08:28 e_EG_Bad_T_valveposition 13
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-28 19:42:14 e_Heizung_Temp-Aussen 16.3
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2019-11-08 17:57:35 mode enabled
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_FK_HeatingAlarm_DI 2022-03-22 12:50:27 state cmd_2
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fenster_Watchdog_Message_dummy on
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fenster_Watchdog_Message_dummy 2019-11-06 19:03:20 state on
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt closed
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 .lastact 1648488824.83841
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2021-12-05 14:47:16 PairedTo 123456
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 RSSI -62.5
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2021-12-05 14:47:16 SerialNr JEQ0158360
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 battery ok
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 batteryState ok
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2021-12-05 14:47:16 firmware 1.3
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2020-05-10 16:08:00 groupid 0
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2021-12-05 14:47:16 msgcnt 9
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 onoff 0
2022.03.28 19:43:13.713 5: configDB: setstate EG_Bad_Fensterkontakt 2021-05-13 18:18:32 peerIDs 12340e
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt 2021-05-13 18:18:32 peerList MAX_12340e
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 rferror 0
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 state closed
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt 2021-12-05 14:47:16 testresult 15
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt 2022-03-28 19:33:44 windowOpen 0
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 1
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 countsOverall 296
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 countsPerDay 1
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pauseTimeEdge 169619
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pauseTimeIncrement 15053
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pauseTimeOverall 34355327
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pauseTimePerDay 64923
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pulseTimeEdge 3477
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pulseTimeIncrement 3477
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pulseTimeOverall 5933266
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 pulseTimePerDay 3477
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 state 1
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 14:49:07 tickChanged 592
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 00:00:00 tickDay 1
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 tickHour 23
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-27 20:17:35 tickMonth 0
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 tickUpdated 216
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 01:00:00 tickWeek 2
2022.03.28 19:43:13.714 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-27 20:17:35 tickYear 0
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_Fensterkontakt_HC 2022-03-28 19:00:00 value 0
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 21.5
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 .lastact 1648487308.40526
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 RSSI -52.5
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-05 19:48:49 TimeInformationHour 0
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 battery ok
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 batteryState ok
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 comfortTemperature 21
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 desiredTemperature 21.5
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 deviation 2.2
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 ecoTemperature 17
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 gateway 1
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-05 21:33:36 groupid 0
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 14:18:05 lastTimeSync 2022-03-28 14:18:05
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 12:33:07 lastcmd desiredTemperature 21.5
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 maximumTemperature on
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2020-01-03 16:39:09 measurementOffset 1.0
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 minimumTemperature off
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 mode manual
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 14:18:05 msgcnt 119
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 panel locked
2022.03.28 19:43:13.715 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 peerIDs 000000
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 peerList Broadcast
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 rferror 0
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 state 21.5
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 temperature 23.7
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 usr_Temp -
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2022-03-28 19:08:28 valveposition 13
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 windowOpenDuration 15
2022.03.28 19:43:13.716 5: configDB: setstate EG_Bad_T 2019-11-07 21:31:08 windowOpenTemperature 12
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 5.0
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 .lastact 1648461625.49383
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 .weekProfile 485a50f649204520452045204520452045204520452045204520485a50f649204520452045204520452045204520452045204520484e50f049204520452045204520452045204520452045204520484e50f049204520452045204520452045204520452045204520484e50f049204520452045204520452045204520452045204520484e50f049204520452045204520452045204520452045204520484e50f049204520452045204520452045204520452045204520
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 RSSI -61.5
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2019-11-05 19:48:49 TimeInformationHour 3
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 battery ok
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 batteryState ok
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 comfortTemperature 21
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 desiredTemperature 5.0
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 deviation 17.5
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 ecoTemperature 17
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 gateway 1
2022.03.28 19:43:13.716 5: configDB: setstate EG_Flur_T 2019-11-05 21:10:36 groupid 0
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 08:18:04 lastTimeSync 2022-03-28 08:18:04
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-26 10:02:08 lastcmd desiredTemperature 5.0
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 maximumTemperature on
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2020-02-12 17:56:58 measurementOffset 0.5
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 minimumTemperature off
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 mode manual
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 08:18:04 msgcnt 101
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 panel unlocked
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 peerIDs 000000,00000e
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 peerList Broadcast,MAX_00000e
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 rferror 0
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 state 5.0
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 temperature 22.5
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 usr_Temp -
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2022-03-28 12:00:25 valveposition 0
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-0-Sat-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-0-Sat-time 00:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-1-Sun-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-1-Sun-time 00:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-2-Mon-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-2-Mon-time 00:00-06:30  /  06:30-20:00  /  20:00-24:00
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-3-Tue-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-3-Tue-time 00:00-06:30  /  06:30-20:00  /  20:00-24:00
2022.03.28 19:43:13.717 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-4-Wed-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-4-Wed-time 00:00-06:30  /  06:30-20:00  /  20:00-24:00
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-5-Thu-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-5-Thu-time 00:00-06:30  /  06:30-20:00  /  20:00-24:00
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-6-Fri-temp 18.0 °C  /  20.0 °C  /  18.0 °C
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-12-29 17:39:12 weekprofile-6-Fri-time 00:00-06:30  /  06:30-20:00  /  20:00-24:00
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 windowOpenDuration 15
2022.03.28 19:43:13.718 5: configDB: setstate EG_Flur_T 2019-11-07 21:33:55 windowOpenTemperature 12
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI cmd_2
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-28 19:42:14 Device Heizung
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-22 14:46:16 cmd 2
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-22 14:46:16 cmd_event EG_Kueche_Fensterkontakt
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-22 14:46:16 cmd_nr 2
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-27 20:17:33 e_EG_Kueche_Fensterkontakt_STATE closed
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-28 17:30:17 e_EG_Kueche_T_valveposition 8
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-28 19:42:14 e_Heizung_Temp-Aussen 16.3
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2019-11-08 17:59:30 mode enabled
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_FK_HeatingAlarm_DI 2022-03-22 14:46:16 state cmd_2
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fenster_Watchdog_Message_dummy on
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fenster_Watchdog_Message_dummy 2019-11-06 19:03:22 state on
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fensterkontakt closed
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 .lastact 1648487814.27397
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.718 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 RSSI -70.5
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 battery ok
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 batteryState ok
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 onoff 0
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 rferror 0
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 state closed
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Fensterkontakt 2022-03-28 19:16:54 windowOpen 0
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 73177.6
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-27 20:17:16 .associatedWith EG_Kueche_Kaffeemaschine_Powermeter_Leistung,EG_WoZi_Powermeter,HM_4A7FF8_SenF,HM_4A7FF8_SenI,HM_4A7FF8_SenPwr,HM_4A7FF8_SenU,Kaffeemaschine,EG_WoZi_Powermeter
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-averaging 1 s
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-sign off
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-txMinDly 8 s
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-txThrCur 100 mA
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-txThrFrq 1 Hz
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-txThrPwr 100 W
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2020-01-28 13:01:52 R-txThrVlt 10 V
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-25 13:50:42 RegL_01. 00:00 08:00 7A:01 7B:08 7C:00 7D:27 7E:10 7F:00 80:64 81:00 82:64 83:64
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 boot off
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-27 20:19:12 cfgState ok
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 18:05:54 commState CMDs_done
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 current 0
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 eState E: 73177.6 P: 0 I: 0 U: 228.8 f: 49.96
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 energy 73177.6
2022.03.28 19:43:13.719 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 energyCalc 138085.3
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2021-09-15 05:44:05 energyOffset 64907.7
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 frequency 49.96
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 power 0
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 state 73177.6
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_Kaffeemaschine_Powermeter_Leistung 2022-03-28 19:42:43 voltage 228.8
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 21.5
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 .lastact 1648481417.07355
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 .weekProfile 4c5456fc512045204520452045204520452045204520452045204c5456fc512045204520452045204520452045204520452045204c48585a56f651204520452045204520452045204520452045204c48585a56f651204520452045204520452045204520452045204c48585a56f651204520452045204520452045204520452045204c48585a56f651204520452045204520452045204520452045204c48585a56f65120452045204520452045204520452045204520
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2021-10-06 14:20:27 PairedTo 123456
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 RSSI -59.5
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2021-10-06 14:20:27 SerialNr KEQ0150685
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2019-11-05 19:48:49 TimeInformationHour 4
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 battery ok
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 batteryState ok
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 comfortTemperature 21
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 desiredTemperature 21.5
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 deviation 2.4
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 ecoTemperature 17
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2021-10-06 14:20:35 error Invalid command/argument  81190000
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2021-10-06 14:20:27 firmware 1.8
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 gateway 1
2022.03.28 19:43:13.720 5: configDB: setstate EG_Kueche_T 2019-11-05 21:16:51 groupid 0
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 10:18:04 lastTimeSync 2022-03-28 10:18:04
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 12:33:06 lastcmd desiredTemperature 21.5
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 maximumTemperature on
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2019-12-05 19:40:56 measurementOffset 0.5
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 minimumTemperature off
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 mode manual
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 12:32:58 msgcnt 155
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 panel unlocked
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 peerIDs 000000
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 peerList Broadcast
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 rferror 0
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 state 21.5
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 temperature 23.9
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-06 14:20:27 testresult 255
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 usr_Temp -
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2022-03-28 17:30:17 valveposition 8
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-0-Sat-temp 19.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-0-Sat-time 00:00-07:00  /  07:00-21:00  /  21:00-24:00
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-1-Sun-temp 19.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-1-Sun-time 00:00-07:00  /  07:00-21:00  /  21:00-24:00
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-2-Mon-temp 19.0 °C  /  22.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-2-Mon-time 00:00-06:00  /  06:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.721 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-3-Tue-temp 19.0 °C  /  22.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-3-Tue-time 00:00-06:00  /  06:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-4-Wed-temp 19.0 °C  /  22.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-4-Wed-time 00:00-06:00  /  06:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-5-Thu-temp 19.0 °C  /  22.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-5-Thu-time 00:00-06:00  /  06:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-6-Fri-temp 19.0 °C  /  22.0 °C  /  21.5 °C  /  20.0 °C
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2021-10-02 20:16:04 weekprofile-6-Fri-time 00:00-06:00  /  06:00-07:30  /  07:30-20:30  /  20:30-24:00
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 windowOpenDuration 15
2022.03.28 19:43:13.722 5: configDB: setstate EG_Kueche_T 2019-11-07 21:33:04 windowOpenTemperature 12
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_EcoTaster 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI cmd_2
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2022-03-28 12:32:53 Device Familie
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2021-01-28 15:29:31 cmd 2
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2021-01-28 15:29:31 cmd_event EG_WoZi_Fensterkontakt
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2021-01-28 15:29:31 cmd_nr 2
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2022-03-27 20:47:09 e_EG_WoZi_Fensterkontakt_STATE closed
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2022-03-28 12:32:53 e_Familie_STATE zuhause
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2020-01-11 15:14:06 e_WindowState_EG_WoZi_Fensterkontakt_STATE closed
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2019-11-07 09:25:55 mode enabled
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Alarm_DI 2021-01-28 15:29:31 state cmd_2
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Close_DI cmd_1
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:47:09 Device EG_WoZi_Fensterkontakt
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:52:09 cmd 1
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:52:09 cmd_event EG_WoZi_Fensterkontakt
2022.03.28 19:43:13.722 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:52:09 cmd_nr 1
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:47:09 e_EG_WoZi_Fensterkontakt_onoff 0
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Close_DI 2021-10-05 13:38:08 mode enabled
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:52:09 state cmd_1
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Close_DI 2022-03-27 20:52:09 wait_timer no timer
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI cmd_2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-28 19:42:14 Device Heizung
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-27 20:47:09 cmd 2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-27 20:47:09 cmd_event EG_WoZi_Fensterkontakt
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-27 20:47:09 cmd_nr 2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-27 20:47:09 e_EG_WoZi_Fensterkontakt_STATE closed
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-28 19:13:32 e_EG_WoZi_T_ValvePosition 0
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-28 19:42:14 e_Heizung_Temp-Aussen 16.3
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2019-11-19 21:23:22 mode enabled
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_HeatingAlarm_DI 2022-03-27 20:47:09 state cmd_2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI cmd_2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-28 05:08:39 Device Absenkung_Dummy
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-26 17:39:35 cmd 2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-26 17:39:35 cmd_event EG_WoZi_Fensterkontakt
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-26 17:39:35 cmd_nr 2
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-28 05:08:39 e_Absenkung_Dummy_STATE false
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-27 20:47:09 e_EG_WoZi_Fensterkontakt_STATE closed
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-27 20:47:09 e_EG_WoZi_Fensterkontakt_onoff 0
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-27 20:49:03 e_Kachelofen_dummy_STATE aus
2022.03.28 19:43:13.723 5: configDB: setstate EG_WoZi_FK_Open_DI 2021-09-05 12:35:16 mode enabled
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_FK_Open_DI 2022-03-26 17:39:35 state cmd_2
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fenster_Watchdog_Message_dummy on
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fenster_Watchdog_Message_dummy 2019-11-06 19:03:23 state on
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt closed
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:50:58 .lastact 1648486258.71681
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-27 20:17:16 IODev cm
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2021-12-22 16:54:38 PairedTo 123456
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:50:58 RSSI -84
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2021-12-22 16:54:38 SerialNr JEQ0162006
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:50:58 battery ok
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:50:58 batteryState ok
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2021-12-22 16:54:52 error Invalid command/argument  8110
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2021-12-22 16:54:38 firmware 1.3
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2020-04-08 08:56:50 groupid 0
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2021-12-22 16:54:38 msgcnt 6
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:50:58 onoff 0
2022.03.28 19:43:13.724 5: configDB: setstate EG_WoZi_Fensterkontakt 2022-03-28 18:

betateilchen

#18
Zitat von: persching am 30 März 2022, 20:53:30
Ich wusste nicht, dass die Änderung etwas mit Docker oder nicht Docker zu tun hat.

Hat das jemand behauptet?
Mein Hinweis bezog sich lediglich darauf, dass ich keine Ahnung habe, wie Du Deinen mysql Server konfiguriert hast, geschweige denn, dass ich Ahnung davon hätte, wie das im Zusammenspiel mit Docker funktioniert.

Zitat von: persching am 30 März 2022, 20:53:30
Du bist davon überzeugt, dass es einen Fehler im Log gibt, dann sind hier die relevanten Zeilen:

Einmal das Schreiben von 4142 states:

Offensichtlich haben wir unterschiedliche Auffassungen davon, was "relevant" bedeutet.

Die setstate Zeilen interessieren mich eigentlich nicht, die sind nicht relevant.
Mich interessieren eher irgendwelche "ungewöhnliche" Einträge im Logfile.


---
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

Wernieman

Aus dem mysql-Log:
2022-03-26T17:05:17.733910Z 12448 [Note] Aborted connection 12448 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
Davon hast Du viele ... brauchst Du wirklich im Docker IPv6? Würde es abschalten (vor allem beim debuggen)
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

persching

Zitat von: betateilchen am 30 März 2022, 21:09:20
Offensichtlich haben wir unterschiedliche Auffassungen davon, was "relevant" bedeutet.

Die setstate Zeilen interessieren mich eigentlich nicht, die sind nicht relevant.
Mich interessieren eher irgendwelche "ungewöhnliche" Einträge im Logfile.
---

Ich hielt das für relevant, weil es das ungekürzte Log beim Schreiben ist. Wenn in dem Log der Schreibvorgang geloggt wird und man dann das geschriebene File ausliest und es nicht vollständig ist, dann würde ich den relevanten Zeitraum auf die Zeit des Schreibens eingrenzen. Oder habe ich da ein falsches Verständnis?

Zitat von: Wernieman am 31 März 2022, 10:40:03
Aus dem mysql-Log:
2022-03-26T17:05:17.733910Z 12448 [Note] Aborted connection 12448 to db: 'fhem' user: 'fhemuser' host: 'fd00::27:0:0:4' (Got timeout reading communication packets)
Davon hast Du viele ... brauchst Du wirklich im Docker IPv6? Würde es abschalten (vor allem beim debuggen)
IPv6 benötige ich nicht und hab ich nun deaktiviert. Diese Einträge tauchen aber nicht zum relevanten Zeitraum auf, sondern eher Nachts... aber natürlich ist das nicht so besonders toll. Ich versuch mich gerade in die Materie einzulesen, wie ich etwas im mySQL Container untersuchen kann.

betateilchen

Zitat von: persching am 31 März 2022, 19:32:30
Ich hielt das für relevant, weil es das ungekürzte Log beim Schreiben ist. .

Das was Du gepostet hast, ist weit davon entfernt, ein ungekürztes Log zu sein.
Mit den von Dir gelieferten Bruchstücken kann ich Dir nicht weiterhelfen.

Die setstate Einträge im Log sind für die Fehlersuche nicht relevant.
Es gilt herauszufinden, warum Dein mysql Server die übergebenen Daten nicht vollständig in die Datenbank schreibt.
Aber das habe ich schon mehrfach geschrieben.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Zitat von: betateilchen am 31 März 2022, 19:48:44
Das was Du gepostet hast, ist weit davon entfernt, ein ungekürztes Log zu sein.
Mit den von Dir gelieferten Bruchstücken kann ich Dir nicht weiterhelfen.

Für die Zeit des Schreibens ist es ungekürzt. Aber ich kann dir auch gerne per Link irgendwo das Logfile zum Download anbieten...

Zitat
Die setstate Einträge im Log sind für die Fehlersuche nicht relevant.
Es gilt herauszufinden, warum Dein mysql Server die übergebenen Daten nicht vollständig in die Datenbank schreibt.
Aber das habe ich schon mehrfach geschrieben.

Und am mysql Server bin ich gerade dran. Damit musste ich mich bisher nicht groß befassen, das lief alles ohne Probleme.

Wernieman

Irgendwie ist Dein mysql-Server komisch. Was für ein Image hast Du verwendet?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

persching

Hallo Wernieman,
hier 2 Screenshots. Einmal wegen der Version und der max_allowed_package Größe und dann der Auszug aus dem docker-compose.yml für den mysql-server.



Wernieman

Beim nächsten mal: Kannst Du bitte rauskopieren? Liest sich nicht nur für mich besser als ein Screenshot ....

- Nutzt Du den Server nur für fhem, oder auch für anderes? (Weil Du exposed)
- 5.7 .... Absicht?
- was willst DU mit sql_mode="" erreichen?
- was steht in der custem.cnf?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

persching

Zitat von: Wernieman am 01 April 2022, 20:37:48
Beim nächsten mal: Kannst Du bitte rauskopieren? Liest sich nicht nur für mich besser als ein Screenshot ....

- Nutzt Du den Server nur für fhem, oder auch für anderes? (Weil Du exposed)
Auf die Daten greife ich noch mit Grafana zu

Zitat
- 5.7 .... Absicht?
Mit der hatte ich aus irgendeinem Beispiel mal angefangen. Hatte dann mal einen Umstieg auf MariaDB probiert, aber das nicht geschafft und seit dem ist es 5.7. Never touch a running system...

Zitat
- was willst DU mit sql_mode="" erreichen?
Ehrlich gesagt weiß ich nicht mehr wofür ich das eingefügt habe, aber irgendwas hatte damals nicht funktioniert.

Zitat
- was steht in der custem.cnf?

[mysqld]
character-set-server = utf8
collation-server = utf8_unicode_ci
skip-character-set-client-handshake
sql-mode="STRICT_TRANS_TABLES,NO_ENGINE_SUBSTITUTION"


Da ich in dem Screenshot gesehen habe, dass dort "charset = latin1" steht und ich gesehen hatte, dass in der mycustom.cnf UTF8 steht habe ich das jetzt mal als command ins docker-compose.yml gepackt und dabei gleich noch die max-allowed-packet erhöht. Meine docker-compose hat sich also jetzt um diese Zeile geändert:

command: mysqld --sql_mode="" --character-set-server=utf8  --max-allowed-packet=67108864

Wenn ich mir das so anschaue habe ich wohl in der mycustom.cnf zum sql mode was ganz anderes stehen als in der docker-compose. :( Leider muss ich hier wohl zugeben, dass ich zu wenig verstehe, was diese Parameter bewirken.

Gebracht haben alle Änderungen nichts. Weiterhin wird das state.file nur bis zur exakt gleichen Stelle geschrieben.

Wernieman

Nimm mal sql-mode raus ...

muß jetzt aber auch gestehen, das ich von mysql zu wenig verstehe, um Deine Parameter komplett zu verstehen. Zur Fehlersuche: Kannst DU mal mit einem "nackten" mysql anfangen?

Stimme jedenfalls betateilchen zu, es dürfte ein mysql-Problem sein.
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

persching

Ich habe jetzt sicherlich 3 Stunden lang versucht das SQL Log irgendwie aus dem Container in einen Ordner auf dem Host umzuleiten, damit ich dort vielleicht mal analysieren kann, was passiert, wenn ich speichern drücke.
Geschafft habe ich es nicht. Darum hab ich dann Schritt für Schritt die Änderungen in der docker-compose.yml und in der custom.cnf wieder rückgängig gemacht.

Zitat von: Wernieman am 03 April 2022, 11:01:48
Nimm mal sql-mode raus ...

habe ich getan, das führt dazu, dass ich gar nicht mehr speichern kann. Ich habe dann die docker-compose nicht mit dem Attribut -d gestartet und dann dort in den Logs folgendes gefunden:

FHEM           | /entry.sh: line 621: kill: (5947) - No such process
FHEM           | 2022.04.03 14:02:15.771 1: PERL WARNING: DBD::mysql::st execute failed: Data too long for column 'content' at row 1 at configDB.pm line 427.
FHEM           | DBD::mysql::st execute failed: Data too long for column 'content' at row 1 at configDB.pm line 427.
FHEM           | 2022.04.03 14:02:15.771 1: PERL WARNING: Issuing rollback() due to DESTROY without explicit disconnect() of DBD::mysql::db handle database=fhem;host=mysql;port=3306 at configDB.pm line 427.


Zitat
muß jetzt aber auch gestehen, das ich von mysql zu wenig verstehe, um Deine Parameter komplett zu verstehen. Zur Fehlersuche: Kannst DU mal mit einem "nackten" mysql anfangen?

Stimme jedenfalls betateilchen zu, es dürfte ein mysql-Problem sein.

Du meinst alles wegsichern und dann mal eine leere Datenbank initialisieren? Kann ich natürlich machen, aber hab ich bisher noch nie gemacht. Ich hab ein wenig Angst, dass dann alles weg ist. Vielleicht würde ich dann erstmal ein Backup der Platte machen, um auf der ganz sicheren Seite zu sein, dass alles wieder da ist.

@betateilchen:
kannst du sagen, was hier in Line 427 von configDB.pm passiert bzw. passieren sollte?

Wernieman

Du hast doch Docker?
Also Container runterfahren, neues Verzeichnis mit neuen Container und den dann hochfahren. Wieso dann ein Komplett neues System?

Stimmt Deine Datenbank, also die Definition der Tabbelen, mit den gewünschten von config db überein?
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

persching

Zitat von: Wernieman am 04 April 2022, 08:45:05
Du hast doch Docker?
Also Container runterfahren, neues Verzeichnis mit neuen Container und den dann hochfahren. Wieso dann ein Komplett neues System?
Stimmt, irgendwie hatte ich daran nicht gedacht. Dann ist nur noch das Problem, dass ich dann eine leere Config habe...

Zitat
Stimmt Deine Datenbank, also die Definition der Tabbelen, mit den gewünschten von config db überein?
...darum werde ich erstmal diesen Punkt prüfen.

persching

Heute habe ich mich mal wieder an die Fehlersuche gemacht, und ich vermute, ich habe was gefunden. Die Datei init.sql, die mir ja die Datenbank beim Erstellen des Containers initialisiert, hat folgende Einträge:

CREATE DATABASE `fhem` DEFAULT CHARACTER SET = `utf8`;

CREATE USER 'fhemuser'@'%' IDENTIFIED BY 'ltuajsdflkssjaskdas';

REVOKE CREATE ROUTINE, CREATE VIEW, CREATE USER, ALTER, SHOW VIEW, CREATE, ALTER ROUTINE, EVENT, SUPER, >

UPDATE mysql.user SET max_questions = 0, max_updates = 0, max_connections = 0 WHERE User = 'fhemuser' AN>

GRANT CREATE ROUTINE, CREATE VIEW, ALTER, SHOW VIEW, CREATE, ALTER ROUTINE, EVENT, INSERT, SELECT, DELET>

USE `fhem`;

CREATE TABLE history (
    TIMESTAMP TIMESTAMP,
    DEVICE varchar(64),
    TYPE varchar(64),
    EVENT varchar(512),
    READING varchar(64),
    VALUE varchar(255),
    UNIT varchar(32),
    KEY `Search_Idx` (`DEVICE`,`READING`,`TIMESTAMP`,`VALUE`),
    KEY `Device_Idx` (`DEVICE`,`READING`),
    KEY `Report_Idx` (`TIMESTAMP`,`READING`) USING BTREE
);

CREATE TABLE current (
    TIMESTAMP TIMESTAMP,
    DEVICE varchar(64),
    TYPE varchar(64),
    EVENT varchar(512),
    READING varchar(64),
    VALUE varchar(255),
    UNIT varchar(32)
);

CREATE TABLE fhemversions (
        `VERSION`       INT,
        `VERSIONUUID`   CHAR ( 50 )
);
CREATE TABLE fhemstate (
        `stateString`   TEXT
);
CREATE TABLE fhemconfig (
        `COMMAND`       VARCHAR ( 32 ),
        `DEVICE`        VARCHAR ( 64 ),
        `P1`    VARCHAR ( 50 ),
        `P2`    TEXT,
        `VERSION`       INT,
        `VERSIONUUID`   CHAR ( 50 )
);
CREATE TABLE fhemb64filesave (
        `filename`      TEXT,
        `content`       BLOB
);
CREATE INDEX config_idx ON fhemconfig (
        `versionuuid`,
        `version`
);

FLUSH PRIVILEGES;


Und ein googlen nach 'mysql blob size' sagt dann:

ZitatTINYBLOB   from 0 to 255 bytes
BLOB   from 0 to 65535 bytes
MEDIUMBLOB   from 0 to 16 777 215 bytes
LONGBLOB   from 0 to 4 294 967 295 bytes

Kann das sein, dass das meine Fehlerquelle ist??

betateilchen

Sorry, ich habe aktuell aus familiären Gründen keine Zeit, mich intensiv mit FHEM zu beschäftigen.

Aber zwei Dinge fallen mir in Deinem letzten Beitrag sofort auf:


  • Du verwendest die gleiche Datenbank (fhem) für DbLog UND für configDB - davon habe ich in der Vergangenheit regelmäßig abgeraten, weil das auch schonmal zu Problemen führte.
  • configDB verwendet in der Tabelle 'fhemb64filesave' für das Feld 'content' standardmäßig den Datentyp MEDIUMBLOB und nicht BLOB


# create TABLE fhemb64filesave if nonexistent
if($cfgDB_dbtype eq "MYSQL") {
$fhem_dbh->do("CREATE TABLE IF NOT EXISTS fhemb64filesave(filename TEXT, content MEDIUMBLOB)");


Offenbar wurden die Tabellen in Deiner Datenbank nicht von configDB selbst angelegt.
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

Zitat von: betateilchen am 09 April 2022, 14:44:56
Sorry, ich habe aktuell aus familiären Gründen keine Zeit, mich intensiv mit FHEM zu beschäftigen.

Aber zwei Dinge fallen mir in Deinem letzten Beitrag sofort auf:


  • Du verwendest die gleiche Datenbank (fhem) für DbLog UND für configDB - davon habe ich in der Vergangenheit regelmäßig abgeraten, weil das auch schonmal zu Problemen führte.
  • configDB verwendet in der Tabelle 'fhemb64filesave' für das Feld 'content' standardmäßig den Datentyp MEDIUMBLOB und nicht BLOB


# create TABLE fhemb64filesave if nonexistent
if($cfgDB_dbtype eq "MYSQL") {
$fhem_dbh->do("CREATE TABLE IF NOT EXISTS fhemb64filesave(filename TEXT, content MEDIUMBLOB)");


Offenbar wurden die Tabellen in Deiner Datenbank nicht von configDB selbst angelegt.

Die Datenbank selbst wurde vom init-script bei der Erstellung des Docker-Containers angelegt. Und ich glaube, das muss auch erstmal so so sein, denn sonst läuft das ganze Docker-konstrukt nicht hoch.

Und ja, ich nutze configDB und LogDB in einer Datenbank. Ich hatte die letzten 3 Jahre damit keine Probleme... zumindest nicht bewusst. Aber da ich mich jetzt intensiv mit dem Thema Docker, fhem und Datenbank beschäftigt habe werde ich zeitnah nochmal den Versuch alles in die MariaDB umzuziehen starten.

Das Problem lag tatsächlich im Unterschied "BLOB" und "MEDIUMBLOB". Ich habe das Initscript geändert, alle Daten der Datenbank gelöscht und sie erneut gebildet. Danach habe ich einen SQL-Dump per Befehlszeile wieder eingespielt (was aufgrund der History mehrere Stunden gedauert hat) und nun funktioniert alles wieder wie gewollt.
Danke für die Unterstützung und für eure Geduld.

:)

Wernieman

Mit anderen Worten war es kein Docker/FHEM Problem, sondern ein Datenbank-Anlegen-Problem .....
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

betateilchen

-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

betateilchen

Zitat von: persching am 10 April 2022, 08:48:34
Die Datenbank selbst wurde vom init-script bei der Erstellung des Docker-Containers angelegt. Und ich glaube, das muss auch erstmal so so sein, denn sonst läuft das ganze Docker-konstrukt nicht hoch.

Bitte verwechsle nicht "Anlegen der Datenbank" und "Anlegen von Tabellen in der Datenbank".
-----------------------
Formuliere die Aufgabe möglichst einfach und
setze die Lösung richtig um - dann wird es auch funktionieren.
-----------------------
Lesen gefährdet die Unwissenheit!

persching

So und weil ich jetzt gerade so schön im Flow war habe ich jetzt einen Umzug von mysql 5.7 zu mariadb:latest im Docker gemacht und dann auch gleich noch berücksichtigt, dass ich 2 Datenbanken erstelle... eine fhem die alle configs enthält und eine fhemlog mit current und history. :)

Mal schauen, ob das alles dann so funktioniert. Im Moment sieht es gut aus. Ich kann alles speichern, Docker neu starten und alles läuft prima.