DBlog blockiert FHEM völlig wenn keine Verbindung zur DB auf NAS

[Peter aus Calw]

habe vorhin verbose (5) vergessen - jetzt kommt in der Logfile :

Code Auswählen Erweitern

2018.03.09 21:51:17 4: DbLog logdb -> ################################################################
2018.03.09 21:51:17 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 21:51:17 4: DbLog logdb -> ################################################################
2018.03.09 21:51:17 4: DbLog logdb -> number of events received: 1 for device: global
2018.03.09 21:51:17 4: DbLog logdb -> check Device: global , Event: ATTR logdb verbose 5
2018.03.09 21:51:30 3: DbLog logdb: Reopen requested.
2018.03.09 21:51:30 3: DbLog logdb - Creating Push-Handle to database mysql:database=fhem;host=localhost;port=3306 with user fhemuser
2018.03.09 21:51:30 3: DbLog logdb - Push-Handle to db mysql:database=fhem;host=localhost;port=3306 created
2018.03.09 21:51:30 3: DbLog logdb - UTF8 support enabled
2018.03.09 21:51:30 4: DbLog logdb -> ################################################################
2018.03.09 21:51:30 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 21:51:30 4: DbLog logdb -> ################################################################
2018.03.09 21:51:30 4: DbLog logdb -> number of events received: 1 for device: logdb
2018.03.09 21:51:30 4: DbLog logdb -> check Device: logdb , Event: state: connected

[Peter aus Calw]

kann das die Ursache sein ? Hier werden Log-Fehler angezeigt !

Code Auswählen Erweitern

2018.03.09 21:54:55 4: DbLog logdb -> check Device: Bild , Event: connection: active
2018.03.09 21:55:01 4: DbLog logdb -> ################################################################
2018.03.09 21:55:01 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 21:55:01 4: DbLog logdb -> ################################################################
2018.03.09 21:55:01 4: DbLog logdb -> number of events received: 2 for device: Wlan_SMA_WR
2018.03.09 21:55:01 4: DbLog logdb -> check Device: Wlan_SMA_WR , Event: state: present
2018.03.09 21:55:01 4: DbLog logdb -> check Device: Wlan_SMA_WR , Event: presence: present
2018.03.09 21:55:01 4: DbLog logdb -> ################################################################
2018.03.09 21:55:01 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 21:55:0

[DS_Starter]

Hallo Peter,

bin auch nicht mehr der frischeste  .

Asynchmode ist schon ok. Setzte es bitte wieder.
Du kannst dir den Cache anschauen mit "Set <device> listCache".

Zeige mal bitte ein List deines Devices. Ich vermute das DEF ist nicht ok.
Das was du gepostet hast sind keine Fehler.  Das "check" besagt dass das zu loggende Event bewertet wird. Da hinterher das parsed bzw. added Event fehlt (siehe unten) kommen deine Events nicht durch den Regex-Filter.
Erfolgreiche Einträge für den Cache sehen etwa so aus:

Code Auswählen Erweitern


2018.03.09 21:59:49.560 4: DbLog LogDB1 -> ################################################################
2018.03.09 21:59:49.561 4: DbLog LogDB1 -> ###              start of new Logcycle                       ###
2018.03.09 21:59:49.562 4: DbLog LogDB1 -> ################################################################
2018.03.09 21:59:49.562 4: DbLog LogDB1 -> number of events received: 1 for device: USV
2018.03.09 21:59:49.563 4: DbLog LogDB1 -> check Device: USV , Event: state: OL
2018.03.09 21:59:49.564 5: DbLog LogDB1 -> parsed Event: USV , Event: state: OL
2018.03.09 21:59:49.564 4: DbLog LogDB1 -> added event - Timestamp: 2018-03-09 21:59:49, Device: USV, Type: NUT, Event: state: OL, Reading: state, Value: OL, Unit:


[Peter aus Calw]

habe gerade mal im DEF ein bestimmtes Gerät eingetragen "EHT_Zaehlerstand:average",
nun kommt im Logfile :

Code Auswählen Erweitern

2018.03.09 22:01:55 4: DbLog logdb -> ################################################################
2018.03.09 22:01:55 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 22:01:55 4: DbLog logdb -> ################################################################
2018.03.09 22:01:55 4: DbLog logdb -> number of events received: 1 for device: EHT_Zaehlerstand
2018.03.09 22:01:55 4: DbLog logdb -> check Device: EHT_Zaehlerstand , Event: average: 13966.517
inclusive dem richtigen Eintrag.

Hier das List :

Code Auswählen Erweitern

nternals:
   COLUMNS    field length used for Device: 64, Type: 64, Event: 512, Reading: 64, Value: 128, Unit: 32
   CONFIGURATION /opt/fhem/db.conf
   DEF        /opt/fhem/db.conf  EHT_Zaehlerstand:average
   MODE       synchronous
   MODEL      MYSQL
   NAME       logdb
   NOTIFYDEV  EHT_Zaehlerstand
   NR         737
   NTFY_ORDER 50-logdb
   PID        7366
   REGEXP     EHT_Zaehlerstand:average
   STATE      connected
   TYPE       DbLog
   UTF8       1
   VERSION    3.8.8
   dbconn     mysql:database=fhem;host=localhost;port=3306
   dbuser     fhemuser
   Helper:
     COLSET     1
     DEVICECOL  64
     EVENTCOL   512
     OLDSTATE   initialized
     READINGCOL 64
     TYPECOL    64
     UNITCOL    32
     VALUECOL   128
   Readings:
     2018-03-09 22:01:53   countCurrent    0
     2018-03-09 22:01:53   countHistory    0
     2018-03-09 22:01:43   state           connected
   Cache:
     index      0
Attributes:
   DbLogType  Current/History
   cacheEvents 2
   cacheLimit 100
   room       DBlog
   shutdownWait 2
   verbose    5

in meinem biblisches Alter von 72 bestimmt noch nicht ?

[Peter aus Calw]

in listCache wird nichts angezeigt !

[DS_Starter]

in meinem biblisches Alter von 72 bestimmt noch nicht ?

Ok, bis dahin habe ich noch ein bisschen. Alle Achtung dass du dich hier durchwurstelst 

Ja, ich denke ich habe das Problem gesehen. Dein DEF müsste so aussehen:

Code Auswählen Erweitern


DEF        /opt/fhem/db.conf  EHT_Zaehlerstand:average.*


Denn nach "average" kommen noch Zeichen im Event (siehe auch Eventmonitor)

[Peter aus Calw]

Danke für das Lob, das tut gut, aber nach 40 Jahren Fernmeldevermittlungsstellen-Bau in ganz Deutschland habe ich immer noch Spass an diesen Dingen.
Habe das geändert und erscheint auch wieder im Log - aber nicht in FHEM

Code Auswählen Erweitern

2018.03.09 22:36:25 4: DbLog logdb -> ################################################################
2018.03.09 22:36:25 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 22:36:25 4: DbLog logdb -> ################################################################
2018.03.09 22:36:25 4: DbLog logdb -> number of events received: 1 for device: EHT_Zaehlerstand
2018.03.09 22:36:25 4: DbLog logdb -> check Device: EHT_Zaehlerstand , Event: average: 13966.595

wo ist bei mir der Wurm drin ?

[DS_Starter]

Gute Frage wo der Wurm steckt, sollte eigentlich so passen.

Da müssen wir uns rantasten. Ändere bitte das DEF nochmal so:

Code Auswählen Erweitern


DEF        /opt/fhem/db.conf  EHT_Zaehlerstand.*:.*average.*


[Peter aus Calw]

bemerke gerade, daß mein logdb nach ca. 60 sec auf
STATE initialized
springt, ist das ok ?
kann dann nur mit set rereadcfg wieder nach connect.
Glaube, daß ich das morgen nochmal ganz neu installiere, ist die

$Id: 93_DbLog.pm 16336 2018-03-05 21:55:44Z DS_Starter

die neueste (oder beste) Version oder gibt es da was anderes ?

[Peter aus Calw]

wenn ich das so einstelle kommen im Logfile ungebetene :

DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 23:03:01 4: DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> number of events received: 4 for device: 15_Batterie
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd_nr: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd_event: di_battery
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: state: cmd_2
2018.03.09 23:03:01 4: DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 23:03:01 4: DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> number of events received: 5 for device: di_battery
2018.03.09 23:03:01 4: DbLog logdb -> check Device: di_battery , Event: cmd_nr: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: di_battery , Event: cmd_seqnr: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: di_battery , Event: cmd: 2.2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: di_battery , Event: cmd_event: timer_2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: di_battery , Event: state: cmd_2

[DS_Starter]

bemerke gerade, daß mein logdb nach ca. 60 sec auf
STATE initialized
springt, ist das ok ?

Das kommt mir komisch vor, ist bei mir nicht so.

DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> ###              start of new Logcycle                       ###
2018.03.09 23:03:01 4: DbLog logdb -> ################################################################
2018.03.09 23:03:01 4: DbLog logdb -> number of events received: 4 for device: 15_Batterie
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd_nr: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd: 2
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: cmd_event: di_battery
2018.03.09 23:03:01 4: DbLog logdb -> check Device: 15_Batterie , Event: state: cmd_2

Die Events werden nur bewertet (deswegen ausgegeben), aber kommen genauso wenig durch den Filter (ist auch richtig so weil der Regex diese Devices nicht durchlässt). Also insofern ok.

Die Version ist auch die z.Zt. aktuellste.

Schauen wir morgen nochmal weiter. Das kann nicht viel sein.
Gn und VG

Heiko

[Peter aus Calw]

auf jeden Fall noch danke für die Unterstützung und wünsche eine gute Nacht, bin morgen aber auch erst wieder zu späterer Stunde am Gerät.
Tschau

[moskito]

nach 40 Jahren Fernmeldevermittlungsstellen-Bau

Also wenn heutzutage jemand das Wort "Fernmelde" verwendet, werde ich immer ganz sentimental, und mir fallen dann so grundlegende Dinge wieder ein wie: "Amt im Rücken, rechts herum.", Wörter wie "Selbstwählferndienst", oder aber das mechanische Rattern von Hebdrehwählern.

Ist einiges anders geworden...

Aber der Spaß an der Technik bleibt.

Gruß
Danny

[DS_Starter]

@moskito ... ja, damals wars, als ein Wechselplattenspeicher so um die 10 Scheiben mit insg. 250MB hatte und riesig (und schwer) war ... 

@Peter:

bemerke gerade, daß mein logdb nach ca. 60 sec auf
STATE initialized
springt, ist das ok ?

Habe den Grund dafür gefunden. Das ist in der Version normal wenn wie bei dir nichts geloggt wird. Ist etwas ungünstig und für den User beunruhigend. Werde das in der nächsten Version mit ändern.

Spare dir den Aufwand alles neu zu installieren. Sieht ja alles gut aus und das Problem finden wir sicher auch noch.
Setze im DbLog verbose 5 wenn noch nicht geschehen.
Hast du eventuell in den Quelldevices (z.B. in dem Device EHT_Zaehlerstand) das Attribut "DbLogExclude" gesetzt ?
Das würde das Verhalten deines DbLog erklären.

LG,
Heiko

[Peter aus Calw]

Hallo Heiko, hallo Danny,
bin wieder am Ball !
Danny scheint auch schon im Loch gesessen zu haben - Amt im Rücken - rechts rum zählen war wichtig beim spleissen - war das so ?
Habe 1960 mit 14 meine Lehre beim Fernmeldeamt 3 in Stuttgart begonnen und hatte mit 17 ausgelernt.
Dann weg von der Post zum Amtsbau - Monteur -Altmonteur - Obermonteur - techn.Revisor - Teamleiter Revisoren - Montageleiter - Vertriebing. und dann nach Ende der Digitalisierung (203) mit 58 in die Rente.

So wars und jetzt stehen 3 Raspi, 2 Mini-PC und 2 richtige PC um mich rum und beschäftigen mich und Euch (tolle FHEM-Gemeinde).

Heiko, habe gestern Abend das DbLog in FHEM nochmal neu installiert mit dem gleichen Erfolg.
Auf meinem 2. Mini-PC mit der ich meine Hausanlage steuere habe ich die gleiche Problem. 
Mache gerade neue Versuche, es wird in der Logfile gar nichts mehr mit Bezug auf DbLog angezeigt.