Ich nochmal...

> Am 23.06.2016 um 11:45 schrieb Heiko Baumann <h...@gmx.de>:
> 
>> Welches Image nutzt du im Moment?
> Hm, hab ich vor ein paar Tagen runterladen, "offiz. Quelle". Ich glaub (!) 
> ich hab sogar auch noch ein Update gemacht. 
> vzlogger ist vom 5.2.2016
> 
>> Setz mal bitte verbosity auf 15 und dann starte nochmal neu. 
> 
> liefert.. :
> pi@BauratPi:/etc $ sudo vzlogger restart

Wieso nicht sudo service vzlogger restart? Das sollte den Service neu starten. 
Vzlogger startest Du normalerweise nicht händisch. Läuft der Service auch noch? 
Was sagt ps aux | grep vzlogger?

Und was sagt dann das log auf level 15? Der zweite Channel wundert mich nämlich 
auch....

Viele Grüße, Andreas 

> [Jun 23 11:42:04][main] vzlogger v0.5.1 based on 
> heads/master-0-g7e79f4c700-dirty from Fri, 5 Feb 2016 18:03:28 +0100 started.
> [Jun 23 11:42:04][mtr0] Creating new meter with protocol w1therm.
> [Jun 23 11:42:04][mtr0] Meter configured, enabled.
> [Jun 23 11:42:04]       New meter initialized (protocol=w1therm)
> [Jun 23 11:42:04]       Configure channel.
> [Jun 23 11:42:04][chn0] New channel initialized (uuid=...77fb28 
> api=volkszaehler id=28-0000045d2497)
> [Jun 23 11:42:04]       Have 1 meters.
> [Jun 23 11:42:04][main] log level is 15
> [Jun 23 11:42:04][main] daemon=1, local=0
> [Jun 23 11:42:04]       Daemonize process...
> 
> .. und im log:
> pi@BauratPi:~ $ sudo tail -f /var/log/vzlogger.log
> [Jun 23 11:42:04][chn0] compare: 1466674895110 1466674905560
> [Jun 23 11:42:04][chn0] compare: 1466674905560 1466674916430
> [Jun 23 11:42:04][chn0] JSON request body: [ [ 1466674905560, 43.625 ], [ 
> 1466674916430, 43.625 ] ]
> [Jun 23 11:42:04][chn0] CURL: Hostname was found in DNS cache
> [Jun 23 11:42:04][chn0] CURL:   Trying 127.0.0.1...
> [Jun 23 11:42:04][chn0] Buffer dump (size=0): {}
> [Jun 23 11:42:04][chn0] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#9)
> [Jun 23 11:42:04][chn0] CURL: Sent 56 bytes..
> [Jun 23 11:42:04][chn0] CURL: Sent '[ [ 1466674905560, 43.625 ], [ 
> 1466674916430, 43.625 ] ]' bytes
> [Jun 23 11:42:04][chn0] CURL: upload completely sent off: 56 out of 56 bytes
> [Jun 23 11:42:04][chn0] Adding reading to queue (value=4.00 ts=1466674924606)
> [Jun 23 11:42:05][chn0] Adding reading to queue (value=43.62 ts=1466674917381)
> [Jun 23 11:42:05][chn1] Adding reading to queue (value=23.56 ts=1466674924364)
> [Jun 23 11:42:05]       Opened logfile /var/log/vzlogger.log
> [Jun 23 11:42:05][push] No pushDataServer defined.
> [Jun 23 11:42:05][]     ===> Start meters
> [Jun 23 11:42:05][w1t]  open found 12 w1 devices
> [Jun 23 11:42:05][mtr0] Meter connection established
> [Jun 23 11:42:05][mtr0] Meter thread started
> [Jun 23 11:42:05][mtr0] Meter is opened. Starting channels.
> [Jun 23 11:42:05][chn0] Logging thread started
> [Jun 23 11:42:05][]     Startup done.
> [Jun 23 11:42:05][chn0] Start logging thread for volkszaehler-api. Running as 
> daemon: yes
> [Jun 23 11:42:05][mtr0] Number of readers: 400
> [Jun 23 11:42:05][mtr0] Config.daemon: 1
> [Jun 23 11:42:05][mtr0] Config.local: 0
> [Jun 23 11:42:05][chn0] Using default volkszaehler api.
> [Jun 23 11:42:05][w1t]  read 10.000000 from 
> /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=10000
> )
> [Jun 23 11:42:05][w1t]  reading w1 device 28-0000045c6924 returned 10.000000
> [Jun 23 11:42:05][chn0] Adding reading to queue (value=4.00 ts=1466674925590)
> [Jun 23 11:42:06][w1t]  read 10.000000 from 
> /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=10000
> )
> [Jun 23 11:42:06][w1t]  reading w1 device 28-0000045c6924 returned 10.000000
> [Jun 23 11:42:06][w1t]  read 24.687000 from 
> /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=24687
> )
> [Jun 23 11:42:06][w1t]  reading w1 device 28-0000045c5c7e returned 24.687000
> [Jun 23 11:42:06][chn0] Adding reading to queue (value=5.00 ts=1466674926820)
> [Jun 23 11:42:06][chn0] CURL: HTTP 1.0, assume close after body
> [Jun 23 11:42:07][chn0] CURL: Received 26 bytes
> [Jun 23 11:42:07][chn0] CURL: Received '{"version":"0.3","rows":2}' bytes
> [Jun 23 11:42:07][chn0] CURL: Closing connection 9
> [Jun 23 11:42:07][chn0] CURL Request succeeded with code: 200
> [Jun 23 11:42:07][w1t]  read 43.625000 from 
> /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=43625
> )
> [Jun 23 11:42:07][w1t]  reading w1 device 28-0000045d2497 returned 43.625000
> [Jun 23 11:42:07][w1t]  read 24.687000 from 
> /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=24687
> )
> [Jun 23 11:42:07][w1t]  reading w1 device 28-0000045c5c7e returned 24.687000
> [Jun 23 11:42:07][chn0] Adding reading to queue (value=4.00 ts=1466674927809)
> [Jun 23 11:42:08][w1t]  read 16.812000 from 
> /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=16812
> )
> [Jun 23 11:42:08][w1t]  reading w1 device 28-0000045d7eb0 returned 16.812000
> [Jun 23 11:42:08][w1t]  read 43.625000 from 
> /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=43625
> )
> [Jun 23 11:42:08][w1t]  reading w1 device 28-0000045d2497 returned 43.625000
> [Jun 23 11:42:08][chn0] Adding reading to queue (value=4.00 ts=1466674928797)
> [Jun 23 11:42:09][chn1] Adding reading to queue (value=43.62 ts=1466674920402)
> [Jun 23 11:42:09][w1t]  read 18.437000 from 
> /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=18437
> )
> [Jun 23 11:42:09][w1t]  reading w1 device 28-000004a2845a returned 18.437000
> [Jun 23 11:42:09][w1t]  read 16.812000 from 
> /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=16812
> )
> [Jun 23 11:42:09][w1t]  reading w1 device 28-0000045d7eb0 returned 16.812000
> [Jun 23 11:42:09][chn0] Adding reading to queue (value=4.00 ts=1466674929785)
> [Jun 23 11:42:10][w1t]  read 18.437000 from 
> /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=18437
> )
> [Jun 23 11:42:10][w1t]  reading w1 device 28-000004a2845a returned 18.437000
> [Jun 23 11:42:10][w1t]  read 9.937000 from 
> /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=9937
> )
> [Jun 23 11:42:10][w1t]  reading w1 device 28-000004c913d5 returned 9.937000
> [Jun 23 11:42:10][chn0] Adding reading to queue (value=4.00 ts=1466674930773)
> [Jun 23 11:42:10][chn0] Adding reading to queue (value=43.62 ts=1466674922387)
> [Jun 23 11:42:10][mtr0] Next reading in 10 seconds
> [Jun 23 11:42:11][w1t]  read 10.125000 from 
> /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=10125
> )
> [Jun 23 11:42:11][w1t]  reading w1 device 28-000004c9583f returned 10.125000
> 
> ...
> 
> 
>> Am 23.06.2016 um 11:24 schrieb Andreas Götz:
>> Setz mal bitte verbosity auf 15 und dann starte nochmal neu. 
>> 
>> Viele Grüße, Andreas 
>> 
>> Am 23.06.2016 um 11:01 schrieb Heiko Baumann <h...@gmx.de>:
>> 
>>> Hallo Andreas,
>>> 
>>> Danke dass du auch mit drüber schaust.
>>> 
>>> > Bist Du sicher dass diese conf Datei auch verwendet wird? In welchem 
>>> > Ordner liegt sie und wie startest Du vzlogger?
>>> 
>>> Jetzt hast du mich kurz mal in Verlegenheit gebracht, aber ja:
>>> 
>>> 
>>> Gestartet wird mit
>>> 
>>> pi@BauratPi:/etc $ sudo vzlogger restart
>>> [Jun 23 11:00:06][main] vzlogger v0.5.1 based on 
>>> heads/master-0-g7e79f4c700-dirty from Fri, 5 Feb 2016 18:03:28 +0100 
>>> started.
>>> [Jun 23 11:00:06]       New meter initialized (protocol=w1therm)
>>> [Jun 23 11:00:06][chn0] New channel initialized (uuid=...77fb28 
>>> api=volkszaehler id=28-0000045d2497)
>>> [Jun 23 11:00:06][main] log level is 5
>>> [Jun 23 11:00:06]       Daemonize process...
>>> 
>>> 
>>> pi@BauratPi:~ $ sudo tail -20 /var/log/vzlogger.log
>>> [Jun 23 11:00:18][chn1] Adding reading to queue (value=43.69 
>>> ts=1466672410490)
>>> [Jun 23 11:00:18][mtr1] Next reading in 10 seconds
>>> [Jun 23 11:00:19][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672419314)
>>> [Jun 23 11:00:20][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672420306)
>>> [Jun 23 11:00:20][chn1] Adding reading to queue (value=43.69 
>>> ts=1466672412297)
>>> [Jun 23 11:00:20][chn1] Adding reading to queue (value=23.38 
>>> ts=1466672419974)
>>> [Jun 23 11:00:20][chn1] Adding reading to queue (value=23.38 
>>> ts=1466672420037)
>>> [Jun 23 11:00:20][chn0] Adding reading to queue (value=43.69 
>>> ts=1466672412599)
>>> [Jun 23 11:00:21][chn1] Adding reading to queue (value=23.88 
>>> ts=1466672411889)
>>> [Jun 23 11:00:21][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672421298)
>>> [Jun 23 11:00:22][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672422290)
>>> [Jun 23 11:00:23][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672423282)
>>> [Jun 23 11:00:24][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672424275)
>>> [Jun 23 11:00:25][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672425272)
>>> [Jun 23 11:00:26][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672426268)
>>> [Jun 23 11:00:27][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672427271)
>>> [Jun 23 11:00:28][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672428267)
>>> [Jun 23 11:00:29][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672429263)
>>> [Jun 23 11:00:29][chn0] Adding reading to queue (value=43.69 
>>> ts=1466672421241)
>>> [Jun 23 11:00:30][chn0] Adding reading to queue (value=4.00 
>>> ts=1466672430259)
>>> 
>>> .. und genau dorthin logge ich ja auch:
>>> 
>>> pi@BauratPi:/etc $ cat vzlogger.conf
>>> 
>>> {
>>>   "retry": 0,
>>>   "daemon": true,
>>>   "verbosity": 5,
>>>   "log": "/var/log/vzlogger.log",
>>>   "local": {
>>>     "enabled": false,
>>>     "port": 8080,
>>>     "index": false,
>>>     "timeout": 0,
>>>     "buffer": 0
>>>   },
>>>   "meters": [
>>>     {
>>>       "enabled": true,
>>>       "allowskip": false,
>>>       "interval": -1,
>>>       "aggtime": 20,
>>>       "aggfixedinterval": true,
>>>       "channels": [
>>>         {
>>>           "uuid": "46f672b0-f2dc-11e2-8c00-43a2ff77fb28",
>>>           "identifier": "28-0000045d2497",
>>>           "api": "volkszaehler",
>>>           "middleware": "http://127.0.0.1/middleware.php";,
>>>           "aggmode": "none",
>>>           "duplicates": 0
>>>         }
>>>       ],
>>>       "protocol": "w1therm"
>>>     }
>>>   ]
>>> }
>>> 
>>> 
>>> Ist mir nicht erklärlich.. :(
>>> 
>>> Danke!
>>> 
>>> LG Heiko
>>> 
>>>> 
>>>> 
>>>> Am 23.06.2016 um 10:42 schrieb Heiko Baumann <h...@gmx.de>:
>>>> 
>>>>>> Am 22.06.2016 um 23:55 schrieb Udo1:
>>>>>>> Am 22.06.2016 um 23:42 schrieb Heiko Baumann: 
>>>>>>> Muss der "identifier" überall die Sensor-ID sein oder kann ich das als 
>>>>>>> Freitext beliebig wählen?
>>>>>> m.M. müsste das die Sensor-ID sein (bei 1Wire), wie sonst sollte 
>>>>>> vzlogger die UUID dem Sensor zuordnen (bei mehreren Sensoren).
>>>>> Ok, es werden zwar Werte geliefert, aber kann gut sein, dass sie ohne 
>>>>> SensorID einfach dem ersten zugeordnet werden.
>>>>> 
>>>>> Beim Rumspielen mit der conf Datei stoße ich auf mir unerklärliche Dinge. 
>>>>> Nur zum Test mal ein einziger Temperatursensor:
>>>>> 
>>>>> 
>>>>> pi@BauratPi:/etc $ cat vzlogger.conf
>>>>> {
>>>>>   "retry": 0,
>>>>>   "daemon": true,
>>>>>   "verbosity": 5,
>>>>>   "log": "/var/log/vzlogger.log",
>>>>>   "local": {
>>>>>     "enabled": false,
>>>>>     "port": 8080,
>>>>>     "index": false,
>>>>>     "timeout": 0,
>>>>>     "buffer": 0
>>>>>   },
>>>>>   "meters": [
>>>>>     {
>>>>>       "enabled": true,
>>>>>       "allowskip": false,
>>>>>       "interval": -1,
>>>>>       "aggtime": 20,
>>>>>       "aggfixedinterval": true,
>>>>>       "channels": [
>>>>>         {
>>>>>           "uuid": "46f672b0-f2dc-11e2-8c00-43a2ff77fb28",
>>>>>           "identifier": "28-0000045d2497",
>>>>>           "api": "volkszaehler",
>>>>>           "middleware": "http://127.0.0.1/middleware.php";,
>>>>>           "aggmode": "none",
>>>>>           "duplicates": 0
>>>>>         }
>>>>>       ],
>>>>>       "protocol": "w1therm"
>>>>>     }
>>>>>   ]
>>>>> }
>>>>> 
>>>>> So. UUID und Sensor-ID passen  zusammen, das ist noch aus der alten 1wire 
>>>>> Konfig übernommen.
>>>>> Im log stehen dann komische Sachen:
>>>>> 
>>>>> 
>>>>> [Jun 23 10:38:23][mtr1] Next reading in 10 seconds
>>>>> [Jun 23 10:38:23][chn0] Adding reading to queue (value=43.81 
>>>>> ts=1466671094865)
>>>>> [Jun 23 10:38:23][chn0] Adding reading to queue (value=43.81 
>>>>> ts=1466671095313)
>>>>> [Jun 23 10:38:23][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671103085)
>>>>> [Jun 23 10:38:23][mtr0] Next reading in 10 seconds
>>>>> [Jun 23 10:38:24][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671104077)
>>>>> [Jun 23 10:38:25][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671105069)
>>>>> [Jun 23 10:38:26][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671106061)
>>>>> [Jun 23 10:38:26][chn1] Adding reading to queue (value=43.81 
>>>>> ts=1466671098570)
>>>>> [Jun 23 10:38:26][mtr1] Next reading in 10 seconds
>>>>> [Jun 23 10:38:26][chn1] Adding reading to queue (value=23.25 
>>>>> ts=1466671105869)
>>>>> [Jun 23 10:38:27][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671107053)
>>>>> [Jun 23 10:38:28][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671108045)
>>>>> [Jun 23 10:38:29][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671109037)
>>>>> [Jun 23 10:38:30][chn1] Adding reading to queue (value=23.56 
>>>>> ts=1466671101185)
>>>>> [Jun 23 10:38:30][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671110043)
>>>>> [Jun 23 10:38:31][chn1] Adding reading to queue (value=43.81 
>>>>> ts=1466671103126)
>>>>> [Jun 23 10:38:31][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671111035)
>>>>> [Jun 23 10:38:32][chn0] Adding reading to queue (value=4.00 
>>>>> ts=1466671112027)
>>>>> 
>>>>> Richtig sind die Werte um 44° (Warmwasser). Der Rest ist Käse.
>>>>> 
>>>>> Wieso werden zwei "Channels" (blau markiert) geloggt, obwohl in der conf 
>>>>> doch nur 1 Sensor erfasst ist?
>>>>> (Am Pi hängen insgesamt 12 temperaturfühler und 4 s0).
>>>>> 
>>>>> Könnte mir jemand mal bitte seine vzlogger.conf posten, in der s0 (Strom 
>>>>> und Betriebsstunden) und 1wire Temperaturfühler angesprochen werden und 
>>>>> die Werte sinnvoll aggregiert werden?
>>>>> 
>>>>> Danke!
>>>>> 
>>>>> LG HEiko
> 

Antwort per Email an