[vz-users] System neu aufgesetzt und es geht nichts mehr
Heine.thomas at online.de
Heine.thomas at online.de
Mon Jun 11 12:15:46 CEST 2018
Hallo,
Ich hab das Push mal rausgenommen.
Die VZlogger.conf sieht jetzt so aus:
/**
* vzlogger configuration
*
* Use properly encoded JSON with javascript comments
*
* Take a look at the wiki for detailed information:
* http://wiki.volkszaehler.org/software/controller/vzlogger#configuration
*
* For an online configuration editor refer to:
* http://volkszaehler.github.io/vzlogger/
*/
/**
* vzlogger configuration
*
* Use properly encoded JSON with javascript comments
*
* Take a look at the wiki for detailed information:
* http://wiki.volkszaehler.org/software/controller/vzlogger#configuration
*
* For an online configuration editor refer to:
* http://volkszaehler.github.io/vzlogger/
*/
{
"retry": 30,
"daemon": false,
"verbosity": 15,
"log": "/var/log/vzlogger.log",
"local": {
"enabled": true,
"port": 8080,
"index": false,
"timeout": 30,
"buffer": 600
},
"meters": [
{
"enabled": true,
"allowskip": false,
"interval": 0,
"aggtime": 0,
"aggfixedinterval": false,
"channels": [
{
"api": "volkszaehler",
"uuid": "9e4f6cd0-6ceb-11e8-a32d-a760ed2d2855", /*Zählerstand
Bezug ZRZ-Zähler*/
"identifier": "1-0:1.8.0*255",
"middleware": "http://localhost/middleware.php",
"aggmode": "none",
"duplicates": 0
},
{
"api": "volkszaehler",
"uuid": "b8609090-6ceb-11e8-8570-c5baf91c7608", /*Zählerstand
Liefer ZRZ-Zähler*/
"identifier": "1-0:2.8.0*255",
"middleware": "http://localhost/middleware.php",
"aggmode": "none",
"duplicates": 0
},
{
"api": "volkszaehler",
"uuid": "d7adb0a0-6ceb-11e8-875f-a5316ade1ece",
/*Wirkleistung ZR-Zähler*/
"identifier": "1-0:16.7.0*255",
"middleware": "http://localhost/middleware.php",
"aggmode": "none",
"duplicates": 0
}
],
"protocol": "sml",
"device": "/dev/ttyUSB0",
"pullseq": "",
"baudrate": 9600,
"parity": "8n1",
"use_local_time": false
},
{
"enabled": true,
"allowskip": false,
"interval": 0,
"aggtime": 0,
"aggfixedinterval": false,
"channels": [
{
"api": "volkszaehler",
"uuid": "74946580-6ceb-11e8-9209-319341c461c1", /*Zählerstand
PV-Zähler*/
"identifier": "1-0:2.8.0*255",
"middleware": "http://localhost/middleware.php",
"aggmode": "none",
"duplicates": 0
},
{
"api": "volkszaehler",
"uuid": "4a779f70-6ceb-11e8-9235-f561c70ea983",
/*Wirkleistung PV-Zähler*/
"identifier": "1-0:16.7.0*255",
"middleware": "http://localhost/middleware.php",
"aggmode": "none",
"duplicates": 0
}
],
"protocol": "sml",
"device": "/dev/ttyUSB1",
"pullseq": "",
"baudrate": 9600,
"parity": "8n1",
"use_local_time": false
}
]
}
Im Anhang nochmals das Log.
Ist das jetzt so ok?
Wenn ich "sudo vzlogger" starte, dann kann ich öfters folgendes lesen
(siehe Auch Anhang vzlogger.txt:
*libsml: warning: could not read the whole file
*und*
libsml: error: unrecognized sequence
*ist das ein Problem?
An den udev-rules arbeite ich später....
Gruß
Thomas
Am 10.06.2018 um 22:57 schrieb Frank Richter:
> Hi,
>
> die Fehler kommen von der fehlenden Push-URL. Wenn du das nicht
> verwendest, am besten den ganzen Push-Block löschen oder auskommentieren.
> Und wie schon heute Nachmittag geschrieben: udev-rule anlegen, damit
> die Zuordnung der Leseköpfe fixiert ist.
>
> Grüße
> Frank
>
> Heine.thomas at online.de <mailto:Heine.thomas at online.de>
> <Heine.thomas at online.de <mailto:Heine.thomas at online.de>> schrieb am
> So., 10. Juni 2018, 22:48:
>
> Hallo,
>
> Hab alles nochmals aufgesetzt. Bekomme jetzt zwar gültige Werte,
> Irgendetwas passt jedoch nicht.
>
> Hier nochmals die neue VZlogger.conf:
>
>
> /**
> * vzlogger configuration
> *
> * Use properly encoded JSON with javascript comments
> *
> * Take a look at the wiki for detailed information:
> *
> http://wiki.volkszaehler.org/software/controller/vzlogger#configuration
> *
> * For an online configuration editor refer to:
> * http://volkszaehler.github.io/vzlogger/
> */
> {
> "retry": 30,
> "daemon": false,
> "verbosity": 5,
> "log": "/var/log/vzlogger.log",
> "push": [
> {
> "url": ""
> }
> ],
> "local": {
> "enabled": true,
> "port": 8080,
> "index": false,
> "timeout": 30,
> "buffer": 600
> },
> "meters": [
> {
> "enabled": true,
> "allowskip": false,
> "interval": 0,
> "aggtime": 0,
> "aggfixedinterval": false,
> "channels": [
> {
> "api": "volkszaehler",
> "uuid": "xxxx", /*Zählerstand Bezug ZRZ-Zähler*/
> "identifier": "1-0:1.8.0*255",
> "middleware": "http://localhost/middleware.php"
> <http://localhost/middleware.php>,
> "aggmode": "none",
> "duplicates": 0
> },
> {
> "api": "volkszaehler",
> "uuid": "xxxx", /*Zählerstand Liefer ZRZ-Zähler*/
> "identifier": "1-0:2.8.0*255",
> "middleware": "http://localhost/middleware.php"
> <http://localhost/middleware.php>,
> "aggmode": "none",
> "duplicates": 0
> },
> {
> "api": "volkszaehler",
> "uuid": "xxxx", /*Wirkleistung ZR-Zähler*/
> "identifier": "1-0:16.7.0*255",
> "middleware": "http://localhost/middleware.php"
> <http://localhost/middleware.php>,
> "aggmode": "none",
> "duplicates": 0
> }
> ],
> "protocol": "sml",
> "device": "/dev/ttyUSB1",
> "pullseq": "",
> "baudrate": 9600,
> "parity": "8n1",
> "use_local_time": false
> },
> {
> "enabled": true,
> "allowskip": false,
> "interval": 0,
> "aggtime": 0,
> "aggfixedinterval": false,
> "channels": [
> {
> "api": "volkszaehler",
> "uuid": "xxxx", /*Zählerstand PV-Zähler*/
> "identifier": "1-0:2.8.0*255",
> "middleware": "http://localhost/middleware.php"
> <http://localhost/middleware.php>,
> "aggmode": "none",
> "duplicates": 0
> },
> {
> "api": "volkszaehler",
> "uuid": "xxxx", /*Wirkleistung PV-Zähler*/
> "identifier": "1-0:16.7.0*255",
> "middleware": "http://localhost/middleware.php"
> <http://localhost/middleware.php>,
> "aggmode": "none",
> "duplicates": 0
> }
> ],
> "protocol": "sml",
> "device": "/dev/ttyUSB0",
> "pullseq": "",
> "baudrate": 9600,
> "parity": "8n1",
> "use_local_time": false
> }
> ]
> }
>
>
>
> Das Ergebnis aus dem log im Anhang.
>
> Weiß jemand Hilfe? Hab mich strikt ans How-To gehalten....
>
>
> Gruß
>
> Thomas
>
>
>
>
>
>
>
>
>
>
> Am 10.06.2018 um 15:04 schrieb Frank Richter:
>> Hi Thomas,
>>
>> bei zwei Leseköpfen solltest du Aliase mittels udev-Regel
>> anlegen, sonst ist die Zuordnung nicht eindeutig.
>>
>> Mit daemon: false läuft vzlogger nicht dauerhaft und sendet
>> nichts zur Middleware. Aber bevor du das auf true setzt, versuch
>> mal vzlogger manuell zu starten (ohne systemctl direkt über die
>> Kommandozeile). Dann solltest du sehen können, wo es in der
>> vzlogger.conf hakt.
>>
>> Grüße
>> Frank
>>
>> Heine.thomas at online.de <mailto:Heine.thomas at online.de>
>> <Heine.thomas at online.de <mailto:Heine.thomas at online.de>> schrieb
>> am So., 10. Juni 2018, 14:50:
>>
>> Hallo,
>>
>> hab mein Systm nach SD-Card-Crash auf das Aktuelle Image neu
>> aufgesetzt.
>> Ich habe 2 USB-Leseköpfe an dem RPI3 angeschlossen.
>> (2 SML-Meter)
>> Schnittstelleneinstellung und Obis-Code habe ich aus der alten
>> VZLogger.conf übernommen.
>>
>>
>> Die Aktuelle sieht so aus:
>>
>> {
>> "retry": 0,
>> "daemon": false,
>> "verbosity": 15,
>> "log": "/var/log/vzlogger.log",
>> "push": [],
>> "local": {
>> "enabled": false,
>> "port": 8080,
>> "index": false,
>> "timeout": 30,
>> "buffer": 600
>> },
>> "meters": [
>> {
>> "enabled": true,
>> "allowskip": false,
>> "interval": 1,
>> "aggtime": 1,
>> "aggfixedinterval": false,
>> "channels": [
>> {
>> "api": "volkszaehler",
>> "uuid": "xxxxx",
>> "identifier": "1-0:1.8.0*255",
>> "middleware": "http://localhost/middleware.php",
>> "aggmode": "none",
>> "duplicates": 2
>> },
>> {
>> "api": "volkszaehler",
>> "uuid": "xxxxx",
>> "identifier": "1-0:2.8.0*255",
>> "middleware": "http://localhost/middleware.php",
>> "aggmode": "none",
>> "duplicates": 2
>> },
>> {
>> "api": "volkszaehler",
>> "uuid": "xxxxx",
>> "identifier": "1-0:16.7.0*255",
>> "middleware": "http://localhost/middleware.php",
>> "aggmode": "none",
>> "duplicates": 0
>> }
>> ],
>> "protocol": "sml",
>> "device": "/dev/ttyUSB0",
>> "pullseq": "",
>> "baudrate": 9600,
>> "parity": "8n1",
>> "use_local_time": false
>> },
>> {
>> "enabled": true,
>> "allowskip": false,
>> "interval": -1,
>> "aggtime": -1,
>> "aggfixedinterval": false,
>> "channels": [
>> {
>> "api": "volkszaehler",
>> "uuid": "xxxxx",
>> "identifier": "1-0:2.8.0*255",
>> "middleware": "http://localhost/middleware.php",
>> "aggmode": "none",
>> "duplicates": 2
>> },
>> {
>> "api": "volkszaehler",
>> "uuid": "xxxxx",
>> "identifier": "1-0:16.7.0*255",
>> "middleware": "http://localhost/middleware.php",
>> "aggmode": "none",
>> "duplicates": 0
>> }
>> ],
>> "protocol": "sml",
>> "device": "/dev/ttyUSB1",
>> "pullseq": "",
>> "baudrate": 9600,
>> "parity": "8n1",
>> "use_local_time": false
>> }
>> ]
>> }
>>
>>
>>
>> Hab die UUID´s ausgeXXt.
>>
>>
>> Bei Aufruf von
>> pi at raspberrypi:~ $ systemctl status vzlogger
>> ● vzlogger.service - vzlogger
>> Loaded: loaded (/etc/systemd/system/vzlogger.service;
>> enabled;
>> vendor preset: enabled)
>> Active: inactive (dead)
>>
>> In der Log-Datei (/var/log/vzlogger.log) steht nichts drin.
>>
>> Wenn ich den Befehl aufrufe:
>> pi at raspberrypi:~ $ sudo systemctl start vzlogger
>>
>> bleibt der Cursor in der Zeile darunter hängen, bis ich den
>> Aufruf mit
>> "Untbr" abbreche.
>> Danach steht auch nichts im Log-File.
>>
>> In der Datenbank werden keine Werte eingetragen.
>>
>> Was mache ich falsch?
>>
>> Danke vorab für die Hilfe
>>
>> Gruß
>>
>> Thomas
>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://demo.volkszaehler.org/pipermail/volkszaehler-users/attachments/20180611/c85a9e0a/attachment-0001.html>
-------------- next part --------------
[Jun 11 11:55:34][main] vzlogger v0.6.1 based on heads/master-0-gd3381ce6ba from Sat, 9 Dec 2017 15:49:37 +0100 started.
[Jun 11 11:55:34][mtr0] Creating new meter with protocol sml.
[Jun 11 11:55:34][sml] pullseq len:0 found
[Jun 11 11:55:34][mtr0] Meter configured, enabled.
[Jun 11 11:55:34] New meter initialized (protocol=sml)
[Jun 11 11:55:34] Configure channel.
[Jun 11 11:55:34][chn0] New channel initialized (uuid=...2d2855 api=volkszaehler id=1-0:1.8.0*255)
[Jun 11 11:55:34] Configure channel.
[Jun 11 11:55:34][chn1] New channel initialized (uuid=...1c7608 api=volkszaehler id=1-0:2.8.0*255)
[Jun 11 11:55:34] Configure channel.
[Jun 11 11:55:34][chn2] New channel initialized (uuid=...de1ece api=volkszaehler id=1-0:16.7.0*255)
[Jun 11 11:55:34][mtr1] Creating new meter with protocol sml.
[Jun 11 11:55:34][sml] pullseq len:0 found
[Jun 11 11:55:34][mtr1] Meter configured, enabled.
[Jun 11 11:55:34] New meter initialized (protocol=sml)
[Jun 11 11:55:34] Configure channel.
[Jun 11 11:55:34][chn3] New channel initialized (uuid=...c461c1 api=volkszaehler id=1-0:2.8.0*255)
[Jun 11 11:55:34] Configure channel.
[Jun 11 11:55:34][chn4] New channel initialized (uuid=...0ea983 api=volkszaehler id=1-0:16.7.0*255)
[Jun 11 11:55:34] Have 2 meters.
[Jun 11 11:55:34][main] log level is 15
[Jun 11 11:55:34][main] daemon=0, local=1
[Jun 11 11:55:34] Process not daemonized...
[Jun 11 11:55:34] Opened logfile /var/log/vzlogger.log
[Jun 11 11:55:34][push] No pushDataServer defined.
[Jun 11 11:55:34][] ===> Start meters
[Jun 11 11:55:34][mtr0] Meter connection established
[Jun 11 11:55:34][mtr0] Meter thread started
[Jun 11 11:55:34][mtr0] Meter is opened. Starting channels.
[Jun 11 11:55:34][mtr0] Number of readers: 32
[Jun 11 11:55:34][chn0] Logging thread started
[Jun 11 11:55:34][mtr0] Config.daemon: 0
[Jun 11 11:55:34][mtr0] Config.local: 1
[Jun 11 11:55:34][chn1] Logging thread started
[Jun 11 11:55:34][chn1] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 11:55:34][chn2] Logging thread started
[Jun 11 11:55:34][chn0] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 11:55:34][chn1] Using default volkszaehler api.
[Jun 11 11:55:34][chn0] Using default volkszaehler api.
[Jun 11 11:55:34][chn2] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 11:55:34][chn2] Using default volkszaehler api.
[Jun 11 11:55:34][mtr1] Meter connection established
[Jun 11 11:55:34][mtr1] Meter thread started
[Jun 11 11:55:34][mtr1] Meter is opened. Starting channels.
[Jun 11 11:55:34][mtr1] Number of readers: 32
[Jun 11 11:55:34][mtr1] Config.daemon: 0
[Jun 11 11:55:34][mtr1] Config.local: 1
[Jun 11 11:55:34][chn3] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 11:55:34][chn3] Logging thread started
[Jun 11 11:55:34][chn4] Logging thread started
[Jun 11 11:55:34][chn3] Using default volkszaehler api.
[Jun 11 11:55:34][http] Starting local interface HTTPd on port 8080
[Jun 11 11:55:34][chn4] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 11:55:34][chn4] Using default volkszaehler api.
[Jun 11 11:55:34][] Startup done.
[Jun 11 11:55:35][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:35][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985219.60 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984219.60 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710935289
[Jun 11 11:55:35][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4046.00 ts=1528710935289
[Jun 11 11:55:35][chn0] Adding reading to queue (value=20981052.60 ts=1528710935289)
[Jun 11 11:55:35][chn1] Adding reading to queue (value=31985219.60 ts=1528710935289)
[Jun 11 11:55:35][chn2] Adding reading to queue (value=-4046.00 ts=1528710935289)
[Jun 11 11:55:35][chn0] ==> number of tuples: 1
[Jun 11 11:55:35][chn0] compare: 0 1528710935289
[Jun 11 11:55:35][chn0] copied 1/1 values for middleware transmission
[Jun 11 11:55:35][chn0] JSON request body: [ [ 1528710935289, 20981052.600000001 ] ]
[Jun 11 11:55:35][chn1] ==> number of tuples: 1
[Jun 11 11:55:35][chn1] compare: 0 1528710935289
[Jun 11 11:55:35][chn1] copied 1/1 values for middleware transmission
[Jun 11 11:55:35][chn2] ==> number of tuples: 1
[Jun 11 11:55:35][chn2] compare: 0 1528710935289
[Jun 11 11:55:35][chn2] copied 1/1 values for middleware transmission
[Jun 11 11:55:35][chn0] CURL: Trying ::1...
[Jun 11 11:55:35][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:35][chn0] CURL: Connected to localhost (::1) port 80 (#0)
[Jun 11 11:55:35][chn0] CURL: Sent 41 bytes..
[Jun 11 11:55:35][chn0] CURL: Sent '[ [ 1528710935289, 20981052.600000001 ] ]' bytes
[Jun 11 11:55:35][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:35][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:35][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789148.60 ts=1528710935709
[Jun 11 11:55:35][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788148.60 ts=1528710935709
[Jun 11 11:55:35][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710935709
[Jun 11 11:55:35][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4524.00 ts=1528710935709
[Jun 11 11:55:35][chn3] Adding reading to queue (value=46789148.60 ts=1528710935709)
[Jun 11 11:55:35][chn4] Adding reading to queue (value=-4524.00 ts=1528710935709)
[Jun 11 11:55:35][chn3] ==> number of tuples: 1
[Jun 11 11:55:35][chn4] ==> number of tuples: 1
[Jun 11 11:55:35][chn3] compare: 0 1528710935709
[Jun 11 11:55:35][chn4] compare: 0 1528710935709
[Jun 11 11:55:35][chn3] copied 1/1 values for middleware transmission
[Jun 11 11:55:35][chn4] copied 1/1 values for middleware transmission
[Jun 11 11:55:35][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:36][chn0] CURL: Received 26 bytes
[Jun 11 11:55:36][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:36][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:36][chn0] CURL: Closing connection 0
[Jun 11 11:55:36][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:36][chn1] JSON request body: [ [ 1528710935289, 31985219.600000001 ] ]
[Jun 11 11:55:36][chn0] emptied all (1) values
[Jun 11 11:55:36][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:36][chn1] CURL: Trying ::1...
[Jun 11 11:55:36][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:36][chn1] CURL: Connected to localhost (::1) port 80 (#1)
[Jun 11 11:55:36][chn1] CURL: Sent 41 bytes..
[Jun 11 11:55:36][chn1] CURL: Sent '[ [ 1528710935289, 31985219.600000001 ] ]' bytes
[Jun 11 11:55:36][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:36][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:36][chn1] CURL: Received 26 bytes
[Jun 11 11:55:36][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:36][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:36][chn1] CURL: Closing connection 1
[Jun 11 11:55:36][chn1] CURL Request succeeded with code: 200
[Jun 11 11:55:36][chn1] emptied all (1) values
[Jun 11 11:55:36][chn2] JSON request body: [ [ 1528710935289, -4046 ] ]
[Jun 11 11:55:36][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:36][chn2] CURL: Trying ::1...
[Jun 11 11:55:36][chn2] CURL: TCP_NODELAY set
[Jun 11 11:55:36][chn2] CURL: Connected to localhost (::1) port 80 (#2)
[Jun 11 11:55:36][chn2] CURL: Sent 28 bytes..
[Jun 11 11:55:36][chn2] CURL: Sent '[ [ 1528710935289, -4046 ] ]' bytes
[Jun 11 11:55:36][chn2] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:36][chn2] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:36][chn2] CURL: Received 26 bytes
[Jun 11 11:55:36][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:36][chn2] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:36][chn2] CURL: Closing connection 2
[Jun 11 11:55:36][chn2] CURL Request succeeded with code: 200
[Jun 11 11:55:36][chn2] emptied all (1) values
[Jun 11 11:55:36][chn3] JSON request body: [ [ 1528710935709, 46789148.600000001 ] ]
[Jun 11 11:55:36][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:36][chn3] CURL: Trying ::1...
[Jun 11 11:55:36][chn3] CURL: TCP_NODELAY set
[Jun 11 11:55:36][chn3] CURL: Connected to localhost (::1) port 80 (#3)
[Jun 11 11:55:36][chn3] CURL: Sent 41 bytes..
[Jun 11 11:55:36][chn3] CURL: Sent '[ [ 1528710935709, 46789148.600000001 ] ]' bytes
[Jun 11 11:55:36][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:36][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:36][chn3] CURL: Received 26 bytes
[Jun 11 11:55:36][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:36][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:36][chn3] CURL: Closing connection 3
[Jun 11 11:55:36][chn3] CURL Request succeeded with code: 200
[Jun 11 11:55:36][chn4] JSON request body: [ [ 1528710935709, -4524 ] ]
[Jun 11 11:55:36][chn3] emptied all (1) values
[Jun 11 11:55:36][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:36][chn4] CURL: Trying ::1...
[Jun 11 11:55:36][chn4] CURL: TCP_NODELAY set
[Jun 11 11:55:36][chn4] CURL: Connected to localhost (::1) port 80 (#4)
[Jun 11 11:55:36][chn4] CURL: Sent 28 bytes..
[Jun 11 11:55:36][chn4] CURL: Sent '[ [ 1528710935709, -4524 ] ]' bytes
[Jun 11 11:55:36][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:36][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:36][chn4] CURL: Received 26 bytes
[Jun 11 11:55:36][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:36][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:36][chn4] CURL: Closing connection 4
[Jun 11 11:55:36][chn4] CURL Request succeeded with code: 200
[Jun 11 11:55:36][chn4] emptied all (1) values
[Jun 11 11:55:37][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:37][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985221.80 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984221.80 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710937262
[Jun 11 11:55:37][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4064.00 ts=1528710937262
[Jun 11 11:55:37][chn0] Adding reading to queue (value=20981052.60 ts=1528710937262)
[Jun 11 11:55:37][chn1] Adding reading to queue (value=31985221.80 ts=1528710937262)
[Jun 11 11:55:37][chn2] Adding reading to queue (value=-4064.00 ts=1528710937262)
[Jun 11 11:55:37][chn0] ==> number of tuples: 1
[Jun 11 11:55:37][chn2] ==> number of tuples: 1
[Jun 11 11:55:37][chn0] compare: 1528710935289 1528710937262[Jun 11 11:55:37][chn1] ==> number of tuples: 1
[Jun 11 11:55:37][chn2] compare: 1528710935289 1528710937262
[Jun 11 11:55:37][chn2] copied 1/1 values for middleware transmission
[Jun 11 11:55:37][chn0] copied 1/1 values for middleware transmission
[Jun 11 11:55:37][chn2] JSON request body: [ [ 1528710937262, -4064 ] ]
[Jun 11 11:55:37][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:37][chn2] CURL: Trying ::1...
[Jun 11 11:55:37][chn2] CURL: TCP_NODELAY set
[Jun 11 11:55:37][chn2] CURL: Connected to localhost (::1) port 80 (#5)
[Jun 11 11:55:37][chn2] CURL: Sent 28 bytes..
[Jun 11 11:55:37][chn2] CURL: Sent '[ [ 1528710937262, -4064 ] ]' bytes
[Jun 11 11:55:37][chn2] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:37][chn1] compare: 1528710935289 1528710937262
[Jun 11 11:55:37][chn1] copied 1/1 values for middleware transmission
[Jun 11 11:55:37][chn2] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:37][chn2] CURL: Received 26 bytes
[Jun 11 11:55:37][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:37][chn2] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:37][chn2] CURL: Closing connection 5
[Jun 11 11:55:37][chn2] CURL Request succeeded with code: 200
[Jun 11 11:55:37][chn0] JSON request body: [ [ 1528710937262, 20981052.600000001 ] ]
[Jun 11 11:55:37][chn2] emptied all (1) values
[Jun 11 11:55:37][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:37][chn0] CURL: Trying ::1...
[Jun 11 11:55:37][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:37][chn0] CURL: Connected to localhost (::1) port 80 (#6)
[Jun 11 11:55:37][chn0] CURL: Sent 41 bytes..
[Jun 11 11:55:37][chn0] CURL: Sent '[ [ 1528710937262, 20981052.600000001 ] ]' bytes
[Jun 11 11:55:37][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:37][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:37][chn0] CURL: Received 26 bytes
[Jun 11 11:55:37][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:37][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:37][chn0] CURL: Closing connection 6
[Jun 11 11:55:37][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:37][chn1] JSON request body: [ [ 1528710937262, 31985221.800000001 ] ]
[Jun 11 11:55:37][chn0] emptied all (1) values
[Jun 11 11:55:37][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:37][chn1] CURL: Trying ::1...
[Jun 11 11:55:37][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:37][chn1] CURL: Connected to localhost (::1) port 80 (#7)
[Jun 11 11:55:37][chn1] CURL: Sent 41 bytes..
[Jun 11 11:55:37][chn1] CURL: Sent '[ [ 1528710937262, 31985221.800000001 ] ]' bytes
[Jun 11 11:55:37][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:37][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:37][chn1] CURL: Received 26 bytes
[Jun 11 11:55:37][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:37][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:37][chn1] CURL: Closing connection 7
[Jun 11 11:55:37][chn1] CURL Request succeeded with code: 200
[Jun 11 11:55:37][chn1] emptied all (1) values
[Jun 11 11:55:37][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:37][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789151.10 ts=1528710937740
[Jun 11 11:55:37][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788151.10 ts=1528710937740
[Jun 11 11:55:37][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710937740
[Jun 11 11:55:37][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4533.00 ts=1528710937740
[Jun 11 11:55:37][chn3] Adding reading to queue (value=46789151.10 ts=1528710937740)
[Jun 11 11:55:37][chn4] Adding reading to queue (value=-4533.00 ts=1528710937740)
[Jun 11 11:55:37][chn3] ==> number of tuples: 1
[Jun 11 11:55:37][chn4] ==> number of tuples: 1
[Jun 11 11:55:37][chn3] compare: 1528710935709 1528710937740
[Jun 11 11:55:37][chn4] compare: 1528710935709 1528710937740
[Jun 11 11:55:37][chn3] copied 1/1 values for middleware transmission
[Jun 11 11:55:37][chn4] copied 1/1 values for middleware transmission
[Jun 11 11:55:37][chn3] JSON request body: [ [ 1528710937740, 46789151.100000001 ] ]
[Jun 11 11:55:37][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:37][chn3] CURL: Trying ::1...
[Jun 11 11:55:37][chn3] CURL: TCP_NODELAY set
[Jun 11 11:55:37][chn3] CURL: Connected to localhost (::1) port 80 (#8)
[Jun 11 11:55:37][chn3] CURL: Sent 41 bytes..
[Jun 11 11:55:37][chn3] CURL: Sent '[ [ 1528710937740, 46789151.100000001 ] ]' bytes
[Jun 11 11:55:37][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:37][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:37][chn3] CURL: Received 26 bytes
[Jun 11 11:55:37][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:37][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:37][chn3] CURL: Closing connection 8
[Jun 11 11:55:37][chn3] CURL Request succeeded with code: 200
[Jun 11 11:55:37][chn4] JSON request body: [ [ 1528710937740, -4533 ] ]
[Jun 11 11:55:37][chn3] emptied all (1) values
[Jun 11 11:55:37][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:37][chn4] CURL: Trying ::1...
[Jun 11 11:55:37][chn4] CURL: TCP_NODELAY set
[Jun 11 11:55:37][chn4] CURL: Connected to localhost (::1) port 80 (#9)
[Jun 11 11:55:37][chn4] CURL: Sent 28 bytes..
[Jun 11 11:55:37][chn4] CURL: Sent '[ [ 1528710937740, -4533 ] ]' bytes
[Jun 11 11:55:37][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:37][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:37][chn4] CURL: Received 26 bytes
[Jun 11 11:55:37][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:37][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:37][chn4] CURL: Closing connection 9
[Jun 11 11:55:37][chn4] CURL Request succeeded with code: 200
[Jun 11 11:55:37][chn4] emptied all (1) values
[Jun 11 11:55:39][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:39][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985224.10 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984224.10 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710939257
[Jun 11 11:55:39][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4036.00 ts=1528710939257
[Jun 11 11:55:39][chn0] Adding reading to queue (value=20981052.60 ts=1528710939257)
[Jun 11 11:55:39][chn1] Adding reading to queue (value=31985224.10 ts=1528710939257)
[Jun 11 11:55:39][chn2] Adding reading to queue (value=-4036.00 ts=1528710939257)
[Jun 11 11:55:39][chn0] ==> number of tuples: 1
[Jun 11 11:55:39][chn0] compare: 1528710937262 1528710939257
[Jun 11 11:55:39][chn0] copied 1/1 values for middleware transmission
[Jun 11 11:55:39][chn0] JSON request body: [ [ 1528710939257, 20981052.600000001 ] ]
[Jun 11 11:55:39][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:39][chn0] CURL: Trying ::1...
[Jun 11 11:55:39][chn1] ==> number of tuples: 1
[Jun 11 11:55:39][chn1] compare: 1528710937262 1528710939257
[Jun 11 11:55:39][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:39][chn1] copied 1/1 values for middleware transmission
[Jun 11 11:55:39][chn2] ==> number of tuples: 1
[Jun 11 11:55:39][chn2] compare: 1528710937262 1528710939257
[Jun 11 11:55:39][chn2] copied 1/1 values for middleware transmission
[Jun 11 11:55:39][chn0] CURL: Connected to localhost (::1) port 80 (#10)
[Jun 11 11:55:39][chn0] CURL: Sent 41 bytes..
[Jun 11 11:55:39][chn0] CURL: Sent '[ [ 1528710939257, 20981052.600000001 ] ]' bytes
[Jun 11 11:55:39][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:39][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:39][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789153.60 ts=1528710939706
[Jun 11 11:55:39][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788153.60 ts=1528710939706
[Jun 11 11:55:39][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710939706
[Jun 11 11:55:39][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4505.00 ts=1528710939706
[Jun 11 11:55:39][chn3] Adding reading to queue (value=46789153.60 ts=1528710939706)
[Jun 11 11:55:39][chn4] Adding reading to queue (value=-4505.00 ts=1528710939706)
[Jun 11 11:55:39][chn3] ==> number of tuples: 1
[Jun 11 11:55:39][chn3] compare: 1528710937740 1528710939706
[Jun 11 11:55:39][chn3] copied 1/1 values for middleware transmission
[Jun 11 11:55:39][chn4] ==> number of tuples: 1
[Jun 11 11:55:39][chn4] compare: 1528710937740 1528710939706
[Jun 11 11:55:39][chn4] copied 1/1 values for middleware transmission
[Jun 11 11:55:41][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:41][chn0] CURL: Received 26 bytes
[Jun 11 11:55:41][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:41][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:41][chn0] CURL: Closing connection 10
[Jun 11 11:55:41][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:41][chn1] JSON request body: [ [ 1528710939257, 31985224.100000001 ] ]
[Jun 11 11:55:41][chn0] emptied all (1) values
[Jun 11 11:55:41][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:41][chn1] CURL: Trying ::1...
[Jun 11 11:55:41][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:41][chn1] CURL: Connected to localhost (::1) port 80 (#11)
[Jun 11 11:55:41][chn1] CURL: Sent 41 bytes..
[Jun 11 11:55:41][chn1] CURL: Sent '[ [ 1528710939257, 31985224.100000001 ] ]' bytes
[Jun 11 11:55:41][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:41][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:41][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985226.30 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984226.30 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710941284
[Jun 11 11:55:41][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4031.00 ts=1528710941284
[Jun 11 11:55:41][chn0] Adding reading to queue (value=20981052.60 ts=1528710941284)
[Jun 11 11:55:41][chn1] Adding reading to queue (value=31985226.30 ts=1528710941284)
[Jun 11 11:55:41][chn2] Adding reading to queue (value=-4031.00 ts=1528710941284)
[Jun 11 11:55:41][chn0] ==> number of tuples: 1
[Jun 11 11:55:41][chn0] compare: 1528710939257 1528710941284
[Jun 11 11:55:41][chn0] copied 1/1 values for middleware transmission
[Jun 11 11:55:41][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:41][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789156.10 ts=1528710941706
[Jun 11 11:55:41][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788156.10 ts=1528710941706
[Jun 11 11:55:41][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710941706
[Jun 11 11:55:41][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4508.00 ts=1528710941706
[Jun 11 11:55:41][chn3] Adding reading to queue (value=46789156.10 ts=1528710941706)
[Jun 11 11:55:41][chn4] Adding reading to queue (value=-4508.00 ts=1528710941706)
[Jun 11 11:55:42][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:42][chn1] CURL: Received 26 bytes
[Jun 11 11:55:42][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:42][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:42][chn1] CURL: Closing connection 11
[Jun 11 11:55:42][chn1] CURL Request succeeded with code: 200
[Jun 11 11:55:42][chn1] emptied all (1) values
[Jun 11 11:55:42][chn1] ==> number of tuples: 1
[Jun 11 11:55:42][chn1] compare: 1528710939257 1528710941284
[Jun 11 11:55:42][chn1] copied 1/1 values for middleware transmission
[Jun 11 11:55:42][chn1] JSON request body: [ [ 1528710941284, 31985226.300000001 ] ]
[Jun 11 11:55:42][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:42][chn1] CURL: Trying ::1...
[Jun 11 11:55:42][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:42][chn1] CURL: Connected to localhost (::1) port 80 (#12)
[Jun 11 11:55:42][chn1] CURL: Sent 41 bytes..
[Jun 11 11:55:42][chn1] CURL: Sent '[ [ 1528710941284, 31985226.300000001 ] ]' bytes
[Jun 11 11:55:42][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:43][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:43][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710943255
[Jun 11 11:55:43][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710943256
[Jun 11 11:55:43][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710943256
[Jun 11 11:55:43][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985228.50 ts=1528710943256
[Jun 11 11:55:43][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984228.50 ts=1528710943256
[Jun 11 11:55:43][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710943256
[Jun 11 11:55:43][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4015.00 ts=1528710943256
[Jun 11 11:55:43][chn0] Adding reading to queue (value=20981052.60 ts=1528710943255)
[Jun 11 11:55:43][chn1] Adding reading to queue (value=31985228.50 ts=1528710943256)
[Jun 11 11:55:43][chn2] Adding reading to queue (value=-4015.00 ts=1528710943256)
[Jun 11 11:55:43][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:43][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789158.60 ts=1528710943737
[Jun 11 11:55:43][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788158.60 ts=1528710943737
[Jun 11 11:55:43][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710943737
[Jun 11 11:55:43][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4492.00 ts=1528710943737
[Jun 11 11:55:43][chn3] Adding reading to queue (value=46789158.60 ts=1528710943737)
[Jun 11 11:55:43][chn4] Adding reading to queue (value=-4492.00 ts=1528710943737)
[Jun 11 11:55:45][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:45][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985230.80 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984230.80 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710945254
[Jun 11 11:55:45][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-3983.00 ts=1528710945254
[Jun 11 11:55:45][chn0] Adding reading to queue (value=20981052.60 ts=1528710945254)
[Jun 11 11:55:45][chn1] Adding reading to queue (value=31985230.80 ts=1528710945254)
[Jun 11 11:55:45][chn2] Adding reading to queue (value=-3983.00 ts=1528710945254)
[Jun 11 11:55:45][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:45][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789161.10 ts=1528710945705
[Jun 11 11:55:45][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788161.10 ts=1528710945705
[Jun 11 11:55:45][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710945705
[Jun 11 11:55:45][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4448.00 ts=1528710945705
[Jun 11 11:55:45][chn3] Adding reading to queue (value=46789161.10 ts=1528710945705)
[Jun 11 11:55:45][chn4] Adding reading to queue (value=-4448.00 ts=1528710945705)
[Jun 11 11:55:47][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:47][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710947290
[Jun 11 11:55:47][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710947290
[Jun 11 11:55:47][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710947291
[Jun 11 11:55:47][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985232.90 ts=1528710947291
[Jun 11 11:55:47][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984232.90 ts=1528710947291
[Jun 11 11:55:47][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710947291
[Jun 11 11:55:47][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-3954.00 ts=1528710947291
[Jun 11 11:55:47][chn0] Adding reading to queue (value=20981052.60 ts=1528710947290)
[Jun 11 11:55:47][chn1] Adding reading to queue (value=31985232.90 ts=1528710947291)
[Jun 11 11:55:47][chn2] Adding reading to queue (value=-3954.00 ts=1528710947291)
[Jun 11 11:55:47][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:47][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789163.60 ts=1528710947706
[Jun 11 11:55:47][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788163.60 ts=1528710947706
[Jun 11 11:55:47][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710947706
[Jun 11 11:55:47][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4427.00 ts=1528710947706
[Jun 11 11:55:47][chn3] Adding reading to queue (value=46789163.60 ts=1528710947706)
[Jun 11 11:55:47][chn4] Adding reading to queue (value=-4427.00 ts=1528710947706)
[Jun 11 11:55:48][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:48][chn1] CURL: Received 26 bytes
[Jun 11 11:55:48][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:48][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:48][chn1] CURL: Closing connection 12
[Jun 11 11:55:48][chn1] CURL Request succeeded with code: 200
[Jun 11 11:55:48][chn1] emptied all (1) values
[Jun 11 11:55:48][chn1] ==> number of tuples: 3
[Jun 11 11:55:48][chn1] compare: 1528710941284 1528710943256
[Jun 11 11:55:48][chn1] compare: 1528710943256 1528710945254
[Jun 11 11:55:48][chn1] compare: 1528710945254 1528710947291
[Jun 11 11:55:48][chn1] copied 3/3 values for middleware transmission
[Jun 11 11:55:48][chn1] JSON request body: [ [ 1528710943256, 31985228.5 ], [ 1528710945254, 31985230.800000001 ], [ 1528710947291, 31985232.900000002 ] ]
[Jun 11 11:55:48][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:48][chn1] CURL: Trying ::1...
[Jun 11 11:55:48][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:48][chn1] CURL: Connected to localhost (::1) port 80 (#13)
[Jun 11 11:55:48][chn1] CURL: Sent 111 bytes..
[Jun 11 11:55:48][chn1] CURL: Sent '[ [ 1528710943256, 31985228.5 ], [ 1528710945254, 31985230.800000001 ], [ 1528710947291, 31985232.900000002 ] ]' bytes
[Jun 11 11:55:48][chn1] CURL: upload completely sent off: 111 out of 111 bytes
[Jun 11 11:55:49][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:49][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985235.10 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984235.10 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710949253
[Jun 11 11:55:49][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-3917.00 ts=1528710949253
[Jun 11 11:55:49][chn0] Adding reading to queue (value=20981052.60 ts=1528710949253)
[Jun 11 11:55:49][chn1] Adding reading to queue (value=31985235.10 ts=1528710949253)
[Jun 11 11:55:49][chn2] Adding reading to queue (value=-3917.00 ts=1528710949253)
[Jun 11 11:55:49][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:49][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789166.00 ts=1528710949735
[Jun 11 11:55:49][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788166.00 ts=1528710949735
[Jun 11 11:55:49][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710949735
[Jun 11 11:55:49][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4390.00 ts=1528710949735
[Jun 11 11:55:49][chn3] Adding reading to queue (value=46789166.00 ts=1528710949735)
[Jun 11 11:55:49][chn4] Adding reading to queue (value=-4390.00 ts=1528710949735)
[Jun 11 11:55:50][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn1] CURL: Received 26 bytes
[Jun 11 11:55:50][chn1] CURL: Received '{"version":"0.3","rows":3}' bytes
[Jun 11 11:55:50][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn1] CURL: Closing connection 13
[Jun 11 11:55:50][chn3] JSON request body: [ [ 1528710939706, 46789153.600000001 ] ]
[Jun 11 11:55:50][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn3] CURL: Trying ::1...
[Jun 11 11:55:50][chn3] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn3] CURL: Connected to localhost (::1) port 80 (#14)
[Jun 11 11:55:50][chn3] CURL: Sent 41 bytes..
[Jun 11 11:55:50][chn3] CURL: Sent '[ [ 1528710939706, 46789153.600000001 ] ]' bytes
[Jun 11 11:55:50][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:50][chn1] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn1] emptied all (3) values
[Jun 11 11:55:50][chn1] ==> number of tuples: 1
[Jun 11 11:55:50][chn1] compare: 1528710947291 1528710949253
[Jun 11 11:55:50][chn1] copied 1/1 values for middleware transmission
[Jun 11 11:55:50][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn3] CURL: Received 26 bytes
[Jun 11 11:55:50][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:50][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn3] CURL: Closing connection 14
[Jun 11 11:55:50][chn3] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn2] JSON request body: [ [ 1528710939257, -4036 ] ]
[Jun 11 11:55:50][chn3] emptied all (1) values
[Jun 11 11:55:50][chn3] ==> number of tuples: 5
[Jun 11 11:55:50][chn3] compare: 1528710939706 1528710941706
[Jun 11 11:55:50][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn3] compare: 1528710941706 1528710943737
[Jun 11 11:55:50][chn3] compare: 1528710943737 1528710945705
[Jun 11 11:55:50][chn3] compare: 1528710945705 1528710947706
[Jun 11 11:55:50][chn3] compare: 1528710947706 1528710949735
[Jun 11 11:55:50][chn3] copied 5/5 values for middleware transmission
[Jun 11 11:55:50][chn2] CURL: Trying ::1...
[Jun 11 11:55:50][chn2] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn2] CURL: Connected to localhost (::1) port 80 (#15)
[Jun 11 11:55:50][chn2] CURL: Sent 28 bytes..
[Jun 11 11:55:50][chn2] CURL: Sent '[ [ 1528710939257, -4036 ] ]' bytes
[Jun 11 11:55:50][chn2] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:50][chn2] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn2] CURL: Received 26 bytes
[Jun 11 11:55:50][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:50][chn2] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn2] CURL: Closing connection 15
[Jun 11 11:55:50][chn2] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn0] JSON request body: [ [ 1528710941284, 20981052.600000001 ] ]
[Jun 11 11:55:50][chn2] emptied all (1) values
[Jun 11 11:55:50][chn2] ==> number of tuples: 5
[Jun 11 11:55:50][chn2] compare: 1528710939257 1528710941284
[Jun 11 11:55:50][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn2] compare: 1528710941284 1528710943256
[Jun 11 11:55:50][chn2] compare: 1528710943256 1528710945254
[Jun 11 11:55:50][chn0] CURL: Trying ::1...
[Jun 11 11:55:50][chn2] compare: 1528710945254 1528710947291
[Jun 11 11:55:50][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn2] compare: 1528710947291 1528710949253
[Jun 11 11:55:50][chn2] copied 5/5 values for middleware transmission
[Jun 11 11:55:50][chn0] CURL: Connected to localhost (::1) port 80 (#16)
[Jun 11 11:55:50][chn0] CURL: Sent 41 bytes..
[Jun 11 11:55:50][chn0] CURL: Sent '[ [ 1528710941284, 20981052.600000001 ] ]' bytes
[Jun 11 11:55:50][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:50][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn0] CURL: Received 26 bytes
[Jun 11 11:55:50][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:50][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn0] CURL: Closing connection 16
[Jun 11 11:55:50][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn0] emptied all (1) values
[Jun 11 11:55:50][chn0] ==> number of tuples: 4
[Jun 11 11:55:50][chn0] compare: 1528710941284 1528710943255
[Jun 11 11:55:50][chn0] compare: 1528710943255 1528710945254
[Jun 11 11:55:50][chn0] compare: 1528710945254 1528710947290
[Jun 11 11:55:50][chn0] compare: 1528710947290 1528710949253
[Jun 11 11:55:50][chn0] copied 4/4 values for middleware transmission
[Jun 11 11:55:50][chn0] JSON request body: [ [ 1528710943255, 20981052.600000001 ], [ 1528710945254, 20981052.600000001 ], [ 1528710947290, 20981052.60000000$
[Jun 11 11:55:50][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn0] CURL: Trying ::1...
[Jun 11 11:55:50][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn0] CURL: Connected to localhost (::1) port 80 (#17)
[Jun 11 11:55:50][chn0] CURL: Sent 158 bytes..
[Jun 11 11:55:50][chn0] CURL: Sent '[ [ 1528710943255, 20981052.600000001 ], [ 1528710945254, 20981052.600000001 ], [ 1528710947290, 20981052.600000001 ], [ $
[Jun 11 11:55:50][chn0] CURL: upload completely sent off: 158 out of 158 bytes
[Jun 11 11:55:50][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn0] CURL: Received 26 bytes
[Jun 11 11:55:50][chn0] CURL: Received '{"version":"0.3","rows":4}' bytes
[Jun 11 11:55:50][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn0] CURL: Closing connection 17
[Jun 11 11:55:50][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn4] JSON request body: [ [ 1528710939706, -4505 ] ]
[Jun 11 11:55:50][chn0] emptied all (4) values
[Jun 11 11:55:50][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn4] CURL: Trying ::1...
[Jun 11 11:55:50][chn4] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn4] CURL: Connected to localhost (::1) port 80 (#18)
[Jun 11 11:55:50][chn4] CURL: Sent 28 bytes..
[Jun 11 11:55:50][chn4] CURL: Sent '[ [ 1528710939706, -4505 ] ]' bytes
[Jun 11 11:55:50][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 11:55:50][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:50][chn4] CURL: Received 26 bytes
[Jun 11 11:55:50][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:50][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:50][chn4] CURL: Closing connection 18
[Jun 11 11:55:50][chn4] CURL Request succeeded with code: 200
[Jun 11 11:55:50][chn3] JSON request body: [ [ 1528710941706, 46789156.100000001 ], [ 1528710943737, 46789158.600000001 ], [ 1528710945705, 46789161.10000000$
[Jun 11 11:55:50][chn4] ==> number of tuples: 5
[Jun 11 11:55:50][chn4] compare: 1528710939706 1528710941706
[Jun 11 11:55:50][chn4] compare: 1528710941706 1528710943737
[Jun 11 11:55:50][chn4] compare: 1528710943737 1528710945705
[Jun 11 11:55:50][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:50][chn4] compare: 1528710945705 1528710947706
[Jun 11 11:55:50][chn4] compare: 1528710947706 1528710949735
[Jun 11 11:55:50][chn3] CURL: Trying ::1...
[Jun 11 11:55:50][chn4] copied 5/5 values for middleware transmission
[Jun 11 11:55:50][chn3] CURL: TCP_NODELAY set
[Jun 11 11:55:50][chn3] CURL: Connected to localhost (::1) port 80 (#19)
[Jun 11 11:55:50][chn3] CURL: Sent 187 bytes..
[Jun 11 11:55:50][chn3] CURL: Sent '[ [ 1528710941706, 46789156.100000001 ], [ 1528710943737, 46789158.600000001 ], [ 1528710945705, 46789161.100000001 ], [ $
[Jun 11 11:55:50][chn3] CURL: upload completely sent off: 187 out of 187 bytes
[Jun 11 11:55:51][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:51][chn3] CURL: Received 26 bytes
[Jun 11 11:55:51][chn3] CURL: Received '{"version":"0.3","rows":5}' bytes
[Jun 11 11:55:51][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:51][chn3] CURL: Closing connection 19
[Jun 11 11:55:51][chn3] CURL Request succeeded with code: 200
[Jun 11 11:55:51][chn2] JSON request body: [ [ 1528710941284, -4031 ], [ 1528710943256, -4015 ], [ 1528710945254, -3983 ], [ 1528710947291, -3954 ], [ 152871$
[Jun 11 11:55:51][chn3] emptied all (5) values
[Jun 11 11:55:51][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:51][chn2] CURL: Trying ::1...
[Jun 11 11:55:51][chn2] CURL: TCP_NODELAY set
[Jun 11 11:55:51][chn2] CURL: Connected to localhost (::1) port 80 (#20)
[Jun 11 11:55:51][chn2] CURL: Sent 132 bytes..
[Jun 11 11:55:51][chn2] CURL: Sent '[ [ 1528710941284, -4031 ], [ 1528710943256, -4015 ], [ 1528710945254, -3983 ], [ 1528710947291, -3954 ], [ 1528710949253$
[Jun 11 11:55:51][chn2] CURL: upload completely sent off: 132 out of 132 bytes
[Jun 11 11:55:51][mtr0] Got 7 new readings from meter:
[Jun 11 11:55:51][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981052.60 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980052.60 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31985237.30 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31984237.30 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710951254
[Jun 11 11:55:51][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-3880.00 ts=1528710951254
[Jun 11 11:55:51][chn0] Adding reading to queue (value=20981052.60 ts=1528710951254)
[Jun 11 11:55:51][chn1] Adding reading to queue (value=31985237.30 ts=1528710951254)
[Jun 11 11:55:51][chn2] Adding reading to queue (value=-3880.00 ts=1528710951254)
[Jun 11 11:55:51][chn0] ==> number of tuples: 1
[Jun 11 11:55:51][chn0] compare: 1528710949253 1528710951254
[Jun 11 11:55:51][chn0] copied 1/1 values for middleware transmission
[Jun 11 11:55:51][mtr1] Got 4 new readings from meter:
[Jun 11 11:55:51][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46789168.40 ts=1528710951704
[Jun 11 11:55:51][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46788168.40 ts=1528710951704
[Jun 11 11:55:51][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528710951704
[Jun 11 11:55:51][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-4346.00 ts=1528710951704
[Jun 11 11:55:51][chn3] Adding reading to queue (value=46789168.40 ts=1528710951704)
[Jun 11 11:55:51][chn4] Adding reading to queue (value=-4346.00 ts=1528710951704)
[Jun 11 11:55:51][chn3] ==> number of tuples: 1
[Jun 11 11:55:51][chn3] compare: 1528710949735 1528710951704
[Jun 11 11:55:51][chn3] copied 1/1 values for middleware transmission
[Jun 11 11:55:51][chn2] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:51][chn2] CURL: Received 26 bytes
[Jun 11 11:55:51][chn2] CURL: Received '{"version":"0.3","rows":5}' bytes
[Jun 11 11:55:51][chn2] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:51][chn2] CURL: Closing connection 20
[Jun 11 11:55:51][chn2] CURL Request succeeded with code: 200
[Jun 11 11:55:51][chn4] JSON request body: [ [ 1528710941706, -4508 ], [ 1528710943737, -4492 ], [ 1528710945705, -4448 ], [ 1528710947706, -4427 ], [ 152871$
[Jun 11 11:55:51][chn2] emptied all (5) values
[Jun 11 11:55:51][chn2] ==> number of tuples: 1
[Jun 11 11:55:51][chn2] compare: 1528710949253 1528710951254
[Jun 11 11:55:51][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:51][chn2] copied 1/1 values for middleware transmission
[Jun 11 11:55:51][chn4] CURL: Trying ::1...
[Jun 11 11:55:51][chn4] CURL: TCP_NODELAY set
[Jun 11 11:55:51][chn4] CURL: Connected to localhost (::1) port 80 (#21)
[Jun 11 11:55:51][chn4] CURL: Sent 132 bytes..
[Jun 11 11:55:51][chn4] CURL: Sent '[ [ 1528710941706, -4508 ], [ 1528710943737, -4492 ], [ 1528710945705, -4448 ], [ 1528710947706, -4427 ], [ 1528710949735$
[Jun 11 11:55:51][chn4] CURL: upload completely sent off: 132 out of 132 bytes
[Jun 11 11:55:51][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:51][chn4] CURL: Received 26 bytes
[Jun 11 11:55:51][chn4] CURL: Received '{"version":"0.3","rows":5}' bytes
[Jun 11 11:55:51][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:51][chn4] CURL: Closing connection 21
[Jun 11 11:55:51][chn4] CURL Request succeeded with code: 200
[Jun 11 11:55:51][chn4] emptied all (5) values
[Jun 11 11:55:51][chn0] JSON request body: [ [ 1528710951254, 20981052.600000001 ] ]
[Jun 11 11:55:51][chn4] ==> number of tuples: 1
[Jun 11 11:55:51][chn4] compare: 1528710949735 1528710951704
[Jun 11 11:55:51][chn4] copied 1/1 values for middleware transmission
[Jun 11 11:55:51][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:51][chn0] CURL: Trying ::1...
[Jun 11 11:55:51][chn0] CURL: TCP_NODELAY set
[Jun 11 11:55:51][chn0] CURL: Connected to localhost (::1) port 80 (#22)
[Jun 11 11:55:51][chn0] CURL: Sent 41 bytes..
[Jun 11 11:55:51][chn0] CURL: Sent '[ [ 1528710951254, 20981052.600000001 ] ]' bytes
[Jun 11 11:55:51][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:52][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:52][chn0] CURL: Received 26 bytes
[Jun 11 11:55:52][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 11:55:52][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 11:55:52][chn0] CURL: Closing connection 22
[Jun 11 11:55:52][chn0] CURL Request succeeded with code: 200
[Jun 11 11:55:52][chn1] JSON request body: [ [ 1528710949253, 31985235.100000001 ] ]
[Jun 11 11:55:52][chn0] emptied all (1) values
[Jun 11 11:55:52][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 11:55:52][chn1] CURL: Trying ::1...
[Jun 11 11:55:52][chn1] CURL: TCP_NODELAY set
[Jun 11 11:55:52][chn1] CURL: Connected to localhost (::1) port 80 (#23)
[Jun 11 11:55:52][chn1] CURL: Sent 41 bytes..
[Jun 11 11:55:52][chn1] CURL: Sent '[ [ 1528710949253, 31985235.100000001 ] ]' bytes
[Jun 11 11:55:52][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 11:55:52][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 11:55:52][chn1] CURL: Received 26 bytes
[Jun 11 11:55:52][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
-------------- next part --------------
[Jun 11 12:10:23][main] vzlogger v0.6.1 based on heads/master-0-gd3381ce6ba from Sat, 9 Dec 2017 15:49:37 +0100 started.
[Jun 11 12:10:23][mtr0] Creating new meter with protocol sml.
[Jun 11 12:10:23][sml] pullseq len:0 found
[Jun 11 12:10:23][mtr0] Meter configured, enabled.
[Jun 11 12:10:23] New meter initialized (protocol=sml)
[Jun 11 12:10:23] Configure channel.
[Jun 11 12:10:23][chn0] New channel initialized (uuid=...2d2855 api=volkszaehler id=1-0:1.8.0*255)
[Jun 11 12:10:23] Configure channel.
[Jun 11 12:10:23][chn1] New channel initialized (uuid=...1c7608 api=volkszaehler id=1-0:2.8.0*255)
[Jun 11 12:10:23] Configure channel.
[Jun 11 12:10:23][chn2] New channel initialized (uuid=...de1ece api=volkszaehler id=1-0:16.7.0*255)
[Jun 11 12:10:23][mtr1] Creating new meter with protocol sml.
[Jun 11 12:10:23][sml] pullseq len:0 found
[Jun 11 12:10:23][mtr1] Meter configured, enabled.
[Jun 11 12:10:23] New meter initialized (protocol=sml)
[Jun 11 12:10:23] Configure channel.
[Jun 11 12:10:23][chn3] New channel initialized (uuid=...c461c1 api=volkszaehler id=1-0:2.8.0*255)
[Jun 11 12:10:23] Configure channel.
[Jun 11 12:10:23][chn4] New channel initialized (uuid=...0ea983 api=volkszaehler id=1-0:16.7.0*255)
[Jun 11 12:10:23] Have 2 meters.
[Jun 11 12:10:23][main] log level is 15
[Jun 11 12:10:23][main] daemon=0, local=1
[Jun 11 12:10:23] Process not daemonized...
[Jun 11 12:10:23] Opened logfile /var/log/vzlogger.log
[Jun 11 12:10:25][push] No pushDataServer defined.
[Jun 11 12:10:25][] ===> Start meters
[Jun 11 12:10:25][mtr0] Meter connection established
[Jun 11 12:10:25][mtr0] Meter thread started
[Jun 11 12:10:25][mtr0] Meter is opened. Starting channels.
[Jun 11 12:10:25][mtr0] Number of readers: 32
[Jun 11 12:10:25][chn0] Logging thread started
[Jun 11 12:10:25][chn0] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 12:10:25][mtr0] Config.daemon: 0
[Jun 11 12:10:25][chn1] Logging thread started
[Jun 11 12:10:25][mtr0] Config.local: 1
[Jun 11 12:10:25][chn2] Logging thread started
[Jun 11 12:10:25][chn0] Using default volkszaehler api.
[Jun 11 12:10:25][chn1] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 12:10:25][chn1] Using default volkszaehler api.
[Jun 11 12:10:25][chn2] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 12:10:25][chn2] Using default volkszaehler api.
[Jun 11 12:10:25][mtr1] Meter connection established
[Jun 11 12:10:25][mtr1] Meter thread started
[Jun 11 12:10:25][mtr1] Number of readers: 32
[Jun 11 12:10:25][mtr1] Meter is opened. Starting channels.
[Jun 11 12:10:25][chn3] Logging thread started
[Jun 11 12:10:25][mtr1] Config.daemon: 0
[Jun 11 12:10:25][chn4] Logging thread started
[Jun 11 12:10:25][mtr1] Config.local: 1
[Jun 11 12:10:25][http] Starting local interface HTTPd on port 8080
[Jun 11 12:10:25][chn3] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 12:10:25][] Startup done.
[Jun 11 12:10:25][chn3] Using default volkszaehler api.
[Jun 11 12:10:25][chn4] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 11 12:10:25][chn4] Using default volkszaehler api.
libsml: warning: could not read the whole file
[Jun 11 12:10:32][mtr0] Got 0 new readings from meter:
[Jun 11 12:10:32][chn0] ==> number of tuples: 0
[Jun 11 12:10:32][chn0] JSON request body is null. Nothing to send now.
[Jun 11 12:10:32][chn1] ==> number of tuples: 0
[Jun 11 12:10:32][chn1] JSON request body is null. Nothing to send now.
[Jun 11 12:10:32][chn2] ==> number of tuples: 0
[Jun 11 12:10:32][chn2] JSON request body is null. Nothing to send now.
libsml: warning: could not read the whole file
[Jun 11 12:11:10][mtr0] Got 0 new readings from meter:
[Jun 11 12:11:10][chn0] ==> number of tuples: 0
[Jun 11 12:11:10][chn0] JSON request body is null. Nothing to send now.
[Jun 11 12:11:10][chn1] ==> number of tuples: 0
[Jun 11 12:11:10][chn1] JSON request body is null. Nothing to send now.
[Jun 11 12:11:10][chn2] ==> number of tuples: 0
[Jun 11 12:11:10][chn2] JSON request body is null. Nothing to send now.
[Jun 11 12:11:16][mtr0] Got 7 new readings from meter:
[Jun 11 12:11:16][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20981062.30 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20980062.30 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31986095.20 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31985095.20 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528711876016
[Jun 11 12:11:16][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-5139.00 ts=1528711876016
[Jun 11 12:11:16][chn0] Adding reading to queue (value=20981062.30 ts=1528711876016)
[Jun 11 12:11:16][chn1] Adding reading to queue (value=31986095.20 ts=1528711876016)
[Jun 11 12:11:16][chn2] Adding reading to queue (value=-5139.00 ts=1528711876016)
[Jun 11 12:11:16][chn0] ==> number of tuples: 1
[Jun 11 12:11:16][chn0] compare: 0 1528711876016
[Jun 11 12:11:16][chn0] copied 1/1 values for middleware transmission
[Jun 11 12:11:16][chn0] JSON request body: [ [ 1528711876016, 20981062.300000001 ] ]
[Jun 11 12:11:16][chn2] ==> number of tuples: 1
[Jun 11 12:11:16][chn2] compare: 0 1528711876016
[Jun 11 12:11:16][chn2] copied 1/1 values for middleware transmission
[Jun 11 12:11:16][chn1] ==> number of tuples: 1
[Jun 11 12:11:16][chn1] compare: 0 1528711876016
[Jun 11 12:11:16][chn1] copied 1/1 values for middleware transmission
[Jun 11 12:11:16][chn0] CURL: Trying ::1...
[Jun 11 12:11:16][chn0] CURL: TCP_NODELAY set
[Jun 11 12:11:16][chn0] CURL: Connected to localhost (::1) port 80 (#0)
[Jun 11 12:11:16][chn0] CURL: Sent 41 bytes..
[Jun 11 12:11:16][chn0] CURL: Sent '[ [ 1528711876016, 20981062.300000001 ] ]' bytes
[Jun 11 12:11:16][chn0] CURL: upload completely sent off: 41 out of 41 bytes
libsml: error: unrecognized sequence
[Jun 11 12:11:16][sml] short message from sml_transport_read len=0
[Jun 11 12:11:16][mtr1] Got 0 new readings from meter:
[Jun 11 12:11:16][chn3] ==> number of tuples: 0
[Jun 11 12:11:16][chn3] JSON request body is null. Nothing to send now.
[Jun 11 12:11:16][chn4] ==> number of tuples: 0
[Jun 11 12:11:16][chn4] JSON request body is null. Nothing to send now.
[Jun 11 12:11:16][chn0] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:16][chn0] CURL: Received 26 bytes
[Jun 11 12:11:16][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:16][chn0] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:16][chn0] CURL: Closing connection 0
[Jun 11 12:11:16][chn2] JSON request body: [ [ 1528711876016, -5139 ] ]
[Jun 11 12:11:16][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:16][chn2] CURL: Trying ::1...
[Jun 11 12:11:16][chn2] CURL: TCP_NODELAY set
[Jun 11 12:11:16][chn2] CURL: Connected to localhost (::1) port 80 (#1)
[Jun 11 12:11:16][chn2] CURL: Sent 28 bytes..
[Jun 11 12:11:16][chn2] CURL: Sent '[ [ 1528711876016, -5139 ] ]' bytes
[Jun 11 12:11:16][chn2] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 12:11:16][chn0] CURL Request succeeded with code: 200
[Jun 11 12:11:16][chn0] emptied all (1) values
[Jun 11 12:11:16][chn2] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:16][chn2] CURL: Received 26 bytes
[Jun 11 12:11:16][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:16][chn2] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:16][chn2] CURL: Closing connection 1
[Jun 11 12:11:16][chn2] CURL Request succeeded with code: 200
[Jun 11 12:11:16][chn2] emptied all (1) values
[Jun 11 12:11:16][chn1] JSON request body: [ [ 1528711876016, 31986095.200000003 ] ]
[Jun 11 12:11:16][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:16][chn1] CURL: Trying ::1...
[Jun 11 12:11:16][chn1] CURL: TCP_NODELAY set
[Jun 11 12:11:16][chn1] CURL: Connected to localhost (::1) port 80 (#2)
[Jun 11 12:11:16][chn1] CURL: Sent 41 bytes..
[Jun 11 12:11:16][chn1] CURL: Sent '[ [ 1528711876016, 31986095.200000003 ] ]' bytes
[Jun 11 12:11:16][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 12:11:16][chn1] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:16][chn1] CURL: Received 26 bytes
[Jun 11 12:11:16][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:16][chn1] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:16][chn1] CURL: Closing connection 2
[Jun 11 12:11:16][chn1] CURL Request succeeded with code: 200
[Jun 11 12:11:16][chn1] emptied all (1) values
[Jun 11 12:11:21][mtr1] Got 4 new readings from meter:
[Jun 11 12:11:21][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46790426.20 ts=1528711881464
[Jun 11 12:11:21][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46789426.20 ts=1528711881464
[Jun 11 12:11:21][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528711881464
[Jun 11 12:11:21][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-8006.00 ts=1528711881464
[Jun 11 12:11:21][chn3] Adding reading to queue (value=46790426.20 ts=1528711881464)
[Jun 11 12:11:21][chn4] Adding reading to queue (value=-8006.00 ts=1528711881464)
[Jun 11 12:11:21][chn3] ==> number of tuples: 1
[Jun 11 12:11:21][chn3] compare: 0 1528711881464
[Jun 11 12:11:21][chn3] copied 1/1 values for middleware transmission
[Jun 11 12:11:21][chn3] JSON request body: [ [ 1528711881464, 46790426.200000003 ] ]
[Jun 11 12:11:21][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:21][chn3] CURL: Trying ::1...
[Jun 11 12:11:21][chn3] CURL: TCP_NODELAY set
[Jun 11 12:11:21][chn3] CURL: Connected to localhost (::1) port 80 (#3)
[Jun 11 12:11:21][chn3] CURL: Sent 41 bytes..
[Jun 11 12:11:21][chn3] CURL: Sent '[ [ 1528711881464, 46790426.200000003 ] ]' bytes
[Jun 11 12:11:21][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 12:11:21][chn4] ==> number of tuples: 1
[Jun 11 12:11:21][chn4] compare: 0 1528711881464
[Jun 11 12:11:21][chn4] copied 1/1 values for middleware transmission
[Jun 11 12:11:22][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:22][chn3] CURL: Received 26 bytes
[Jun 11 12:11:22][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:22][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:22][chn3] CURL: Closing connection 3
[Jun 11 12:11:22][chn3] CURL Request succeeded with code: 200
[Jun 11 12:11:22][chn4] JSON request body: [ [ 1528711881464, -8006 ] ]
[Jun 11 12:11:22][chn3] emptied all (1) values
[Jun 11 12:11:22][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:22][chn4] CURL: Trying ::1...
[Jun 11 12:11:22][chn4] CURL: TCP_NODELAY set
[Jun 11 12:11:22][chn4] CURL: Connected to localhost (::1) port 80 (#4)
[Jun 11 12:11:22][chn4] CURL: Sent 28 bytes..
[Jun 11 12:11:22][chn4] CURL: Sent '[ [ 1528711881464, -8006 ] ]' bytes
[Jun 11 12:11:22][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 12:11:22][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:22][chn4] CURL: Received 26 bytes
[Jun 11 12:11:22][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:22][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:22][chn4] CURL: Closing connection 4
[Jun 11 12:11:22][chn4] CURL Request succeeded with code: 200
[Jun 11 12:11:22][chn4] emptied all (1) values
[Jun 11 12:11:25][mtr1] Got 4 new readings from meter:
[Jun 11 12:11:25][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46790435.10 ts=1528711885493
[Jun 11 12:11:25][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46789435.10 ts=1528711885493
[Jun 11 12:11:25][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528711885493
[Jun 11 12:11:25][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-7996.00 ts=1528711885493
[Jun 11 12:11:25][chn3] Adding reading to queue (value=46790435.10 ts=1528711885493)
[Jun 11 12:11:25][chn4] Adding reading to queue (value=-7996.00 ts=1528711885493)
[Jun 11 12:11:25][chn3] ==> number of tuples: 1
[Jun 11 12:11:25][chn4] ==> number of tuples: 1
[Jun 11 12:11:25][chn3] compare: 1528711881464 1528711885493
[Jun 11 12:11:25][chn4] compare: 1528711881464 1528711885493
[Jun 11 12:11:25][chn3] copied 1/1 values for middleware transmission
[Jun 11 12:11:25][chn4] copied 1/1 values for middleware transmission
[Jun 11 12:11:25][chn3] JSON request body: [ [ 1528711885493, 46790435.100000001 ] ]
[Jun 11 12:11:25][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:25][chn3] CURL: Trying ::1...
[Jun 11 12:11:25][chn3] CURL: TCP_NODELAY set
[Jun 11 12:11:25][chn3] CURL: Connected to localhost (::1) port 80 (#5)
[Jun 11 12:11:25][chn3] CURL: Sent 41 bytes..
[Jun 11 12:11:25][chn3] CURL: Sent '[ [ 1528711885493, 46790435.100000001 ] ]' bytes
[Jun 11 12:11:25][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 12:11:26][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:26][chn3] CURL: Received 26 bytes
[Jun 11 12:11:26][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:26][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:26][chn3] CURL: Closing connection 5
[Jun 11 12:11:26][chn3] CURL Request succeeded with code: 200
[Jun 11 12:11:26][chn4] JSON request body: [ [ 1528711885493, -7996 ] ]
[Jun 11 12:11:26][chn3] emptied all (1) values
[Jun 11 12:11:26][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:26][chn4] CURL: Trying ::1...
[Jun 11 12:11:26][chn4] CURL: TCP_NODELAY set
[Jun 11 12:11:26][chn4] CURL: Connected to localhost (::1) port 80 (#6)
[Jun 11 12:11:26][chn4] CURL: Sent 28 bytes..
[Jun 11 12:11:26][chn4] CURL: Sent '[ [ 1528711885493, -7996 ] ]' bytes
[Jun 11 12:11:26][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 12:11:31][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:31][chn4] CURL: Received 26 bytes
[Jun 11 12:11:31][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:31][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:31][chn4] CURL: Closing connection 6
[Jun 11 12:11:31][chn4] CURL Request succeeded with code: 200
[Jun 11 12:11:31][chn4] emptied all (1) values
libsml: error: unrecognized sequence
[Jun 11 12:11:31][sml] short message from sml_transport_read len=0
[Jun 11 12:11:31][mtr0] Got 0 new readings from meter:
[Jun 11 12:11:31][chn0] ==> number of tuples: 0
[Jun 11 12:11:31][chn1] ==> number of tuples: 0
[Jun 11 12:11:31][chn0] JSON request body is null. Nothing to send now.
[Jun 11 12:11:31][chn1] JSON request body is null. Nothing to send now.
[Jun 11 12:11:31][chn2] ==> number of tuples: 0
[Jun 11 12:11:31][chn2] JSON request body is null. Nothing to send now.
libsml: warning: could not read the whole file
[Jun 11 12:11:31][mtr1] Got 0 new readings from meter:
[Jun 11 12:11:31][chn3] ==> number of tuples: 0
[Jun 11 12:11:31][chn3] JSON request body is null. Nothing to send now.
[Jun 11 12:11:31][chn4] ==> number of tuples: 0
[Jun 11 12:11:31][chn4] JSON request body is null. Nothing to send now.
[Jun 11 12:11:33][mtr1] Got 4 new readings from meter:
[Jun 11 12:11:33][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46790453.10 ts=1528711893460
[Jun 11 12:11:33][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46789453.10 ts=1528711893460
[Jun 11 12:11:33][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528711893460
[Jun 11 12:11:33][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-8078.00 ts=1528711893460
[Jun 11 12:11:33][chn3] Adding reading to queue (value=46790453.10 ts=1528711893460)
[Jun 11 12:11:33][chn4] Adding reading to queue (value=-8078.00 ts=1528711893460)
[Jun 11 12:11:33][chn3] ==> number of tuples: 1
[Jun 11 12:11:33][chn4] ==> number of tuples: 1
[Jun 11 12:11:33][chn3] compare: 1528711885493 1528711893460
[Jun 11 12:11:33][chn4] compare: 1528711885493 1528711893460
[Jun 11 12:11:33][chn3] copied 1/1 values for middleware transmission
[Jun 11 12:11:33][chn4] copied 1/1 values for middleware transmission
[Jun 11 12:11:33][chn3] JSON request body: [ [ 1528711893460, 46790453.100000001 ] ]
[Jun 11 12:11:33][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:33][chn3] CURL: Trying ::1...
[Jun 11 12:11:33][chn3] CURL: TCP_NODELAY set
[Jun 11 12:11:33][chn3] CURL: Connected to localhost (::1) port 80 (#7)
[Jun 11 12:11:33][chn3] CURL: Sent 41 bytes..
[Jun 11 12:11:33][chn3] CURL: Sent '[ [ 1528711893460, 46790453.100000001 ] ]' bytes
[Jun 11 12:11:33][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 12:11:33][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:33][chn3] CURL: Received 26 bytes
[Jun 11 12:11:33][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:33][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:33][chn3] CURL: Closing connection 7
[Jun 11 12:11:33][chn3] CURL Request succeeded with code: 200
[Jun 11 12:11:33][chn4] JSON request body: [ [ 1528711893460, -8078 ] ]
[Jun 11 12:11:33][chn3] emptied all (1) values
[Jun 11 12:11:33][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:33][chn4] CURL: Trying ::1...
[Jun 11 12:11:33][chn4] CURL: TCP_NODELAY set
[Jun 11 12:11:33][chn4] CURL: Connected to localhost (::1) port 80 (#8)
[Jun 11 12:11:33][chn4] CURL: Sent 28 bytes..
[Jun 11 12:11:33][chn4] CURL: Sent '[ [ 1528711893460, -8078 ] ]' bytes
[Jun 11 12:11:33][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 12:11:37][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:37][chn4] CURL: Received 26 bytes
[Jun 11 12:11:37][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:37][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:37][chn4] CURL: Closing connection 8
[Jun 11 12:11:37][chn4] CURL Request succeeded with code: 200
[Jun 11 12:11:37][chn4] emptied all (1) values
[Jun 11 12:11:39][mtr1] Got 4 new readings from meter:
[Jun 11 12:11:39][mtr1] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=46790466.70 ts=1528711899464
[Jun 11 12:11:39][mtr1] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=46789466.70 ts=1528711899464
[Jun 11 12:11:39][mtr1] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528711899464
[Jun 11 12:11:39][mtr1] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=-8150.00 ts=1528711899464
[Jun 11 12:11:39][chn3] Adding reading to queue (value=46790466.70 ts=1528711899464)
[Jun 11 12:11:39][chn4] Adding reading to queue (value=-8150.00 ts=1528711899464)
[Jun 11 12:11:39][chn3] ==> number of tuples: 1
[Jun 11 12:11:39][chn4] ==> number of tuples: 1
[Jun 11 12:11:39][chn4] compare: 1528711893460 1528711899464
[Jun 11 12:11:39][chn4] copied 1/1 values for middleware transmission
[Jun 11 12:11:39][chn4] JSON request body: [ [ 1528711899464, -8150 ] ]
[Jun 11 12:11:39][chn4] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:39][chn4] CURL: Trying ::1...
[Jun 11 12:11:39][chn3] compare: 1528711893460 1528711899464
[Jun 11 12:11:39][chn4] CURL: TCP_NODELAY set
[Jun 11 12:11:39][chn3] copied 1/1 values for middleware transmission
[Jun 11 12:11:39][chn4] CURL: Connected to localhost (::1) port 80 (#9)
[Jun 11 12:11:39][chn4] CURL: Sent 28 bytes..
[Jun 11 12:11:39][chn4] CURL: Sent '[ [ 1528711899464, -8150 ] ]' bytes
[Jun 11 12:11:39][chn4] CURL: upload completely sent off: 28 out of 28 bytes
[Jun 11 12:11:40][chn4] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:40][chn4] CURL: Received 26 bytes
[Jun 11 12:11:40][chn4] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:40][chn4] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:40][chn4] CURL: Closing connection 9
[Jun 11 12:11:40][chn4] CURL Request succeeded with code: 200
[Jun 11 12:11:40][chn3] JSON request body: [ [ 1528711899464, 46790466.700000003 ] ]
[Jun 11 12:11:40][chn4] emptied all (1) values
[Jun 11 12:11:40][chn3] CURL: Hostname localhost was found in DNS cache
[Jun 11 12:11:40][chn3] CURL: Trying ::1...
[Jun 11 12:11:40][chn3] CURL: TCP_NODELAY set
[Jun 11 12:11:40][chn3] CURL: Connected to localhost (::1) port 80 (#10)
[Jun 11 12:11:40][chn3] CURL: Sent 41 bytes..
[Jun 11 12:11:40][chn3] CURL: Sent '[ [ 1528711899464, 46790466.700000003 ] ]' bytes
[Jun 11 12:11:40][chn3] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 11 12:11:42][chn3] CURL: HTTP 1.0, assume close after body
[Jun 11 12:11:42][chn3] CURL: Received 26 bytes
[Jun 11 12:11:42][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 11 12:11:42][chn3] CURL: Curl_http_done: called premature == 0
[Jun 11 12:11:42][chn3] CURL: Closing connection 10
[Jun 11 12:11:42][chn3] CURL Request succeeded with code: 200
[Jun 11 12:11:42][chn3] emptied all (1) values
libsml: error: unrecognized sequence
[Jun 11 12:11:51][sml] short message from sml_transport_read len=0
[Jun 11 12:11:51][mtr0] Got 0 new readings from meter:
[Jun 11 12:11:51][chn0] ==> number of tuples: 0
[Jun 11 12:11:51][chn1] ==> number of tuples: 0
[Jun 11 12:11:51][chn0] JSON request body is null. Nothing to send now.
[Jun 11 12:11:51][chn1] JSON request body is null. Nothing to send now.
[Jun 11 12:11:51][chn2] ==> number of tuples: 0
[Jun 11 12:11:51][chn2] JSON request body is null. Nothing to send now.
libsml: warning: could not read the whole file
[Jun 11 12:11:53][mtr1] Got 0 new readings from meter:
[Jun 11 12:11:53][chn3] ==> number of tuples: 0
[Jun 11 12:11:53][chn4] ==> number of tuples: 0
[Jun 11 12:11:53][chn3] JSON request body is null. Nothing to send now.
[Jun 11 12:11:53][chn4] JSON request body is null. Nothing to send now.
More information about the volkszaehler-users
mailing list