[vz-users] System neu aufgesetzt und es geht nichts mehr

Heine.thomas at online.de Heine.thomas at online.de
Sun Jun 10 22:47:38 CEST 2018


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",
           "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",
           "aggmode": "none",
           "duplicates": 0
         },
         {
           "api": "volkszaehler",
           "uuid": "xxxx",    /*Wirkleistung ZR-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
     },
     {
       "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",
           "aggmode": "none",
           "duplicates": 0
         },
         {
           "api": "volkszaehler",
           "uuid": "xxxx",    /*Wirkleistung PV-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
     }
   ]
}



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/20180610/365320fc/attachment-0001.html>
-------------- next part --------------

[Jun 10 22:37:24][main] vzlogger v0.6.1 based on heads/master-0-gd3381ce6ba from Sat, 9 Dec 2017 15:49:37 +0100 started.
[Jun 10 22:37:24][mtr0] Creating new meter with protocol sml.
[Jun 10 22:37:24][sml]  pullseq len:0 found
[Jun 10 22:37:24][mtr0] Meter configured, enabled.
[Jun 10 22:37:24]       New meter initialized (protocol=sml)
[Jun 10 22:37:24]       Configure channel.
[Jun 10 22:37:24][chn0] New channel initialized (uuid=...2d2855 api=volkszaehler id=1-0:1.8.0*255)
[Jun 10 22:37:24]       Configure channel.
[Jun 10 22:37:24][chn1] New channel initialized (uuid=...1c7608 api=volkszaehler id=1-0:2.8.0*255)
[Jun 10 22:37:24]       Configure channel.
[Jun 10 22:37:24][chn2] New channel initialized (uuid=...de1ece api=volkszaehler id=1-0:16.7.0*255)
[Jun 10 22:37:24][mtr1] Creating new meter with protocol sml.
[Jun 10 22:37:24][sml]  pullseq len:0 found
[Jun 10 22:37:24][mtr1] Meter configured, enabled.
[Jun 10 22:37:24]       New meter initialized (protocol=sml)
[Jun 10 22:37:24]       Configure channel.
[Jun 10 22:37:24][chn3] New channel initialized (uuid=...c461c1 api=volkszaehler id=1-0:2.8.0*255)
[Jun 10 22:37:24]       Configure channel.
[Jun 10 22:37:24][chn4] New channel initialized (uuid=...0ea983 api=volkszaehler id=1-0:16.7.0*255)
[Jun 10 22:37:24]       Have 2 meters.
[Jun 10 22:37:24][main] log level is 15
[Jun 10 22:37:24][main] daemon=0, local=1
[Jun 10 22:37:24]       Process not  daemonized...
[Jun 10 22:37:24]       Opened logfile /var/log/vzlogger.log
[Jun 10 22:37:24][push] pushdata_thread created.
[Jun 10 22:37:24][push] Start push_data_thread
[Jun 10 22:37:24][]     ===> Start meters
[Jun 10 22:37:24][mtr0] Meter connection established
[Jun 10 22:37:24][mtr0] Meter thread started
[Jun 10 22:37:24][mtr0] Meter is opened. Starting channels.
[Jun 10 22:37:24][mtr0] Number of readers: 32
[Jun 10 22:37:24][mtr0] Config.daemon: 0
[Jun 10 22:37:24][chn0] Logging thread started
[Jun 10 22:37:24][chn0] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 10 22:37:24][mtr0] Config.local: 1
[Jun 10 22:37:24][chn1] Logging thread started
[Jun 10 22:37:24][chn1] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 10 22:37:24][chn2] Logging thread started
[Jun 10 22:37:24][chn0] Using default volkszaehler api.
[Jun 10 22:37:24][chn1] Using default volkszaehler api.
[Jun 10 22:37:24][chn2] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 10 22:37:24][chn2] Using default volkszaehler api.
[Jun 10 22:37:24][mtr1] Meter connection established
[Jun 10 22:37:24][mtr1] Meter thread started
[Jun 10 22:37:24][mtr1] Meter is opened. Starting channels.
[Jun 10 22:37:24][mtr1] Number of readers: 32
[Jun 10 22:37:24][mtr1] Config.daemon: 0
[Jun 10 22:37:24][chn3] Logging thread started
[Jun 10 22:37:24][mtr1] Config.local: 1
[Jun 10 22:37:24][chn3] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 10 22:37:24][chn4] Logging thread started
[Jun 10 22:37:24][http] Starting local interface HTTPd on port 8080
[Jun 10 22:37:24][chn3] Using default volkszaehler api.
[Jun 10 22:37:24][chn4] Start logging thread for volkszaehler-api. Running as daemon: no
[Jun 10 22:37:24][]     Startup done.
[Jun 10 22:37:24][chn4] Using default volkszaehler api.
[Jun 10 22:37:29][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:37:34][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:37:39][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: error: unrecognized sequence
[Jun 10 22:37:40][sml]  short message from sml_transport_read len=0
[Jun 10 22:37:40][mtr1] Got 0 new readings from meter:
[Jun 10 22:37:40][chn3] ==> number of tuples: 0
[Jun 10 22:37:40][chn3] JSON request body is null. Nothing to send now.
[Jun 10 22:37:40][chn4] ==> number of tuples: 0
[Jun 10 22:37:40][chn4] JSON request body is null. Nothing to send now.
[Jun 10 22:37:44][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: error: unrecognized sequence
[Jun 10 22:37:45][sml]  short message from sml_transport_read len=0
[Jun 10 22:37:45][mtr1] Got 0 new readings from meter:
[Jun 10 22:37:45][chn3] ==> number of tuples: 0
[Jun 10 22:37:45][chn3] JSON request body is null. Nothing to send now.
[Jun 10 22:37:45][chn4] ==> number of tuples: 0
[Jun 10 22:37:45][chn4] JSON request body is null. Nothing to send now.
[Jun 10 22:37:49][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:37:54][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: warning: could not read the whole file
[Jun 10 22:37:56][mtr0] Got 0 new readings from meter:
[Jun 10 22:37:56][chn1] ==> number of tuples: 0
[Jun 10 22:37:56][chn1] JSON request body is null. Nothing to send now.
[Jun 10 22:37:56][chn0] ==> number of tuples: 0
[Jun 10 22:37:56][chn2] ==> number of tuples: 0
[Jun 10 22:37:56][chn0] JSON request body is null. Nothing to send now.
[Jun 10 22:37:56][chn2] JSON request body is null. Nothing to send now.
[Jun 10 22:37:58][mtr0] Got 7 new readings from meter:
[Jun 10 22:37:58][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979103.40 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978103.40 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663078911
[Jun 10 22:37:58][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=542.00 ts=1528663078911
[Jun 10 22:37:58][chn0] Adding reading to queue (value=20979103.40 ts=1528663078911)
[Jun 10 22:37:58][push] added to uuid xxx2855
[Jun 10 22:37:58][chn1] Adding reading to queue (value=31969628.70 ts=1528663078911)
[Jun 10 22:37:58][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663078911, 20979103.400000002 ] ] } ] }
[Jun 10 22:37:58][push] added to uuid xxx7608
[Jun 10 22:37:58][chn2] Adding reading to queue (value=542.00 ts=1528663078911)
[Jun 10 22:37:58][push] added to uuid xxxe1ece
[Jun 10 22:37:58][chn0] ==> number of tuples: 1
[Jun 10 22:37:58][chn1] ==> number of tuples: 1
[Jun 10 22:37:58][push] [Jun 10 22:37:58][chn0] compare: 0 1528663078911
CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:37:58][chn1] compare: 0 1528663078911
[Jun 10 22:37:58][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:37:58][chn1] JSON request body: [ [ 1528663078911, 31969628.700000003 ] ]
[Jun 10 22:37:58][chn2] ==> number of tuples: 1
[Jun 10 22:37:58][push] send nok to url
[Jun 10 22:37:58][chn2] compare: 0 1528663078911
[Jun 10 22:37:58][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:37:58][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:37:58][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663078911, 542 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663078911, 31969628.700000003 ] ] } ] }
[Jun 10 22:37:58][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:37:58][push] send nok to url
[Jun 10 22:37:58][chn1] CURL:   Trying ::1...
[Jun 10 22:37:58][chn1] CURL: TCP_NODELAY set
[Jun 10 22:37:58][chn1] CURL: Connected to localhost (::1) port 80 (#0)
[Jun 10 22:37:58][chn1] CURL: Sent 41 bytes..
[Jun 10 22:37:58][chn1] CURL: Sent '[ [ 1528663078911, 31969628.700000003 ] ]' bytes
[Jun 10 22:37:58][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:37:59][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:37:59][chn1] CURL: Received 26 bytes
[Jun 10 22:37:59][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:37:59][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:37:59][chn1] CURL: Closing connection 0
[Jun 10 22:37:59][chn2] JSON request body: [ [ 1528663078911, 542 ] ]
[Jun 10 22:37:59][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:37:59][chn2] CURL:   Trying ::1...
[Jun 10 22:37:59][chn2] CURL: TCP_NODELAY set
[Jun 10 22:37:59][chn2] CURL: Connected to localhost (::1) port 80 (#1)
[Jun 10 22:37:59][chn2] CURL: Sent 26 bytes..
[Jun 10 22:37:59][chn2] CURL: Sent '[ [ 1528663078911, 542 ] ]' bytes
[Jun 10 22:37:59][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:37:59][chn1] CURL Request succeeded with code: 200
[Jun 10 22:37:59][chn1] emptied all (1) values
[Jun 10 22:37:59][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:37:59][chn2] CURL: Received 26 bytes
[Jun 10 22:37:59][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:37:59][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:37:59][chn2] CURL: Closing connection 1
[Jun 10 22:37:59][chn2] CURL Request succeeded with code: 200
[Jun 10 22:37:59][chn0] JSON request body: [ [ 1528663078911, 20979103.400000002 ] ]
[Jun 10 22:37:59][chn2] emptied all (1) values
[Jun 10 22:37:59][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:37:59][chn0] CURL:   Trying ::1...
[Jun 10 22:37:59][chn0] CURL: TCP_NODELAY set
[Jun 10 22:37:59][chn0] CURL: Connected to localhost (::1) port 80 (#2)
[Jun 10 22:37:59][chn0] CURL: Sent 41 bytes..
[Jun 10 22:37:59][chn0] CURL: Sent '[ [ 1528663078911, 20979103.400000002 ] ]' bytes
[Jun 10 22:37:59][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:37:59][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:37:59][chn0] CURL: Received 26 bytes
[Jun 10 22:37:59][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:37:59][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:37:59][chn0] CURL: Closing connection 2
[Jun 10 22:37:59][chn0] CURL Request succeeded with code: 200
[Jun 10 22:37:59][chn0] emptied all (1) values
[Jun 10 22:38:03][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:08][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: warning: could not read the whole file
[Jun 10 22:38:11][mtr1] Got 0 new readings from meter:
[Jun 10 22:38:11][chn3] ==> number of tuples: 0
[Jun 10 22:38:11][chn3] JSON request body is null. Nothing to send now.
[Jun 10 22:38:11][chn4] ==> number of tuples: 0
[Jun 10 22:38:11][chn4] JSON request body is null. Nothing to send now.
[Jun 10 22:38:13][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:18][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:23][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: warning: could not read the whole file
[Jun 10 22:38:27][mtr1] Got 0 new readings from meter:
[Jun 10 22:38:27][chn3] ==> number of tuples: 0
[Jun 10 22:38:27][chn3] JSON request body is null. Nothing to send now.
[Jun 10 22:38:27][chn4] ==> number of tuples: 0
[Jun 10 22:38:27][chn4] JSON request body is null. Nothing to send now.
[Jun 10 22:38:28][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:33][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: error: unrecognized sequence
[Jun 10 22:38:36][sml]  short message from sml_transport_read len=0
[Jun 10 22:38:36][mtr0] Got 0 new readings from meter:
[Jun 10 22:38:36][chn1] ==> number of tuples: 0
[Jun 10 22:38:36][chn0] ==> number of tuples: 0
[Jun 10 22:38:36][chn2] ==> number of tuples: 0
[Jun 10 22:38:36][chn0] JSON request body is null. Nothing to send now.
[Jun 10 22:38:36][chn1] JSON request body is null. Nothing to send now.
[Jun 10 22:38:36][chn2] JSON request body is null. Nothing to send now.
[Jun 10 22:38:38][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:43][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:48][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:53][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:38:58][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:39:03][push] waitAndSendOnceToAll empty dataMap (timeout?)
libsml: error: unrecognized sequence
[Jun 10 22:39:04][sml]  short message from sml_transport_read len=0
[Jun 10 22:39:04][mtr0] Got 0 new readings from meter:
[Jun 10 22:39:04][chn0] ==> number of tuples: 0
[Jun 10 22:39:04][chn2] ==> number of tuples: 0
[Jun 10 22:39:04][chn1] ==> number of tuples: 0
[Jun 10 22:39:04][chn1] JSON request body is null. Nothing to send now.
[Jun 10 22:39:04][chn0] JSON request body is null. Nothing to send now.
[Jun 10 22:39:04][chn2] JSON request body is null. Nothing to send now.
[Jun 10 22:39:08][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:39:13][push] waitAndSendOnceToAll empty dataMap (timeout?)
[Jun 10 22:39:16][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:16][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979115.00 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978115.00 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663156879
[Jun 10 22:39:16][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=535.00 ts=1528663156879
[Jun 10 22:39:16][chn0] Adding reading to queue (value=20979115.00 ts=1528663156879)
[Jun 10 22:39:16][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663156879, 20979115 ] ] } ] }
[Jun 10 22:39:16][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:16][push] send nok to url
[Jun 10 22:39:16][push] added to uuid xxx2855
[Jun 10 22:39:16][chn1] Adding reading to queue (value=31969628.70 ts=1528663156879)
[Jun 10 22:39:16][push] push: { "data": [ { "uuid": "xxxx7608", "tuples": [ [ 1528663156879, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:16][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:16][push] send nok to url
[Jun 10 22:39:16][push] added to uuid xxx7608
[Jun 10 22:39:16][chn2] Adding reading to queue (value=535.00 ts=1528663156879)
[Jun 10 22:39:16][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663156879, 535 ] ] } ] }
[Jun 10 22:39:16][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:16][push] send nok to url
[Jun 10 22:39:16][push] added to uuid xxxe1ece
[Jun 10 22:39:16][chn0] ==> number of tuples: 1
[Jun 10 22:39:16][chn1] ==> number of tuples: 1
[Jun 10 22:39:16][chn0] compare: 1528663078911 1528663156879
[Jun 10 22:39:16][chn1] compare: 1528663078911 1528663156879
[Jun 10 22:39:16][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:16][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:16][chn0] JSON request body: [ [ 1528663156879, 20979115 ] ]
[Jun 10 22:39:16][chn2] ==> number of tuples: 1
[Jun 10 22:39:16][chn2] compare: 1528663078911 1528663156879
[Jun 10 22:39:16][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:16][chn0] CURL: Hostname in DNS cache was stale, zapped
[Jun 10 22:39:16][chn0] CURL:   Trying ::1...
[Jun 10 22:39:16][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:16][chn0] CURL: Connected to localhost (::1) port 80 (#3)
[Jun 10 22:39:16][chn0] CURL: Sent 31 bytes..
[Jun 10 22:39:16][chn0] CURL: Sent '[ [ 1528663156879, 20979115 ] ]' bytes
[Jun 10 22:39:16][chn0] CURL: upload completely sent off: 31 out of 31 bytes
[Jun 10 22:39:17][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:17][chn0] CURL: Received 26 bytes
[Jun 10 22:39:17][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:17][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:17][chn0] CURL: Closing connection 3
[Jun 10 22:39:17][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:17][chn1] JSON request body: [ [ 1528663156879, 31969628.700000003 ] ]
[Jun 10 22:39:17][chn0] emptied all (1) values
[Jun 10 22:39:17][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:17][chn1] CURL:   Trying ::1...
[Jun 10 22:39:17][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:17][chn1] CURL: Connected to localhost (::1) port 80 (#4)
[Jun 10 22:39:17][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:17][chn1] CURL: Sent '[ [ 1528663156879, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:17][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:17][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:17][chn1] CURL: Received 26 bytes
[Jun 10 22:39:17][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:17][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:17][chn1] CURL: Closing connection 4
[Jun 10 22:39:17][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:17][chn1] emptied all (1) values
[Jun 10 22:39:17][chn2] JSON request body: [ [ 1528663156879, 535 ] ]
[Jun 10 22:39:17][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:17][chn2] CURL:   Trying ::1...
[Jun 10 22:39:17][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:17][chn2] CURL: Connected to localhost (::1) port 80 (#5)
[Jun 10 22:39:17][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:17][chn2] CURL: Sent '[ [ 1528663156879, 535 ] ]' bytes
[Jun 10 22:39:17][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:17][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:17][chn2] CURL: Received 26 bytes
[Jun 10 22:39:17][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:17][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:17][chn2] CURL: Closing connection 5
[Jun 10 22:39:17][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:17][chn2] emptied all (1) values
[Jun 10 22:39:18][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:18][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979115.30 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978115.30 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663158944
[Jun 10 22:39:18][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=535.00 ts=1528663158944
[Jun 10 22:39:18][chn0] Adding reading to queue (value=20979115.30 ts=1528663158944)
[Jun 10 22:39:18][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663158944, 20979115.300000001 ] ] } ] }
[Jun 10 22:39:18][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:18][push] send nok to url
[Jun 10 22:39:18][push] added to uuid xxx2855
[Jun 10 22:39:18][chn1] Adding reading to queue (value=31969628.70 ts=1528663158944)
[Jun 10 22:39:18][push] push: { "data": [ { "uuid": "xxxx7608", "tuples": [ [ 1528663158944, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:18][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:18][push] send nok to url
[Jun 10 22:39:18][push] added to uuid xxx7608
[Jun 10 22:39:18][chn2] Adding reading to queue (value=535.00 ts=1528663158944)
[Jun 10 22:39:18][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663158944, 535 ] ] } ] }
[Jun 10 22:39:18][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:18][push] send nok to url
[Jun 10 22:39:18][push] added to uuid xxxe1ece
[Jun 10 22:39:18][chn0] ==> number of tuples: 1
[Jun 10 22:39:18][chn1] ==> number of tuples: 1
[Jun 10 22:39:18][chn0] compare: 1528663156879 1528663158944
[Jun 10 22:39:18][chn1] compare: 1528663156879 1528663158944
[Jun 10 22:39:18][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:18][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:18][chn0] JSON request body: [ [ 1528663158944, 20979115.300000001 ] ]
[Jun 10 22:39:18][chn2] ==> number of tuples: 1
[Jun 10 22:39:18][chn2] compare: 1528663156879 1528663158944
[Jun 10 22:39:18][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:18][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:18][chn0] CURL:   Trying ::1...
[Jun 10 22:39:18][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:18][chn0] CURL: Connected to localhost (::1) port 80 (#6)
[Jun 10 22:39:18][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:18][chn0] CURL: Sent '[ [ 1528663158944, 20979115.300000001 ] ]' bytes
[Jun 10 22:39:18][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:18][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:18][chn0] CURL: Received 26 bytes
[Jun 10 22:39:18][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:18][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:18][chn0] CURL: Closing connection 6
[Jun 10 22:39:18][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:18][chn1] JSON request body: [ [ 1528663158944, 31969628.700000003 ] ]
[Jun 10 22:39:18][chn0] emptied all (1) values
[Jun 10 22:39:18][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:18][chn1] CURL:   Trying ::1...
[Jun 10 22:39:18][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:18][chn1] CURL: Connected to localhost (::1) port 80 (#7)
[Jun 10 22:39:18][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:18][chn1] CURL: Sent '[ [ 1528663158944, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:18][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:19][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:19][chn1] CURL: Received 26 bytes
[Jun 10 22:39:19][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:19][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:19][chn1] CURL: Closing connection 7
[Jun 10 22:39:19][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:19][chn1] emptied all (1) values
[Jun 10 22:39:19][chn2] JSON request body: [ [ 1528663158944, 535 ] ]
[Jun 10 22:39:19][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:19][chn2] CURL:   Trying ::1...
[Jun 10 22:39:19][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:19][chn2] CURL: Connected to localhost (::1) port 80 (#8)
[Jun 10 22:39:19][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:19][chn2] CURL: Sent '[ [ 1528663158944, 535 ] ]' bytes
[Jun 10 22:39:19][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:19][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:19][chn2] CURL: Received 26 bytes
[Jun 10 22:39:19][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:19][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:19][chn2] CURL: Closing connection 8
[Jun 10 22:39:19][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:19][chn2] emptied all (1) values
[Jun 10 22:39:20][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:20][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979115.60 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978115.60 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663160876
[Jun 10 22:39:20][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=533.00 ts=1528663160876
[Jun 10 22:39:20][chn0] Adding reading to queue (value=20979115.60 ts=1528663160876)
[Jun 10 22:39:20][push] added to uuid xxx2855
[Jun 10 22:39:20][chn1] Adding reading to queue (value=31969628.70 ts=1528663160876)
[Jun 10 22:39:20][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663160876, 20979115.600000001 ] ] } ] }
[Jun 10 22:39:20][push] added to uuid xxx7608
[Jun 10 22:39:20][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:20][chn2] Adding reading to queue (value=533.00 ts=1528663160876)
[Jun 10 22:39:20][push] send nok to url
[Jun 10 22:39:20][push] push: { "data": [ { "uuid": "xxxx7608", "tuples": [ [ 1528663160876, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:20][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:20][push] send nok to url
[Jun 10 22:39:20][push] added to uuid xxxe1ece
[Jun 10 22:39:20][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663160876, 533 ] ] } ] }
[Jun 10 22:39:20][chn0] ==> number of tuples: 1
[Jun 10 22:39:20][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:20][chn0] compare: 1528663158944 1528663160876
[Jun 10 22:39:20][push] send nok to url
[Jun 10 22:39:20][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:20][chn0] JSON request body: [ [ 1528663160876, 20979115.600000001 ] ]
[Jun 10 22:39:20][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:20][chn0] CURL:   Trying ::1...
[Jun 10 22:39:20][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:20][chn0] CURL: Connected to localhost (::1) port 80 (#9)
[Jun 10 22:39:20][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:20][chn0] CURL: Sent '[ [ 1528663160876, 20979115.600000001 ] ]' bytes
[Jun 10 22:39:20][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:20][chn1] ==> number of tuples: 1
[Jun 10 22:39:20][chn1] compare: 1528663158944 1528663160876
[Jun 10 22:39:20][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:20][chn2] ==> number of tuples: 1
[Jun 10 22:39:20][chn2] compare: 1528663158944 1528663160876
[Jun 10 22:39:20][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:21][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:21][chn0] CURL: Received 26 bytes
[Jun 10 22:39:21][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:21][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:21][chn0] CURL: Closing connection 9
[Jun 10 22:39:21][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:21][chn1] JSON request body: [ [ 1528663160876, 31969628.700000003 ] ]
[Jun 10 22:39:21][chn0] emptied all (1) values
[Jun 10 22:39:21][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:21][chn1] CURL:   Trying ::1...
[Jun 10 22:39:21][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:21][chn1] CURL: Connected to localhost (::1) port 80 (#10)
[Jun 10 22:39:21][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:21][chn1] CURL: Sent '[ [ 1528663160876, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:21][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:22][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:23][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979115.90 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978115.90 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663162875
[Jun 10 22:39:23][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=536.00 ts=1528663162875
[Jun 10 22:39:23][chn0] Adding reading to queue (value=20979115.90 ts=1528663162875)
[Jun 10 22:39:23][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663162875, 20979115.900000002 ] ] } ] }
[Jun 10 22:39:23][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:23][push] send nok to url
[Jun 10 22:39:23][push] added to uuid xxx2855
[Jun 10 22:39:23][chn1] Adding reading to queue (value=31969628.70 ts=1528663162875)
[Jun 10 22:39:23][push] push: { "data": [ { "uuid": "xxxx7608", "tuples": [ [ 1528663162875, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:23][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:23][push] send nok to url
[Jun 10 22:39:23][push] added to uuid xxx7608
[Jun 10 22:39:23][chn2] Adding reading to queue (value=536.00 ts=1528663162875)
[Jun 10 22:39:23][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663162875, 536 ] ] } ] }
[Jun 10 22:39:23][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:23][push] send nok to url
[Jun 10 22:39:23][push] added to uuid xxxe1ece
[Jun 10 22:39:23][chn0] ==> number of tuples: 1
[Jun 10 22:39:23][chn0] compare: 1528663160876 1528663162875
[Jun 10 22:39:23][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:23][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:23][chn1] CURL: Received 26 bytes
[Jun 10 22:39:23][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:23][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:23][chn1] CURL: Closing connection 10
[Jun 10 22:39:23][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:23][chn1] emptied all (1) values
[Jun 10 22:39:23][chn1] ==> number of tuples: 1
[Jun 10 22:39:23][chn1] compare: 1528663160876 1528663162875
[Jun 10 22:39:23][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:23][chn1] JSON request body: [ [ 1528663162875, 31969628.700000003 ] ]
[Jun 10 22:39:23][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:23][chn1] CURL:   Trying ::1...
[Jun 10 22:39:23][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:23][chn1] CURL: Connected to localhost (::1) port 80 (#11)
[Jun 10 22:39:23][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:23][chn1] CURL: Sent '[ [ 1528663162875, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:23][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:24][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:24][chn1] CURL: Received 26 bytes
[Jun 10 22:39:24][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:24][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:24][chn1] CURL: Closing connection 11
[Jun 10 22:39:24][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:24][chn1] emptied all (1) values
[Jun 10 22:39:24][chn2] JSON request body: [ [ 1528663160876, 533 ] ]
[Jun 10 22:39:24][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:24][chn2] CURL:   Trying ::1...
[Jun 10 22:39:24][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:24][chn2] CURL: Connected to localhost (::1) port 80 (#12)
[Jun 10 22:39:24][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:24][chn2] CURL: Sent '[ [ 1528663160876, 533 ] ]' bytes
[Jun 10 22:39:24][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:24][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:24][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979116.20 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978116.20 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663164911
[Jun 10 22:39:24][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=534.00 ts=1528663164911
[Jun 10 22:39:24][chn0] Adding reading to queue (value=20979116.20 ts=1528663164911)
[Jun 10 22:39:24][push] added to uuid xxx2855
[Jun 10 22:39:24][chn1] Adding reading to queue (value=31969628.70 ts=1528663164911)
[Jun 10 22:39:24][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663164911, 20979116.200000003 ] ] } ] }
[Jun 10 22:39:24][push] added to uuid xxx7608
[Jun 10 22:39:24][chn2] Adding reading to queue (value=534.00 ts=1528663164911)
[Jun 10 22:39:24][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:24][push] added to uuid xxxe1ece
[Jun 10 22:39:24][push] send nok to url
[Jun 10 22:39:24][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663164911, 534 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663164911, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:24][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:24][push] send nok to url
[Jun 10 22:39:24][chn1] ==> number of tuples: 1
[Jun 10 22:39:24][chn1] compare: 1528663162875 1528663164911
[Jun 10 22:39:24][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:26][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:26][chn2] CURL: Received 26 bytes
[Jun 10 22:39:26][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:26][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:26][chn2] CURL: Closing connection 12
[Jun 10 22:39:26][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:26][chn0] JSON request body: [ [ 1528663162875, 20979115.900000002 ] ]
[Jun 10 22:39:26][chn2] emptied all (1) values
[Jun 10 22:39:26][chn2] ==> number of tuples: 2
[Jun 10 22:39:26][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:26][chn2] compare: 1528663160876 1528663162875
[Jun 10 22:39:26][chn0] CURL:   Trying ::1...
[Jun 10 22:39:26][chn2] compare: 1528663162875 1528663164911
[Jun 10 22:39:26][chn2] copied 2/2 values for middleware transmission
[Jun 10 22:39:26][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:26][chn0] CURL: Connected to localhost (::1) port 80 (#13)
[Jun 10 22:39:26][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:26][chn0] CURL: Sent '[ [ 1528663162875, 20979115.900000002 ] ]' bytes
[Jun 10 22:39:26][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:26][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:26][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979116.50 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978116.50 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663166873
[Jun 10 22:39:26][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=534.00 ts=1528663166873
[Jun 10 22:39:26][chn0] Adding reading to queue (value=20979116.50 ts=1528663166873)
[Jun 10 22:39:26][push] added to uuid xxx2855
[Jun 10 22:39:26][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663166873, 20979116.5 ] ] } ] }
[Jun 10 22:39:26][chn1] Adding reading to queue (value=31969628.70 ts=1528663166873)
[Jun 10 22:39:26][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:26][push] send nok to url
[Jun 10 22:39:26][push] added to uuid xxx7608
[Jun 10 22:39:26][push] push: { "data": [ { "uuid": "xxxx7608", "tuples": [ [ 1528663166873, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:26][chn2] Adding reading to queue (value=534.00 ts=1528663166873)
[Jun 10 22:39:26][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:26][push] send nok to url
[Jun 10 22:39:26][push] added to uuid xxxe1ece
[Jun 10 22:39:26][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663166873, 534 ] ] } ] }
[Jun 10 22:39:26][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:26][push] send nok to url
[Jun 10 22:39:27][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn0] CURL: Received 26 bytes
[Jun 10 22:39:27][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:27][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn0] CURL: Closing connection 13
[Jun 10 22:39:27][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn1] JSON request body: [ [ 1528663164911, 31969628.700000003 ] ]
[Jun 10 22:39:27][chn0] emptied all (1) values
[Jun 10 22:39:27][chn0] ==> number of tuples: 2
[Jun 10 22:39:27][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:27][chn0] compare: 1528663162875 1528663164911
[Jun 10 22:39:27][chn1] CURL:   Trying ::1...
[Jun 10 22:39:27][chn0] compare: 1528663164911 1528663166873
[Jun 10 22:39:27][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:27][chn0] copied 2/2 values for middleware transmission
[Jun 10 22:39:27][chn1] CURL: Connected to localhost (::1) port 80 (#14)
[Jun 10 22:39:27][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:27][chn1] CURL: Sent '[ [ 1528663164911, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:27][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:27][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn1] CURL: Received 26 bytes
[Jun 10 22:39:27][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:27][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn1] CURL: Closing connection 14
[Jun 10 22:39:27][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn1] emptied all (1) values
[Jun 10 22:39:27][chn2] JSON request body: [ [ 1528663162875, 536 ], [ 1528663164911, 534 ] ]
[Jun 10 22:39:27][chn1] ==> number of tuples: 1
[Jun 10 22:39:27][chn1] compare: 1528663164911 1528663166873
[Jun 10 22:39:27][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:27][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:27][chn2] CURL:   Trying ::1...
[Jun 10 22:39:27][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:27][chn2] CURL: Connected to localhost (::1) port 80 (#15)
[Jun 10 22:39:27][chn2] CURL: Sent 50 bytes..
[Jun 10 22:39:27][chn2] CURL: Sent '[ [ 1528663162875, 536 ], [ 1528663164911, 534 ] ]' bytes
[Jun 10 22:39:27][chn2] CURL: upload completely sent off: 50 out of 50 bytes
[Jun 10 22:39:27][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn2] CURL: Received 26 bytes
[Jun 10 22:39:27][chn2] CURL: Received '{"version":"0.3","rows":2}' bytes
[Jun 10 22:39:27][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn2] CURL: Closing connection 15
[Jun 10 22:39:27][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn2] emptied all (2) values
[Jun 10 22:39:27][chn2] ==> number of tuples: 1
[Jun 10 22:39:27][chn2] compare: 1528663164911 1528663166873
[Jun 10 22:39:27][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:27][chn2] JSON request body: [ [ 1528663166873, 534 ] ]
[Jun 10 22:39:27][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:27][chn2] CURL:   Trying ::1...
[Jun 10 22:39:27][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:27][chn2] CURL: Connected to localhost (::1) port 80 (#16)
[Jun 10 22:39:27][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:27][chn2] CURL: Sent '[ [ 1528663166873, 534 ] ]' bytes
[Jun 10 22:39:27][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:27][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn2] CURL: Received 26 bytes
[Jun 10 22:39:27][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:27][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn2] CURL: Closing connection 16
[Jun 10 22:39:27][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn1] JSON request body: [ [ 1528663166873, 31969628.700000003 ] ]
[Jun 10 22:39:27][chn2] emptied all (1) values
[Jun 10 22:39:27][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:27][chn1] CURL:   Trying ::1...
[Jun 10 22:39:27][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:27][chn1] CURL: Connected to localhost (::1) port 80 (#17)
[Jun 10 22:39:27][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:27][chn1] CURL: Sent '[ [ 1528663166873, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:27][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:27][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn1] CURL: Received 26 bytes
[Jun 10 22:39:27][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:27][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn1] CURL: Closing connection 17
[Jun 10 22:39:27][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn0] JSON request body: [ [ 1528663164911, 20979116.200000003 ], [ 1528663166873, 20979116.5 ] ]
[Jun 10 22:39:27][chn1] emptied all (1) values
[Jun 10 22:39:27][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:27][chn0] CURL:   Trying ::1...
[Jun 10 22:39:27][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:27][chn0] CURL: Connected to localhost (::1) port 80 (#18)
[Jun 10 22:39:27][chn0] CURL: Sent 72 bytes..
[Jun 10 22:39:27][chn0] CURL: Sent '[ [ 1528663164911, 20979116.200000003 ], [ 1528663166873, 20979116.5 ] ]' bytes
[Jun 10 22:39:27][chn0] CURL: upload completely sent off: 72 out of 72 bytes
[Jun 10 22:39:27][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:27][chn0] CURL: Received 26 bytes
[Jun 10 22:39:27][chn0] CURL: Received '{"version":"0.3","rows":2}' bytes
[Jun 10 22:39:27][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:27][chn0] CURL: Closing connection 18
[Jun 10 22:39:27][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:27][chn0] emptied all (2) values
[Jun 10 22:39:28][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:28][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979116.80 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978116.80 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663168873
[Jun 10 22:39:28][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=540.00 ts=1528663168873
[Jun 10 22:39:28][chn0] Adding reading to queue (value=20979116.80 ts=1528663168873)
[Jun 10 22:39:28][push] added to uuid xxx2855
[Jun 10 22:39:28][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663168873, 20979116.800000001 ] ] } ] }
[Jun 10 22:39:28][chn1] Adding reading to queue (value=31969628.70 ts=1528663168873)
[Jun 10 22:39:28][push] added to uuid xxx7608
[Jun 10 22:39:28][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:28][chn2] Adding reading to queue (value=540.00 ts=1528663168873)
[Jun 10 22:39:28][push] added to uuid xxxe1ece
[Jun 10 22:39:28][push] send nok to url
[Jun 10 22:39:28][chn0] ==> number of tuples: 1
[Jun 10 22:39:28][chn2] ==> number of tuples: 1
[Jun 10 22:39:28][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663168873, 540 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663168873, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:28][chn2] compare: 1528663166873 1528663168873
[Jun 10 22:39:28][chn0] compare: 1528663166873 1528663168873
[Jun 10 22:39:28][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:28][push] CURL:  URL using bad/illegal format or missing URL[Jun 10 22:39:28][chn0] copied 1/1 values for middleware transmission

[Jun 10 22:39:28][chn2] JSON request body: [ [ 1528663168873, 540 ] ]
[Jun 10 22:39:28][push] send nok to url
[Jun 10 22:39:28][chn1] ==> number of tuples: 1
[Jun 10 22:39:28][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:28][chn2] CURL:   Trying ::1...
[Jun 10 22:39:28][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:28][chn1] compare: 1528663166873 1528663168873
[Jun 10 22:39:28][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:28][chn2] CURL: Connected to localhost (::1) port 80 (#19)
[Jun 10 22:39:28][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:28][chn2] CURL: Sent '[ [ 1528663168873, 540 ] ]' bytes
[Jun 10 22:39:28][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:28][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:28][chn2] CURL: Received 26 bytes
[Jun 10 22:39:28][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:28][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:28][chn2] CURL: Closing connection 19
[Jun 10 22:39:28][chn0] JSON request body: [ [ 1528663168873, 20979116.800000001 ] ]
[Jun 10 22:39:28][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:28][chn0] CURL:   Trying ::1...
[Jun 10 22:39:28][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:28][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:28][chn2] emptied all (1) values
[Jun 10 22:39:28][chn0] CURL: Connected to localhost (::1) port 80 (#20)
[Jun 10 22:39:28][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:28][chn0] CURL: Sent '[ [ 1528663168873, 20979116.800000001 ] ]' bytes
[Jun 10 22:39:28][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:28][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:28][chn0] CURL: Received 26 bytes
[Jun 10 22:39:28][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:28][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:28][chn0] CURL: Closing connection 20
[Jun 10 22:39:28][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:28][chn1] JSON request body: [ [ 1528663168873, 31969628.700000003 ] ]
[Jun 10 22:39:28][chn0] emptied all (1) values
[Jun 10 22:39:28][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:28][chn1] CURL:   Trying ::1...
[Jun 10 22:39:28][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:28][chn1] CURL: Connected to localhost (::1) port 80 (#21)
[Jun 10 22:39:28][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:28][chn1] CURL: Sent '[ [ 1528663168873, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:28][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:29][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:29][chn1] CURL: Received 26 bytes
[Jun 10 22:39:29][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:29][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:29][chn1] CURL: Closing connection 21
[Jun 10 22:39:29][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:29][chn1] emptied all (1) values
[Jun 10 22:39:30][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:30][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979117.10 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978117.10 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663170959
[Jun 10 22:39:30][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=538.00 ts=1528663170959
[Jun 10 22:39:30][chn0] Adding reading to queue (value=20979117.10 ts=1528663170959)
[Jun 10 22:39:30][push] added to uuid xxx2855
[Jun 10 22:39:30][chn1] Adding reading to queue (value=31969628.70 ts=1528663170959)
[Jun 10 22:39:30][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663170959, 20979117.100000001 ] ] } ] }
[Jun 10 22:39:30][push] added to uuid xxx7608
[Jun 10 22:39:30][chn2] Adding reading to queue (value=538.00 ts=1528663170959)
[Jun 10 22:39:30][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:30][push] send nok to url
[Jun 10 22:39:30][push] added to uuid xxxe1ece
[Jun 10 22:39:30][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663170959, 538 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663170959, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:30][chn0] ==> number of tuples: 1
[Jun 10 22:39:30][chn0] compare: 1528663168873 1528663170959
[Jun 10 22:39:30][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:30][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:30][push] send nok to url
[Jun 10 22:39:30][chn0] JSON request body: [ [ 1528663170959, 20979117.100000001 ] ]
[Jun 10 22:39:30][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:30][chn0] CURL:   Trying ::1...
[Jun 10 22:39:30][chn1] ==> number of tuples: 1
[Jun 10 22:39:30][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:30][chn1] compare: 1528663168873 1528663170959
[Jun 10 22:39:30][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:30][chn2] ==> number of tuples: 1
[Jun 10 22:39:30][chn0] CURL: Connected to localhost (::1) port 80 (#22)
[Jun 10 22:39:30][chn2] compare: 1528663168873 1528663170959
[Jun 10 22:39:30][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:30][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:30][chn0] CURL: Sent '[ [ 1528663170959, 20979117.100000001 ] ]' bytes
[Jun 10 22:39:30][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:32][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:32][chn0] CURL: Received 26 bytes
[Jun 10 22:39:32][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:32][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:32][chn0] CURL: Closing connection 22
[Jun 10 22:39:32][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:32][chn1] JSON request body: [ [ 1528663170959, 31969628.700000003 ] ]
[Jun 10 22:39:32][chn0] emptied all (1) values
[Jun 10 22:39:32][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:32][chn1] CURL:   Trying ::1...
[Jun 10 22:39:32][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:32][chn1] CURL: Connected to localhost (::1) port 80 (#23)
[Jun 10 22:39:32][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:32][chn1] CURL: Sent '[ [ 1528663170959, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:32][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:32][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:32][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979117.40 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978117.40 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663172873
[Jun 10 22:39:32][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=538.00 ts=1528663172873
[Jun 10 22:39:32][chn0] Adding reading to queue (value=20979117.40 ts=1528663172873)
[Jun 10 22:39:32][push] added to uuid xxx2855
[Jun 10 22:39:32][chn1] Adding reading to queue (value=31969628.70 ts=1528663172873)
[Jun 10 22:39:32][push] added to uuid xxx7608
[Jun 10 22:39:32][chn2] Adding reading to queue (value=538.00 ts=1528663172873)
[Jun 10 22:39:32][push] added to uuid xxxe1ece
[Jun 10 22:39:32][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663172873, 20979117.400000002 ] ] } ] }
[Jun 10 22:39:32][chn0] ==> number of tuples: 1
[Jun 10 22:39:32][chn0] compare: 1528663170959 1528663172873
[Jun 10 22:39:32][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:32][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:32][push] send nok to url
[Jun 10 22:39:32][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663172873, 538 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663172873, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:32][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:32][push] send nok to url
[Jun 10 22:39:33][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:33][chn1] CURL: Received 26 bytes
[Jun 10 22:39:33][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:33][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:33][chn1] CURL: Closing connection 23
[Jun 10 22:39:33][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:33][chn0] JSON request body: [ [ 1528663172873, 20979117.400000002 ] ]
[Jun 10 22:39:33][chn1] emptied all (1) values
[Jun 10 22:39:33][chn1] ==> number of tuples: 1
[Jun 10 22:39:33][chn1] compare: 1528663170959 1528663172873
[Jun 10 22:39:33][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:33][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:33][chn0] CURL:   Trying ::1...
[Jun 10 22:39:33][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:33][chn0] CURL: Connected to localhost (::1) port 80 (#24)
[Jun 10 22:39:33][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:33][chn0] CURL: Sent '[ [ 1528663172873, 20979117.400000002 ] ]' bytes
[Jun 10 22:39:33][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:34][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:34][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979117.70 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978117.70 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663174873
[Jun 10 22:39:34][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=534.00 ts=1528663174873
[Jun 10 22:39:34][chn0] Adding reading to queue (value=20979117.70 ts=1528663174873)
[Jun 10 22:39:34][push] added to uuid xxx2855
[Jun 10 22:39:34][chn1] Adding reading to queue (value=31969628.70 ts=1528663174873)
[Jun 10 22:39:34][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663174873, 20979117.700000003 ] ] } ] }
[Jun 10 22:39:34][push] added to uuid xxx7608
[Jun 10 22:39:34][chn2] Adding reading to queue (value=534.00 ts=1528663174873)
[Jun 10 22:39:34][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:34][push] added to uuid xxxe1ece
[Jun 10 22:39:34][push] send nok to url
[Jun 10 22:39:34][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663174873, 534 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663174873, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:34][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:34][push] send nok to url
[Jun 10 22:39:35][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn0] CURL: Received 26 bytes
[Jun 10 22:39:35][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:35][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn0] CURL: Closing connection 24
[Jun 10 22:39:35][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn1] JSON request body: [ [ 1528663172873, 31969628.700000003 ] ]
[Jun 10 22:39:35][chn0] emptied all (1) values
[Jun 10 22:39:35][chn0] ==> number of tuples: 1
[Jun 10 22:39:35][chn0] compare: 1528663172873 1528663174873
[Jun 10 22:39:35][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:35][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:35][chn1] CURL:   Trying ::1...
[Jun 10 22:39:35][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:35][chn1] CURL: Connected to localhost (::1) port 80 (#25)
[Jun 10 22:39:35][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:35][chn1] CURL: Sent '[ [ 1528663172873, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:35][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:35][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn1] CURL: Received 26 bytes
[Jun 10 22:39:35][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:35][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn1] CURL: Closing connection 25
[Jun 10 22:39:35][chn2] JSON request body: [ [ 1528663170959, 538 ] ]
[Jun 10 22:39:35][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:35][chn2] CURL:   Trying ::1...
[Jun 10 22:39:35][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:35][chn2] CURL: Connected to localhost (::1) port 80 (#26)
[Jun 10 22:39:35][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:35][chn2] CURL: Sent '[ [ 1528663170959, 538 ] ]' bytes
[Jun 10 22:39:35][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:35][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn1] emptied all (1) values
[Jun 10 22:39:35][chn1] ==> number of tuples: 1
[Jun 10 22:39:35][chn1] compare: 1528663172873 1528663174873
[Jun 10 22:39:35][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:35][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn2] CURL: Received 26 bytes
[Jun 10 22:39:35][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:35][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn2] CURL: Closing connection 26
[Jun 10 22:39:35][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn0] JSON request body: [ [ 1528663174873, 20979117.700000003 ] ]
[Jun 10 22:39:35][chn2] emptied all (1) values
[Jun 10 22:39:35][chn2] ==> number of tuples: 2
[Jun 10 22:39:35][chn2] compare: 1528663170959 1528663172873
[Jun 10 22:39:35][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:35][chn2] compare: 1528663172873 1528663174873
[Jun 10 22:39:35][chn2] copied 2/2 values for middleware transmission
[Jun 10 22:39:35][chn0] CURL:   Trying ::1...
[Jun 10 22:39:35][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:35][chn0] CURL: Connected to localhost (::1) port 80 (#27)
[Jun 10 22:39:35][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:35][chn0] CURL: Sent '[ [ 1528663174873, 20979117.700000003 ] ]' bytes
[Jun 10 22:39:35][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:35][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn0] CURL: Received 26 bytes
[Jun 10 22:39:35][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:35][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn0] CURL: Closing connection 27
[Jun 10 22:39:35][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn1] JSON request body: [ [ 1528663174873, 31969628.700000003 ] ]
[Jun 10 22:39:35][chn0] emptied all (1) values
[Jun 10 22:39:35][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:35][chn1] CURL:   Trying ::1...
[Jun 10 22:39:35][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:35][chn1] CURL: Connected to localhost (::1) port 80 (#28)
[Jun 10 22:39:35][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:35][chn1] CURL: Sent '[ [ 1528663174873, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:35][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:35][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn1] CURL: Received 26 bytes
[Jun 10 22:39:35][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:35][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn1] CURL: Closing connection 28
[Jun 10 22:39:35][chn2] JSON request body: [ [ 1528663172873, 538 ], [ 1528663174873, 534 ] ]
[Jun 10 22:39:35][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:35][chn2] CURL:   Trying ::1...
[Jun 10 22:39:35][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:35][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn2] CURL: Connected to localhost (::1) port 80 (#29)
[Jun 10 22:39:35][chn1] emptied all (1) values
[Jun 10 22:39:35][chn2] CURL: Sent 50 bytes..
[Jun 10 22:39:35][chn2] CURL: Sent '[ [ 1528663172873, 538 ], [ 1528663174873, 534 ] ]' bytes
[Jun 10 22:39:35][chn2] CURL: upload completely sent off: 50 out of 50 bytes
[Jun 10 22:39:35][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:35][chn2] CURL: Received 26 bytes
[Jun 10 22:39:35][chn2] CURL: Received '{"version":"0.3","rows":2}' bytes
[Jun 10 22:39:35][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:35][chn2] CURL: Closing connection 29
[Jun 10 22:39:35][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:35][chn2] emptied all (2) values
[Jun 10 22:39:36][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:36][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979118.00 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978118.00 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663176901
[Jun 10 22:39:36][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=535.00 ts=1528663176901
[Jun 10 22:39:36][chn0] Adding reading to queue (value=20979118.00 ts=1528663176901)
[Jun 10 22:39:36][push] added to uuid xxx2855
[Jun 10 22:39:36][chn1] Adding reading to queue (value=31969628.70 ts=1528663176901)
[Jun 10 22:39:36][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663176901, 20979118 ] ] } ] }
[Jun 10 22:39:36][push] added to uuid xxx7608
[Jun 10 22:39:36][chn2] Adding reading to queue (value=535.00 ts=1528663176901)
[Jun 10 22:39:36][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:36][push] added to uuid xxxe1ece
[Jun 10 22:39:36][push] send nok to url
[Jun 10 22:39:36][chn0] ==> number of tuples: 1
[Jun 10 22:39:36][chn0] compare: 1528663174873 1528663176901
[Jun 10 22:39:36][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663176901, 535 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663176901, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:36][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:36][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:36][chn0] JSON request body: [ [ 1528663176901, 20979118 ] ]
[Jun 10 22:39:36][push] send nok to url
[Jun 10 22:39:36][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:36][chn0] CURL:   Trying ::1...
[Jun 10 22:39:36][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:36][chn0] CURL: Connected to localhost (::1) port 80 (#30)
[Jun 10 22:39:36][chn0] CURL: Sent 31 bytes..
[Jun 10 22:39:36][chn0] CURL: Sent '[ [ 1528663176901, 20979118 ] ]' bytes
[Jun 10 22:39:36][chn1] ==> number of tuples: 1
[Jun 10 22:39:36][chn0] CURL: upload completely sent off: 31 out of 31 bytes
[Jun 10 22:39:36][chn1] compare: 1528663174873 1528663176901
[Jun 10 22:39:36][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:36][chn2] ==> number of tuples: 1
[Jun 10 22:39:36][chn2] compare: 1528663174873 1528663176901
[Jun 10 22:39:36][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:36][chn0] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:36][chn0] CURL: Received 26 bytes
[Jun 10 22:39:36][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:36][chn0] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:36][chn0] CURL: Closing connection 30
[Jun 10 22:39:36][chn0] CURL Request succeeded with code: 200
[Jun 10 22:39:36][chn1] JSON request body: [ [ 1528663176901, 31969628.700000003 ] ]
[Jun 10 22:39:36][chn0] emptied all (1) values
[Jun 10 22:39:36][chn1] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:36][chn1] CURL:   Trying ::1...
[Jun 10 22:39:36][chn1] CURL: TCP_NODELAY set
[Jun 10 22:39:36][chn1] CURL: Connected to localhost (::1) port 80 (#31)
[Jun 10 22:39:36][chn1] CURL: Sent 41 bytes..
[Jun 10 22:39:36][chn1] CURL: Sent '[ [ 1528663176901, 31969628.700000003 ] ]' bytes
[Jun 10 22:39:36][chn1] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:36][chn1] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:36][chn1] CURL: Received 26 bytes
[Jun 10 22:39:36][chn1] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:36][chn1] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:36][chn1] CURL: Closing connection 31
[Jun 10 22:39:36][chn1] CURL Request succeeded with code: 200
[Jun 10 22:39:36][chn2] JSON request body: [ [ 1528663176901, 535 ] ]
[Jun 10 22:39:36][chn1] emptied all (1) values
[Jun 10 22:39:36][chn2] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:36][chn2] CURL:   Trying ::1...
[Jun 10 22:39:36][chn2] CURL: TCP_NODELAY set
[Jun 10 22:39:36][chn2] CURL: Connected to localhost (::1) port 80 (#32)
[Jun 10 22:39:36][chn2] CURL: Sent 26 bytes..
[Jun 10 22:39:36][chn2] CURL: Sent '[ [ 1528663176901, 535 ] ]' bytes
[Jun 10 22:39:36][chn2] CURL: upload completely sent off: 26 out of 26 bytes
[Jun 10 22:39:37][chn2] CURL: HTTP 1.0, assume close after body
[Jun 10 22:39:37][chn2] CURL: Received 26 bytes
[Jun 10 22:39:37][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 10 22:39:37][chn2] CURL: Curl_http_done: called premature == 0
[Jun 10 22:39:37][chn2] CURL: Closing connection 32
[Jun 10 22:39:37][chn2] CURL Request succeeded with code: 200
[Jun 10 22:39:37][chn2] emptied all (1) values
[Jun 10 22:39:38][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:38][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979118.30 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978118.30 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663178871
[Jun 10 22:39:38][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=534.00 ts=1528663178871
[Jun 10 22:39:38][chn0] Adding reading to queue (value=20979118.30 ts=1528663178871)
[Jun 10 22:39:38][push] added to uuid xxx2855
[Jun 10 22:39:38][chn1] Adding reading to queue (value=31969628.70 ts=1528663178871)
[Jun 10 22:39:38][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663178871, 20979118.300000001 ] ] } ] }
[Jun 10 22:39:38][push] added to uuid xxx7608
[Jun 10 22:39:38][chn2] Adding reading to queue (value=534.00 ts=1528663178871)
[Jun 10 22:39:38][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:38][push] added to uuid xxxe1ece
[Jun 10 22:39:38][push] send nok to url
[Jun 10 22:39:38][chn0] ==> number of tuples: 1
[Jun 10 22:39:38][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663178871, 534 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663178871, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:38][chn0] compare: 1528663176901 1528663178871
[Jun 10 22:39:38][chn0] copied 1/1 values for middleware transmission
[Jun 10 22:39:38][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:38][chn0] JSON request body: [ [ 1528663178871, 20979118.300000001 ] ]
[Jun 10 22:39:38][push] send nok to url
[Jun 10 22:39:38][chn0] CURL: Hostname localhost was found in DNS cache
[Jun 10 22:39:38][chn0] CURL:   Trying ::1...
[Jun 10 22:39:38][chn0] CURL: TCP_NODELAY set
[Jun 10 22:39:38][chn0] CURL: Connected to localhost (::1) port 80 (#33)
[Jun 10 22:39:38][chn0] CURL: Sent 41 bytes..
[Jun 10 22:39:38][chn0] CURL: Sent '[ [ 1528663178871, 20979118.300000001 ] ]' bytes
[Jun 10 22:39:38][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 10 22:39:38][chn2] ==> number of tuples: 1
[Jun 10 22:39:38][chn1] ==> number of tuples: 1
[Jun 10 22:39:38][chn2] compare: 1528663176901 1528663178871
[Jun 10 22:39:38][chn1] compare: 1528663176901 1528663178871
[Jun 10 22:39:38][chn2] copied 1/1 values for middleware transmission
[Jun 10 22:39:38][chn1] copied 1/1 values for middleware transmission
[Jun 10 22:39:40][mtr0] Got 7 new readings from meter:
[Jun 10 22:39:40][mtr0] Reading: id=1-0:1.8.0*255/ObisIdentifier:1-0:1.8.0*255 value=20979118.60 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:1.8.1*255/ObisIdentifier:1-0:1.8.1*255 value=20978118.60 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:1.8.2*255/ObisIdentifier:1-0:1.8.2*255 value=1000.00 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:2.8.0*255/ObisIdentifier:1-0:2.8.0*255 value=31969628.70 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:2.8.1*255/ObisIdentifier:1-0:2.8.1*255 value=31968628.70 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:2.8.2*255/ObisIdentifier:1-0:2.8.2*255 value=1000.00 ts=1528663180870
[Jun 10 22:39:40][mtr0] Reading: id=1-0:16.7.0*255/ObisIdentifier:1-0:16.7.0*255 value=534.00 ts=1528663180870
[Jun 10 22:39:40][chn0] Adding reading to queue (value=20979118.60 ts=1528663180870)
[Jun 10 22:39:40][push] added to uuid xxx2855
[Jun 10 22:39:40][chn1] Adding reading to queue (value=31969628.70 ts=1528663180870)
[Jun 10 22:39:40][push] push: { "data": [ { "uuid": "xxxx2855", "tuples": [ [ 1528663180870, 20979118.600000001 ] ] } ] }
[Jun 10 22:39:40][push] added to uuid xxx7608
[Jun 10 22:39:40][chn2] Adding reading to queue (value=534.00 ts=1528663180870)
[Jun 10 22:39:40][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:40][push] added to uuid xxxe1ece
[Jun 10 22:39:40][push] send nok to url
[Jun 10 22:39:40][push] push: { "data": [ { "uuid": "xxxxade1ece", "tuples": [ [ 1528663180870, 534 ] ] }, { "uuid": "xxxx7608", "tuples": [ [ 1528663180870, 31969628.700000003 ] ] } ] }
[Jun 10 22:39:40][push] CURL:  URL using bad/illegal format or missing URL
[Jun 10 22:39:40][push] send nok to url
[Jun 10 22:39:41][sml]  short message from sml_transport_read len=0
[Jun 10 22:39:41][mtr1] Got 0 new readings from meter:
[Jun 10 22:39:41][chn3] ==> number of tuples: 0
[Jun 10 22:39:42][chn3] JSON request body is null. Nothing to send now.
[Jun 10 22:39:42][chn4] ==> number of tuples: 0
[Jun 10 22:39:42][chn4] JSON request body is null. Nothing to send now.


More information about the volkszaehler-users mailing list