unplausible Daten mit FHEM 5.5 + CULV3 + ESA2000

Begonnen von Wickerl, 06 März 2014, 14:40:37

Vorheriges Thema - Nächstes Thema

Wickerl

Hallo an alle,

ich habe schon seit einem Jahr einen Verbrauchslogger am laufen welcher mir per ESA2000 die Verbräuche an den CUL übergibt.
Allerdings habe ich das Problem dass sporadisch FHEM mir falsche/unplausible Werte anzeigt und dadurch alles verfälscht wird.

Im Logfile sieht man dann immer diese komischen Werte:

xx.xx.xx. day: 2.26099999999999
xx.xx.xx. CUR_hr: 2.2299999999999
...
xx.xx.xx. CNT: CUM: CUR: -1.0000 TICKS: 1000

Wobei im Logfile auffällt dass day und cur_hr normalerweise nur drei stellen hinter seperator haben z.B.: 2.123
Im Fehlerfall aber erscheinen nochmals zusätzlich 11*9 resp. 2.12399999999999 und im gleichem Atemzug ist im Logfile CUR: -1.000

Es ist unlogisch dass der Zähler auf einmal minus 1KW mir anzeigt wenn ich nur eine 500Watt PV-Anlage am laufen habe und im Moment
nur 100W erzeugt werden. Der Zähler ELTAKO mit SO-Bus zeigt mir auch alles korrekt an. Nur kann ich nicht am ESA2000 schauen
was eigentlich dass Problem ist dass es mal wochenlang funkrioniert und so wie heute pünktlich um 12:00 12:50 13:40 meine Leistung -1KW beträgt.

Ich weiß erhlich gesagt nicht wo der Fehler liegt und warum im Logfile die 11*9 zusätzlich herkommt. Meine Vermuting ist nämlich dass Aufgrund dieser Zahl Perl dann
abkachelt und 12e-17 in der Statistik mit als Wert ausgibt. Kennt jemand dieses Phänomen?

Hier das Logfile wenn unmittelbar vor Auftreten des Fehlers:

2014-03-06_14:03:49 ESAx000WZ_18d6 repeat: -
2014-03-06_14:03:49 ESAx000WZ_18d6 sequence: 62
2014-03-06_14:03:49 ESAx000WZ_18d6 total_ticks: 138790
2014-03-06_14:03:49 ESAx000WZ_18d6 actual_ticks: 4
2014-03-06_14:03:49 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:03:49 ESAx000WZ_18d6 raw: CNT: 62- CUM: 138790 CUR: 4  TICKS: 1000 HR
2014-03-06_14:03:49 ESAx000WZ_18d6 total: 420.611999999981
2014-03-06_14:03:49 ESAx000WZ_18d6 actual: 0.00968392737054472
2014-03-06_14:03:49 ESAx000WZ_18d6 diff: 0.0040
2014-03-06_14:03:49 ESAx000WZ_18d6 diff_sec: 1487
2014-03-06_14:03:49 ESAx000WZ_18d6 diff_ticks: 4
2014-03-06_14:03:49 ESAx000WZ_18d6 last_sec: 1394111029
2014-03-06_14:03:49 ESAx000WZ_18d6 raw_total: 138.79
2014-03-06_14:03:49 ESAx000WZ_18d6 day: 2.217
2014-03-06_14:03:49 ESAx000WZ_18d6 month: 41.9500000000003
2014-03-06_14:03:49 ESAx000WZ_18d6 year: 117.763000000002
2014-03-06_14:03:49 ESAx000WZ_18d6 rate: HR
2014-03-06_14:03:49 ESAx000WZ_18d6 day_hr: 1.476
2014-03-06_14:03:49 ESAx000WZ_18d6 month_hr: 13.6019999999999
2014-03-06_14:03:49 ESAx000WZ_18d6 year_hr: 39.9180000000003
2014-03-06_14:03:49 ESAx000WZ_18d6 hour: 0.004
2014-03-06_14:03:49 ESAx000WZ_18d6 hour_last: 0.107
2014-03-06_14:03:49 ESAx000WZ_18d6 type: ESAx000WZ
2014-03-06_14:03:49 ESAx000WZ_18d6 CNT: 62- CUM: 420.612 CUR: 0.010 TICKS: 1000 HR
2014-03-06_14:03:49 ESAx000WZ_18d6 repeat: -
2014-03-06_14:03:49 ESAx000WZ_18d6 sequence: 63
2014-03-06_14:03:49 ESAx000WZ_18d6 total_ticks: 138796
2014-03-06_14:03:49 ESAx000WZ_18d6 actual_ticks: 6
2014-03-06_14:03:49 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:03:49 ESAx000WZ_18d6 raw: CNT: 63- CUM: 138796 CUR: 6  TICKS: 1000 HR
2014-03-06_14:03:49 ESAx000WZ_18d6 total: 420.617999999981
2014-03-06_14:03:49 ESAx000WZ_18d6 actual: -1
2014-03-06_14:03:49 ESAx000WZ_18d6 diff: 0.0060
2014-03-06_14:03:49 ESAx000WZ_18d6 diff_sec: 0
2014-03-06_14:03:49 ESAx000WZ_18d6 diff_ticks: 6
2014-03-06_14:03:49 ESAx000WZ_18d6 last_sec: 1394111029
2014-03-06_14:03:49 ESAx000WZ_18d6 raw_total: 138.796
2014-03-06_14:03:49 ESAx000WZ_18d6 day: 2.22299999999999
2014-03-06_14:03:49 ESAx000WZ_18d6 month: 41.9560000000003
2014-03-06_14:03:49 ESAx000WZ_18d6 year: 117.769000000002
2014-03-06_14:03:49 ESAx000WZ_18d6 rate: HR
2014-03-06_14:03:49 ESAx000WZ_18d6 day_hr: 1.482
2014-03-06_14:03:49 ESAx000WZ_18d6 month_hr: 13.6079999999999
2014-03-06_14:03:49 ESAx000WZ_18d6 year_hr: 39.9240000000003
2014-03-06_14:03:49 ESAx000WZ_18d6 hour: 0.01
2014-03-06_14:03:49 ESAx000WZ_18d6 type: ESAx000WZ
2014-03-06_14:03:49 ESAx000WZ_18d6 CNT: 63- CUM: 420.618 CUR: -1.000 TICKS: 1000 HR
2014-03-06_14:03:49 ESAx000WZ_18d6 repeat: -
2014-03-06_14:03:49 ESAx000WZ_18d6 sequence: 64
2014-03-06_14:03:49 ESAx000WZ_18d6 total_ticks: 138802
2014-03-06_14:03:49 ESAx000WZ_18d6 actual_ticks: 6
2014-03-06_14:03:49 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:03:49 ESAx000WZ_18d6 raw: CNT: 64- CUM: 138802 CUR: 6  TICKS: 1000 HR
2014-03-06_14:03:49 ESAx000WZ_18d6 total: 420.623999999981


Ciao
Wickerl






Wickerl

Hier mal ein Auszug aus dem Logfile, komischer Weise erholt sich das wieder wie man unten sehen kann:

2014-03-06_14:03:50 ESAx000WZ_18d6 repeat: -
2014-03-06_14:03:50 ESAx000WZ_18d6 sequence: 71
2014-03-06_14:03:50 ESAx000WZ_18d6 total_ticks: 138834
2014-03-06_14:03:50 ESAx000WZ_18d6 actual_ticks: 3
2014-03-06_14:03:50 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:03:50 ESAx000WZ_18d6 raw: CNT: 71- CUM: 138834 CUR: 3  TICKS: 1000 HR
2014-03-06_14:03:50 ESAx000WZ_18d6 total: 420.655999999981
2014-03-06_14:03:50 ESAx000WZ_18d6 actual: -1
2014-03-06_14:03:50 ESAx000WZ_18d6 diff: 0.0030
2014-03-06_14:03:50 ESAx000WZ_18d6 diff_sec: 0
2014-03-06_14:03:50 ESAx000WZ_18d6 diff_ticks: 3
2014-03-06_14:03:50 ESAx000WZ_18d6 last_sec: 1394111030
2014-03-06_14:03:50 ESAx000WZ_18d6 raw_total: 138.834
2014-03-06_14:03:50 ESAx000WZ_18d6 day: 2.26099999999999
2014-03-06_14:03:50 ESAx000WZ_18d6 month: 41.9940000000003
2014-03-06_14:03:50 ESAx000WZ_18d6 year: 117.807000000002
2014-03-06_14:03:50 ESAx000WZ_18d6 rate: HR
2014-03-06_14:03:50 ESAx000WZ_18d6 day_hr: 1.52
2014-03-06_14:03:50 ESAx000WZ_18d6 month_hr: 13.6459999999999
2014-03-06_14:03:50 ESAx000WZ_18d6 year_hr: 39.9620000000003
2014-03-06_14:03:50 ESAx000WZ_18d6 hour: 0.048
2014-03-06_14:03:50 ESAx000WZ_18d6 type: ESAx000WZ
2014-03-06_14:03:50 ESAx000WZ_18d6 CNT: 71- CUM: 420.656 CUR: -1.000 TICKS: 1000 HR
2014-03-06_14:06:20 ESAx000WZ_18d6 repeat: -
2014-03-06_14:06:20 ESAx000WZ_18d6 sequence: 72
2014-03-06_14:06:20 ESAx000WZ_18d6 total_ticks: 138838
2014-03-06_14:06:20 ESAx000WZ_18d6 actual_ticks: 4
2014-03-06_14:06:20 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:06:20 ESAx000WZ_18d6 raw: CNT: 72- CUM: 138838 CUR: 4  TICKS: 1000 HR
2014-03-06_14:06:20 ESAx000WZ_18d6 total: 420.659999999981
2014-03-06_14:06:20 ESAx000WZ_18d6 actual: 0.096
2014-03-06_14:06:20 ESAx000WZ_18d6 diff: 0.0040
2014-03-06_14:06:20 ESAx000WZ_18d6 diff_sec: 150
2014-03-06_14:06:20 ESAx000WZ_18d6 diff_ticks: 4
2014-03-06_14:06:20 ESAx000WZ_18d6 last_sec: 1394111180
2014-03-06_14:06:20 ESAx000WZ_18d6 raw_total: 138.838
2014-03-06_14:06:20 ESAx000WZ_18d6 day: 2.26499999999999
2014-03-06_14:06:20 ESAx000WZ_18d6 month: 41.9980000000003
2014-03-06_14:06:20 ESAx000WZ_18d6 year: 117.811000000002
2014-03-06_14:06:20 ESAx000WZ_18d6 rate: HR
2014-03-06_14:06:20 ESAx000WZ_18d6 day_hr: 1.524
2014-03-06_14:06:20 ESAx000WZ_18d6 month_hr: 13.6499999999999
2014-03-06_14:06:20 ESAx000WZ_18d6 year_hr: 39.9660000000003
2014-03-06_14:06:20 ESAx000WZ_18d6 hour: 0.052
2014-03-06_14:06:20 ESAx000WZ_18d6 type: ESAx000WZ
2014-03-06_14:06:20 ESAx000WZ_18d6 CNT: 72- CUM: 420.660 CUR: 0.096 TICKS: 1000 HR
2014-03-06_14:08:56 ESAx000WZ_18d6 repeat: +
2014-03-06_14:08:56 ESAx000WZ_18d6 sequence: 73
2014-03-06_14:08:56 ESAx000WZ_18d6 total_ticks: 138841
2014-03-06_14:08:56 ESAx000WZ_18d6 actual_ticks: 3
2014-03-06_14:08:56 ESAx000WZ_18d6 ticks: 1000
2014-03-06_14:08:56 ESAx000WZ_18d6 raw: CNT: 73+ CUM: 138841 CUR: 3  TICKS: 1000 HR
2014-03-06_14:08:56 ESAx000WZ_18d6 total: 420.662999999981
2014-03-06_14:08:56 ESAx000WZ_18d6 actual: 0.0692307692307692
2014-03-06_14:08:56 ESAx000WZ_18d6 diff: 0.0030
2014-03-06_14:08:56 ESAx000WZ_18d6 diff_sec: 156
2014-03-06_14:08:56 ESAx000WZ_18d6 diff_ticks: 3
2014-03-06_14:08:56 ESAx000WZ_18d6 last_sec: 1394111336
2014-03-06_14:08:56 ESAx000WZ_18d6 raw_total: 138.841
2014-03-06_14:08:56 ESAx000WZ_18d6 day: 2.26799999999999
2014-03-06_14:08:56 ESAx000WZ_18d6 month: 42.0010000000003
2014-03-06_14:08:56 ESAx000WZ_18d6 year: 117.814000000002
2014-03-06_14:08:56 ESAx000WZ_18d6 rate: HR
2014-03-06_14:08:56 ESAx000WZ_18d6 day_hr: 1.527
2014-03-06_14:08:56 ESAx000WZ_18d6 month_hr: 13.6529999999999
2014-03-06_14:08:56 ESAx000WZ_18d6 year_hr: 39.9690000000003
2014-03-06_14:08:56 ESAx000WZ_18d6 hour: 0.055
2014-03-06_14:08:56 ESAx000WZ_18d6 type: ESAx000WZ
2014-03-06_14:08:56 ESAx000WZ_18d6 CNT: 73+ CUM: 420.663 CUR: 0.069 TICKS: 1000 HR

stromer-12

Das -1 bedeutet, das nicht plausible Werte empfangen wurden. Bei dir zB. wurden deinem log zufolge angeblich 10 Datentelegramme innerhalb einer Sekunde empfangen. Der Abstand zwischen 2 Telegrammen beträgt normalerweise 120 bis 180 Sekunden.  Bei dir scheint etwas in fhem zu klemmen. Bei mir wurde durch solch einen Klemmer die Reihenfolge vertauscht.
FHEM (SVN) auf RPi1B mit HMser | ESPLink
FHEM (SVN) virtuell mit HMLAN | HMUSB | CUL