gelöst: Problem mit EM1000WZ (extrem hohe Werte)

[synaps-o-dan]

Hallo zusammen,
mein EM1000WZ Funk-Sensor für Drehstromzähler hat urplötzlich angefangen zu spinnen. Er sendet auf einmal unrealistisch hohe Werte, hier ein Auszug aus der log-Datei:

Code Auswählen Erweitern


2016-06-02_21:19:47 EM_Hauptzaehler CNT: 234 CUM: 237204000.000  5MIN: 3600.000  TOP: 3321.033
2016-06-02_21:24:47 EM_Hauptzaehler CNT: 235 CUM: 237240000.000  5MIN: 3600.000  TOP: 3435.115
2016-06-02_21:29:48 EM_Hauptzaehler CNT: 236 CUM: 237276000.000  5MIN: 3600.000  TOP: 5113.636
2016-06-02_21:35:44 EM_Hauptzaehler CNT: 1 CUM: 237276000.000  5MIN: 0.000  TOP: 0.000
2016-06-02_21:40:45 EM_Hauptzaehler CNT: 2 CUM: 237504000.000  5MIN: 22800.000  TOP: 27480.916
2016-06-02_21:45:45 EM_Hauptzaehler CNT: 3 CUM: 237564000.000  5MIN: 6000.000  TOP: 6060.606
2016-06-02_21:46:24 EM_Hauptzaehler CNT: 3 CUM: 237564000.000  5MIN: 6000.000  TOP: 6060.606

Um 21:35:44 habe ich ihn kurz stromlos gemacht, aber das hat nichts gebracht. Die Erkennung der roten Markierung auf der Zählerscheibe funktioniert zuverlässig. Die RSSI-Werte liegen bei etwa -60 im Durchschnitt. Ich bekomme zuverlässig alle fünf Minuten ein Reading des Sensors. Zu dem Zeitpunkt, an dem der Fehler aufgetreten ist, ist nichts am System (fhem, Raspi, Verkabelung, ...) geändert worden (es war mitten in der Nacht).
Hat irgendwer schon mal so ein Verhalten beobachtet und kann mir einen Tipp geben, wie ich den Funk-Sensor wieder reparieren kann?
Vielen Dank im Voraus und viele Grüße,
Daniel

[rudolfkoenig]

Kannst du bitte einen Log-Ausschnitt nach "attr CUL verbose 5" hier anhaengen?

[synaps-o-dan]

Vielen Dank für eine erneute Hilfestellung zu einer Frage zu SlowRF-Geräten.
Hier ist der Auszug des Logfile, wenn ich den loglevel des EM1000WZ hochdrehe:

Code Auswählen Erweitern

2016.06.03 19:48:20 5: CUL_EM EM_Hauptzaehler: CNT: 13 CUM: 935  5MIN: 6  TOP: 207
2016.06.03 19:48:20 4: CUL_EM EM_Hauptzaehler: CNT: 13 CUM: 248496000.000  5MIN: 7200.000  TOP: 17391.304
2016.06.03 19:53:21 5: CUL_EM EM_Hauptzaehler: CNT: 14 CUM: 940  5MIN: 5  TOP: 619
2016.06.03 19:53:21 4: CUL_EM EM_Hauptzaehler: CNT: 14 CUM: 248556000.000  5MIN: 6000.000  TOP: 5815.832
2016.06.03 19:58:21 5: CUL_EM EM_Hauptzaehler: CNT: 15 CUM: 943  5MIN: 3  TOP: 983
2016.06.03 19:58:21 4: CUL_EM EM_Hauptzaehler: CNT: 15 CUM: 248592000.000  5MIN: 3600.000  TOP: 3662.258
Zu jeder Übermittlung zwei verschiedene Sets von Werten?

Wenn ich den CUL im loglevel hochschraube, erhalte ich folgendes Reading, welches ich zeitlich dem EM_Hauptzaehler zuordne (Eintrag im Logfile und im FileLog sind ungefähr zeitlich passend):

Code Auswählen Erweitern

2016.06.03 20:27:58 4: CUL_Parse: myCUL 0102UT1A3800AA00F4;
2016.06.03 20:27:58 5: myCUL dispatch 0102UT1A3800AA00F4;
2016.06.03 20:28:20 5: CUL/RAW: /T9CA6D402EF


Hilft das?
Grüße,
Daniel

[rudolfkoenig]

Eintrag im Logfile und im FileLog sind ungefähr zeitlich passend

Kann nicht wirklich nachvollziehen, wie du auf diese Idee kommst: 2016.06.03 19:58:21 vs. 2016.06.03 20:27:58

Ich haette gerne mehr Daten (== mehr Zeilen), und vom CUL_EM. Du hast das Output von 2 FHTs gepostet, einmal direkt empfangen, und einmal ueber ein RFR. CUL_EM Rohdaten fangen mit E an (oder mit 0102UE, falls ueber RFR), und sind deutlich laenger.

[synaps-o-dan]

Alles klar, hier sind readings, die von dem betroffenen EM1000WZ stammen:

Code Auswählen Erweitern

2016.06.03 21:18:31 5: CUL/RAW: /E01011F20040300A4031D

2016.06.03 21:18:31 4: CUL_Parse: myCUL E01011F20040300A4031D -59.5
2016.06.03 21:18:31 5: myCUL dispatch E01011F20040300A403

2016.06.03 21:23:31 5: CUL/RAW: /E010120230403008F031D

2016.06.03 21:23:31 4: CUL_Parse: myCUL E010120230403008F031D -59.5
2016.06.03 21:23:31 5: myCUL dispatch E010120230403008F03

2016.06.03 21:28:32 5: CUL/RAW: /E01012126040300B3031F

2016.06.03 21:28:32 4: CUL_Parse: myCUL E01012126040300B3031F -58.5
2016.06.03 21:28:32 5: myCUL dispatch E01012126040300B303

2016.06.03 21:33:33 5: CUL/RAW: /E01012229040300AB041B

2016.06.03 21:33:33 4: CUL_Parse: myCUL E01012229040300AB041B -60.5
2016.06.03 21:33:33 5: myCUL dispatch E01012229040300AB04

2016.06.03 21:38:33 5: CUL/RAW: /E0101232C040300DD031C

2016.06.03 21:38:33 4: CUL_Parse: myCUL E0101232C040300DD031C -60
2016.06.03 21:38:33 5: myCUL dispatch E0101232C040300DD03


(Ich hofe, ich habe die richtigen Zeilen herauskopiert!)

Grüße,
Daniel

edit: ich hatte ein paar Zeilen mit FHT statt EM. Gibt es in der Commandref, der Wiki oder im Forum irgendwo eine Erklärung, wie ich Raw Messages dekodieren kann? Mit Google habe ich nix gefunden. (rein interessehalber)

[rudolfkoenig]

2016.06.03 21:18:31 5: CUL/RAW: /E01011F20040300A4031D

Die Nachricht scheint OK zu sein, wenn ich das in meinem Testsystem einspeise, bekomme ich sinnvolle Werte:

Code Auswählen Erweitern

fhem> { Dispatch($defs{CUL}, "E01011F20040300A403", undef) }
2016-06-04 15:49:35.078 CUL_EM emwz CNT: 31 CUM: 83879.713  5MIN: 0.480  TOP: 0.515
2016-06-04 15:49:35.078 CUL_EM emwz cum_month: CUM_MONTH: 146.106 CUM: 83879.713 COST: 0.00
2016-06-04 15:49:35.078 CUL_EM emwz tsecs: 1465048175
2016-06-04 15:49:35.078 CUL_EM emwz seqno: 31
2016-06-04 15:49:35.078 CUL_EM emwz cum_day: CUM_DAY: 41948.103 CUM: 83879.713 COST: 0.00
2016-06-04 15:49:35.078 CUL_EM emwz peak: 0.515021459227468
2016-06-04 15:49:35.078 CUL_EM emwz total: 83879.7133333333
2016-06-04 15:49:35.078 CUL_EM emwz basis: 6289922.5
2016-06-04 15:49:35.078 CUL_EM emwz current_cnt: 3
2016-06-04 15:49:35.078 CUL_EM emwz total_cnt: 1056
2016-06-04 15:49:35.078 CUL_EM emwz current: 0.48
2016-06-04 15:49:35.078 CUL_EM emwz RAW: CNT: 31 CUM: 1056  5MIN: 3  TOP: 932
2016-06-04 15:49:35.078 CUL_EM emwz peak_cnt: 932

Sind die mit diesen Daten gleichzeitig protokollierten Daten im FileLog auch kaputt?

Raw Messages sind fuers Modul (Open Source!) oder fuer den Entwickler.
Eine generische Doku gibts dafuer mWn nicht, wenn manche Entwickler das machen, das ist lobenswert aber keine Pflicht.

[synaps-o-dan]

Danke für die Antwort! Ich habe mal den Befehl

Code Auswählen Erweitern

{ Dispatch($defs{CUL}, "E01011F20040300A403", undef) }
in das Kommandofeld eingegeben. Ergebnis:

Code Auswählen Erweitern

2016-06-04_16:17:08 EM_Hauptzaehler CNT: 31 CUM: 267972000.000  5MIN: 3600.000  TOP: 3862.661
Im Filelog wird für die RawMsg E01011F20040300A403 folgendes mitgeloggt:

Code Auswählen Erweitern

2016-06-03_21:18:31 EM_Hauptzaehler CNT: 31 CUM: 249948000.000  5MIN: 3600.000  TOP: 3862.661
2016-06-03_21:18:31 EM_Hauptzaehler RSSI: -59.5
Das Parsing der message führt definitv zu unsinnigen Werten. Ich denke, ich werde in meiner  15_CUL_EM.pm versuchen, weitere log-Ausgaben einzubauen, um zu sehen, was an das Parsing übergeben wird und was herauskommt (vorher mache ich besser eine Sicherungskopie...)
Grüße,
Daniel

[synaps-o-dan]

Argh, jetzt wird's peinlich. Ich habe dann doch selbst herausgefunden, woran es liegt. Man (in dem Fall: ich) sollte einem EM1000WZ auch die richtigen Korrekturwerte corr1 und corr2 verpassen. Das hätte ich auch ohne Forum herausfinden können. Sorry wegen der unnötigen Frage!!!
Grüße,
Daniel