Moin, 2016-05-05 20:27 GMT+02:00 Justin Otherguy <jus...@justinotherguy.org>:
> Moin, > > > Am 05.05.2016 um 12:28 schrieb Andreas Goetz <cpui...@gmail.com>: > > > > Servus (ich muss endlich in den Garten ;) > > …war ich schon :D > > > > 2016-05-05 12:12 GMT+02:00 Justin Otherguy <jus...@justinotherguy.org>: > > > ... > >> > >> ok - richtig wäre also, interval nicht zu setzen, wenn ich s0 nutze, > korrekt? > >> > > M.E. ja! > > done! s. [3] > > sieht besser aus…seither ist der Abstand zwischen den Übertragungen > konstant und der höchste „value“ war 101. > -> damit scheint mir bestätigt, dass die Verwendung von „interval“ hier > reingespuckt hat - sehr schön, etwas Klarheit :) > > Bleibt die Frage, wie aggtime sich hier auswirken sollte. > - bei aggtime = 1 würde ich erwarten, dass die Impulse für 1 Sekunde > gesammelt und dann in einem Request übertragen werden (value= (ca.) 100) > Ich auch- allerdings 50 statt 100 bei 50 Hz, es sei denn Dein GPIO triggert auf beiden Flanken? - bei aggtime = 10 würde ich erwarten, dass die Impulse für 10 Sekunden > gesammelt und dann in einem Request übertragen werden (value= (ca.) 1000) > > Habe ich hier die falsche Vorstellung? > Denke nein. Wie kommst Du drauf dass da was falsch sein könnte? Hast Du mal mit und ohne aggfixed interval getestet? > > > >> Das probiere ich mal aus. Falls ich das richtig verstanden habe: haben > wir eine Chance, das beim Parsen der Config entweder > >> - als Fehler auszugeben -> vzlogger beendet sich oder > >> - als Warning auf der Konsole und im Logfile? > >> > > Mach bitte ein Issue auf. > > done! s. [4] > Gesehen, danke! > > > >> Ausschnitt aus vzlogger.conf: > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][s0] Reading S0 - returning 4 readings (n=100 > n_neg = 0) > > >> [May 05 08:11:31][mtr0] Got 4 new readings from meter: > > >> [May 05 08:11:31][mtr0] Reading: id=Power/StringIdentifier: > value=359281.40 ts=1462428691862 > > >> [May 05 08:11:31][mtr0] Reading: id=Impulse/StringIdentifier: > value=100.00 ts=1462428691862 > > >> [May 05 08:11:31][mtr0] Reading: id=Power_neg/StringIdentifier: > value=0.00 ts=1462428691862 > > >> [May 05 08:11:31][mtr0] Reading: id=Impulse_neg/StringIdentifier: > value=0.00 ts=1462428691862 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> [May 05 08:11:31][S0] MeterS0:HWIF_GPIO:first poll returned 1 > > >> > > >> Ich gebe 50 Hz auf den Eingang - und das sieht so aus, als würden die > auch (zum Grossteil) verarbeitet. > > > > Mal für die Doofen wie mich: Du erwartest aufgrund der 50 Hz also einen > konstanten Wert im Log, richtig? > > ex-akt. > Das ist die Simulation für den Zustand „Pelletförderschnecke läuft“; der > andere Zustand („…läuft nicht“) liefert eben 0 Hz und ist mit „send_zero“ > erschlagen. > Passt. Wobei das- wenn Matthias https://github.com/volkszaehler/vzlogger/issues/252 gelöst hat alles nicht mehr nötig sein sollte sondern einfach der Wert des Pins erfasst wird. > > >> 2. aggtime ist die Zeit, über die aggregiert wird > > >> > > >> das scheint mir nicht immer zu funktionieren - noch ein Auszug, jetzt > gegrept nach "Impulse/StringIdentifier“: > > >> > > >> [May 05 08:12:36][mtr0] Reading: id=Impulse/StringIdentifier: > value=100.00 ts=1462428756878 > > >> [May 05 08:12:37][mtr0] Reading: id=Impulse/StringIdentifier: > value=99.00 ts=1462428757871 > > >> [May 05 08:12:38][mtr0] Reading: id=Impulse/StringIdentifier: > value=100.00 ts=1462428758874 > > >> [May 05 08:12:48][mtr0] Reading: id=Impulse/StringIdentifier: > value=998.00 ts=1462428768879 > > >> [May 05 08:12:49][mtr0] Reading: id=Impulse/StringIdentifier: > value=100.00 ts=1462428769882 > > >> [May 05 08:12:50][mtr0] Reading: id=Impulse/StringIdentifier: > value=99.00 ts=1462428770874 > > >> [May 05 08:12:51][mtr0] Reading: id=Impulse/StringIdentifier: > value=100.00 ts=1462428771877 > > >> > > >> -> in der Liste hat’s ein Mal geklappt: „value=998“, sonst immer ca. > 100. > > > > Was heißt "geklappt"? Ich verstehe Deine Erwartungshaltung nicht. Siehe > oben- ich würde jeweils den gleichen Wert erwarten und mir erscheint die > 998 spanisch. > > geklappt im Sinne der Definition von oben. > 998 ist aus meiner Sicht nahe genug an 1000 - wenn der Pi 0,2% der Impulse > verschluckt, halte ich das für unproblematisch (s. Udos berechtigten > Einwand: wozu überhaupt die hohe Auflösung von 50 Hz?). > Stimmt- ich hatte übersehen dass es in dem Fall auch 10 Sekunden statt 1sec war. > > Wir sind einen Schritt weiter :) > > > >> >> Wie kann ich das genauer eingrenzen? > >> >> > >> > Ich kann nicht erkennen wo/was da nicht funktioniert insofern schwer > zu beantworten. > >> > >> bei 1. ging’s mir um „Interval=1 bewirkt, dass jeweils 1 Sekunde keine > Impulse verarbeitet werden > >> der Auszug zeigt mehrere Einträge innerhalb einer Sekunde - direkt vor > und nach dem Loggen eines Wertes > >> > > Lass uns den Punkt mal bitte vergessen. Betrachten wir Interval bei S0 > mal als undefiniert. Bleibt aggtime auf Deinem 2. Log. > > jepp! > > > >> > Wir haben seit ewigen Zeiten aber vmtl. diesen Fehler offen: > https://github.com/volkszaehler/vzlogger/issues/231 Könnte das die > Ursache sein? > >> > >> das ist ein guter Punkt - vielleicht können wir das nun gleich mit > klären. > >> > >> Ich habe send_zero nun auskommentiert [1] - Auszug aus dem Log (wieder > gegrept nach Impulse/StringItentifier): > > > > Das ist schon Fehlersuche aus dem Issue- noch wissen wir nicht obs bei > Dir vorher einen anderen Fehler gibt der den überlagert. > > Könntest Du bitte erstmal testen ob aggtime wie erwartet funktioniert > wenn Du aggfixedinterval ebenfalls setzt? Dann wissen wir ob das Logging > wie erwartet läuft und können dann in send_zero aus dem Issue einsteigen. > > jepp. > > Habe aggfixedinterval aktiviert (s. [3]) und es werden weiterhin jede > Sekunde die Werte geloggt: > > [May 05 20:26:28][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472788615 > [May 05 20:26:29][mtr0] Reading: id=Impulse/StringIdentifier: value=99.00 > ts=1462472789607 > [May 05 20:26:30][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472790610 > [May 05 20:26:31][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472791612 > [May 05 20:26:32][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472792615 > [May 05 20:26:33][mtr0] Reading: id=Impulse/StringIdentifier: value=99.00 > ts=1462472793608 > [May 05 20:26:34][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472794610 > [May 05 20:26:35][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472795613 > [May 05 20:26:36][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472796615 > [May 05 20:26:37][mtr0] Reading: id=Impulse/StringIdentifier: value=99.00 > ts=1462472797608 > [May 05 20:26:38][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472798611 > [May 05 20:26:39][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472799613 > [May 05 20:26:40][mtr0] Reading: id=Impulse/StringIdentifier: value=100.00 > ts=1462472800616 > [May 05 20:26:41][mtr0] Reading: id=Impulse/StringIdentifier: value=99.00 > ts=1462472801608 > Das heißt also dass bei Dir aggtime auch ohne aggfixedinterval funktioniert? Mit aktuellem logger? Bitte kurzes Feedback hier, dann können wir den Bug schließen: https://github.com/volkszaehler/vzlogger/issues/231 > > >> > Bevor wir weiter an Symptomen rumdoktorn würde mich aber eigentlich > interessieren wie konkret Deine Meßeinrichtung aussieht- dann finden wir > auch die richtige Konfiguration dazu. > >> > >> ich verwende Udos whm [2] „produktiv“ und im Test hier gerade einen > Arduino, der 50 Hz auf den GPIO17 des RPi ausgibt. > >> Brauchst Du weitere Details? > > > > D.h. Du erwartest einfach konstate Readings solange der whm getaktet > wird, richtig? > > genau. > > Neue Ideen? > Jetzt hast Du mich erwischt. Wozu- läuft doch jetzt alles?? Viele Grüße, Andreas > > > Gruß, J. > > [3] http://pastie.org/10825951 > [4] https://github.com/volkszaehler/vzlogger/issues/253