angeblich keine Daten geloggt

[rabehd]

Macht er ohne zu murren.

Code Auswählen Erweitern

2024.01.09 21:31:11 3: DbRep logdb.Serv - ################################################################
2024.01.09 21:31:11 3: DbRep logdb.Serv - ###                    new reduceLog run                     ###
2024.01.09 21:31:11 3: DbRep logdb.Serv - ################################################################
2024.01.09 21:31:11 4: DbRep logdb.Serv - -------- New selection ---------
2024.01.09 21:31:11 4: DbRep logdb.Serv - Command: reduceLog 1
2024.01.09 21:31:11 4: DbRep logdb.Serv - timeOlderThan - year: , day: 1, hour: , min: , sec:
2024.01.09 21:31:11 4: DbRep logdb.Serv - Year 2024 is leap year
2024.01.09 21:31:11 4: DbRep logdb.Serv - startMonth: 0 endMonth: 0 lastleapyear: 2024 baseYear: 2024 diffdaylight:0 isdaylight:0
2024.01.09 21:31:11 4: DbRep logdb.Serv - FullDay option: 1
2024.01.09 21:31:11 5: DbRep logdb.Serv - Timestamp begin epocheseconds: 1704754800
2024.01.09 21:31:11 4: DbRep logdb.Serv - Timestamp begin human readable: 2024-01-09 00:00:00
2024.01.09 21:31:11 5: DbRep logdb.Serv - Timestamp end epocheseconds: 1704754799
2024.01.09 21:31:11 4: DbRep logdb.Serv - Timestamp end human readable: 2024-01-08 23:59:59


[DS_Starter]

Naja nicht wirklich Begin ist jünger als Ende Zeitstempel. Aber durch die Tests sehe ich wo der Abbruch erfolgt.
Ich baue eine bessere Ausgabe ein und melde mich gleich wieder.

[DS_Starter]

So, im contrib liegt ein Update des DbRep. Zieh dir das bitte und für den Test wieder aus.
Es sollte eine bessere Ausgabe im Log kommen.

[rabehd]

Die Version hat sich nicht geändert?
93_DbRep.pm:v8.53.0-s28267/2023-12-08

[DS_Starter]

Ja, V ist gleich. Nur upgedated.

[rabehd]

wie üblich erst reduziert, dann gezählt.
Bisher keine Zählergebnisse in der Reihenfolge.
Bei erneuten Zählen direkt danach kommen Ergebnisse.
(ich kann morgen weitermachen)

Code Auswählen Erweitern

2024.01.09 22:11:44 3: DbRep logdb.Serv - ################################################################
2024.01.09 22:11:44 3: DbRep logdb.Serv - ###                    new reduceLog run                     ###
2024.01.09 22:11:44 3: DbRep logdb.Serv - ################################################################
2024.01.09 22:11:44 4: DbRep logdb.Serv - -------- New selection ---------
2024.01.09 22:11:44 4: DbRep logdb.Serv - Command: reduceLog 1:1
2024.01.09 22:11:44 4: DbRep logdb.Serv - timeDiffToNow - year: , day: 1, hour: , min: , sec:
2024.01.09 22:11:44 4: DbRep logdb.Serv - Year 2024 is leap year
2024.01.09 22:11:44 4: DbRep logdb.Serv - startMonth: 0 endMonth: 0 lastleapyear: 2024 baseYear: 2024 diffdaylight:0 isdaylight:0
2024.01.09 22:11:44 4: DbRep logdb.Serv - timeOlderThan - year: 0, day: 1, hour: 0, min: 0, sec: 0
2024.01.09 22:11:44 4: DbRep logdb.Serv - Year 2024 is leap year
2024.01.09 22:11:44 4: DbRep logdb.Serv - startMonth: 0 endMonth: 0 lastleapyear: 2024 baseYear: 2024 diffdaylight:0 isdaylight:0
2024.01.09 22:11:44 4: DbRep logdb.Serv - FullDay option: 1
2024.01.09 22:11:44 4: DbRep logdb.Serv - Time difference to current time for calculating Timestamp begin: 86401 sec
2024.01.09 22:11:44 5: DbRep logdb.Serv - Timestamp begin epocheseconds: 1704668400
2024.01.09 22:11:44 4: DbRep logdb.Serv - Timestamp begin human readable: 2024-01-08 00:00:00
2024.01.09 22:11:44 5: DbRep logdb.Serv - Timestamp end epocheseconds: 1704754799
2024.01.09 22:11:44 4: DbRep logdb.Serv - Timestamp end human readable: 2024-01-08 23:59:59
2024.01.09 22:11:44 2: DbRep logdb.Serv - ERROR - The Timestamp of the oldest dataset (1704779940) is newer than specified end time (1704754799)
2024.01.09 22:11:49 4: DbRep logdb.Serv - -------- New selection ---------
2024.01.09 22:11:49 4: DbRep logdb.Serv - Command: countEntries history
2024.01.09 22:11:49 4: DbRep logdb.Serv - timeDiffToNow - year: , day: 1, hour: , min: , sec:
2024.01.09 22:11:49 4: DbRep logdb.Serv - Year 2024 is leap year
2024.01.09 22:11:49 4: DbRep logdb.Serv - startMonth: 0 endMonth: 0 lastleapyear: 2024 baseYear: 2024 diffdaylight:0 isdaylight:0
2024.01.09 22:11:49 4: DbRep logdb.Serv - timeOlderThan - year: 0, day: 1, hour: 0, min: 0, sec: 0
2024.01.09 22:11:49 4: DbRep logdb.Serv - Year 2024 is leap year
2024.01.09 22:11:49 4: DbRep logdb.Serv - startMonth: 0 endMonth: 0 lastleapyear: 2024 baseYear: 2024 diffdaylight:0 isdaylight:0
2024.01.09 22:11:49 4: DbRep logdb.Serv - FullDay option: 1
2024.01.09 22:11:49 4: DbRep logdb.Serv - Time difference to current time for calculating Timestamp begin: 86401 sec
2024.01.09 22:11:49 5: DbRep logdb.Serv - Timestamp begin epocheseconds: 1704668400
2024.01.09 22:11:49 4: DbRep logdb.Serv - Timestamp begin human readable: 2024-01-08 00:00:00
2024.01.09 22:11:49 5: DbRep logdb.Serv - Timestamp end epocheseconds: 1704754799
2024.01.09 22:11:49 4: DbRep logdb.Serv - Timestamp end human readable: 2024-01-08 23:59:59
2024.01.09 22:11:49 4: DbRep logdb.Serv - Aggregation: no
2024.01.09 22:11:49 5: DbRep logdb.Serv - BlockingCall with PID "26428" started
2024.01.09 22:11:49 4: DbRep logdb.Serv - Database connect - user: fhemuser, UTF-8 option set: yes
2024.01.09 22:11:49 4: DbRep logdb.Serv - SQL execute: SHOW VARIABLES LIKE 'collation_database'
2024.01.09 22:11:49 4: DbRep logdb.Serv - Database Character set is >utf8mb4_bin<
2024.01.09 22:11:49 4: DbRep logdb.Serv - simple do statement: set names "utf8mb4" collate "utf8mb4_bin"
2024.01.09 22:11:49 5: DbRep logdb.Serv - IsTimeSet: 1, IsAggrSet: 0
2024.01.09 22:11:49 5: DbRep logdb.Serv - Timestamp-Array:
no_aggregation#2024-01-08 00:00:00#2024-01-08 23:59:59
2024.01.09 22:11:49 5: DbRep logdb.Serv - Devices for operation -
included (1): %
included with wildcard: 
excluded (0): 
excluded with wildcard:
2024.01.09 22:11:49 5: DbRep logdb.Serv - Readings for operation -
included (1): %
included with wildcard: 
excluded (0): 
excluded with wildcard:
2024.01.09 22:11:49 4: DbRep logdb.Serv - SQL execute: SELECT READING, COUNT(*) FROM history where TIMESTAMP >= '2024-01-08 00:00:00' AND TIMESTAMP <= '2024-01-08 23:59:59' group by READING;
2024.01.09 22:11:49 5: DbRep logdb.Serv - BlockingCall PID "26428" finished
2024.01.09 22:11:49 5: DbRep logdb.Serv - SQL result decoded: no_aggregation#ALLREADINGS#0#2024-01-08|

[DS_Starter]

Jetzt sehen wir den Abbruch genau und auch den Grund:

Code Auswählen Erweitern

....
2024.01.09 22:11:44 4: DbRep logdb.Serv - Timestamp end human readable: 2024-01-08 23:59:59
2024.01.09 22:11:44 2: DbRep logdb.Serv - ERROR - The Timestamp of the oldest dataset (1704779940) is newer than specified end time (1704754799)

Dadurch kommt der Prozess nicht an die Stelle wo der gesetzte temporäre Timestamp bereinigt wird und verhagelt den nachfolgenden Befehl.
An dieser Stelle kann ich jetzt weitermachen und eine Idee entwickeln.
Ich werde wieder ein Update bereitstellen und melde es wieder hier.
Dann können wir ggf. morgen weiter das Ergebnis testen.

[DS_Starter]

Ich das Modul im contrib upgedated. Damit kannst du dann erneut testen.

[rabehd]

Ich das Modul im contrib upgedated. Damit kannst du dann erneut testen.

Mit dem Release tritt der Fehler nicht mehr auf.
Bei "reduceLog 1:1 max=day INCLUDE=%:ENERGY_Power" kommt natürlich keine Fehlermedlung mehr. Deshalb habe ich "2:10 max=day INCLUDE=%:ENERGY_Power" genutzt. Damit kommt die "neue" Meldung.
Der Zählbefehl wird jetzt immer korrekt ausgeführt.
Für mich wäre das Problem damit gelöst.

Danke Dir für die Korrektur und besonders Deinen schnellen Einsatz.

[DS_Starter]

Danke für deine Rückinfo.
Ich werde die Lösung im Modul noch finalisieren und dann auch zeitnah einchecken.

Grüße,
Heiko